builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1453394491.64 results: success (0) buildid: 20160121053025 builduid: 1f9d19e7cef04dd8add20bcd28bf3344 revision: a7b909eabadf197c6b1988a793c329b6213db042 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.635841) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.636433) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.636822) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004276 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.654848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.655153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.670126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.670459) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.722949) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.723682) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.724225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:31.724554) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 08:41:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-01-21 08:41:32 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.374997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:32.112481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:32.112906) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:32.163851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 08:41:32.164248) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7b909eabadf197c6b1988a793c329b6213db042 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a7b909eabadf197c6b1988a793c329b6213db042 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 08:41:32,365 truncating revision to first 12 chars 2016-01-21 08:41:32,365 Setting DEBUG logging. 2016-01-21 08:41:32,365 attempt 1/10 2016-01-21 08:41:32,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7b909eabadf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 08:41:33,478 unpacking tar archive at: fx-team-a7b909eabadf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.384220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 08:41:33.562337) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:33.562759) ========= echo a7b909eabadf197c6b1988a793c329b6213db042 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a7b909eabadf197c6b1988a793c329b6213db042'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a7b909eabadf197c6b1988a793c329b6213db042 program finished with exit code 0 elapsedTime=0.004665 script_repo_revision: 'a7b909eabadf197c6b1988a793c329b6213db042' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:33.615360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:33.615746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:33.626628) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:33.626972) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/a7b909eabadf197c6b1988a793c329b6213db042 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 08:41:33.627418) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-21 08:41:33.627760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:33 INFO - MultiFileLogger online at 20160121 08:41:33 in /builds/slave/test-pgo 08:41:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:41:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:41:33 INFO - {'append_to_log': False, 08:41:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:41:33 INFO - 'blob_upload_branch': 'Fx-Team', 08:41:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:41:33 INFO - 'branch': 'Fx-Team', 08:41:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:33 INFO - 'config_files': ('talos/linux_config.py',), 08:41:33 INFO - 'default_actions': ('clobber', 08:41:33 INFO - 'read-buildbot-config', 08:41:33 INFO - 'download-and-extract', 08:41:33 INFO - 'populate-webroot', 08:41:33 INFO - 'create-virtualenv', 08:41:33 INFO - 'install', 08:41:33 INFO - 'run-tests'), 08:41:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:33 INFO - 'download_minidump_stackwalk': True, 08:41:33 INFO - 'download_symbols': 'ondemand', 08:41:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:33 INFO - 'installer_path': 'installer.exe', 08:41:33 INFO - 'log_level': 'info', 08:41:33 INFO - 'log_name': 'talos', 08:41:33 INFO - 'log_to_console': True, 08:41:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:33 INFO - 'opt_config_files': (), 08:41:33 INFO - 'pip_index': False, 08:41:33 INFO - 'sps_profile': False, 08:41:33 INFO - 'sps_profile_interval': 0, 08:41:33 INFO - 'suite': 'dromaeojs', 08:41:33 INFO - 'system_bits': '32', 08:41:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:33 INFO - 'title': 'talos-linux64-ix-016', 08:41:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:33 INFO - 'use_talos_json': True, 08:41:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:41:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:33 INFO - 'work_dir': 'build'} 08:41:33 INFO - ##### 08:41:33 INFO - ##### Running clobber step. 08:41:33 INFO - ##### 08:41:33 INFO - Running pre-action listener: _resource_record_pre_action 08:41:33 INFO - Running main action method: clobber 08:41:33 INFO - rmtree: /builds/slave/test-pgo/build 08:41:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:41:34 INFO - Running post-action listener: _resource_record_post_action 08:41:34 INFO - ##### 08:41:34 INFO - ##### Running read-buildbot-config step. 08:41:34 INFO - ##### 08:41:34 INFO - Running pre-action listener: _resource_record_pre_action 08:41:34 INFO - Running main action method: read_buildbot_config 08:41:34 INFO - Using buildbot properties: 08:41:34 INFO - { 08:41:34 INFO - "project": "", 08:41:34 INFO - "product": "firefox", 08:41:34 INFO - "script_repo_revision": "production", 08:41:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:41:34 INFO - "repository": "", 08:41:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:41:34 INFO - "buildid": "20160121053025", 08:41:34 INFO - "pgo_build": "True", 08:41:34 INFO - "basedir": "/builds/slave/test-pgo", 08:41:34 INFO - "buildnumber": 594, 08:41:34 INFO - "slavename": "talos-linux64-ix-016", 08:41:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:41:34 INFO - "platform": "ubuntu64_hw", 08:41:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:41:34 INFO - "branch": "fx-team", 08:41:34 INFO - "repo_path": "integration/fx-team", 08:41:34 INFO - "revision": "a7b909eabadf197c6b1988a793c329b6213db042", 08:41:34 INFO - "stage_platform": "linux64-pgo", 08:41:34 INFO - "builduid": "1f9d19e7cef04dd8add20bcd28bf3344", 08:41:34 INFO - "slavebuilddir": "test" 08:41:34 INFO - } 08:41:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:41:34 INFO - Running post-action listener: _resource_record_post_action 08:41:34 INFO - ##### 08:41:34 INFO - ##### Running download-and-extract step. 08:41:34 INFO - ##### 08:41:34 INFO - Running pre-action listener: _resource_record_pre_action 08:41:34 INFO - Running main action method: download_and_extract 08:41:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:34 INFO - https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/test_packages.json 08:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/test_packages.json 08:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:41:35 INFO - Downloaded 1448 bytes. 08:41:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:41:35 INFO - Using the following test package requirements: 08:41:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:41:35 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:41:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'jsshell-linux-x86_64.zip'], 08:41:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:41:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:41:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:41:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:41:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:41:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:35 INFO - https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:41:36 INFO - Downloaded 22486683 bytes. 08:41:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:41:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:41:37 INFO - Return code: 0 08:41:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:37 INFO - https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:41:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:41:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:41:38 INFO - Downloaded 22486683 bytes. 08:41:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:41:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:41:39 INFO - Return code: 0 08:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:39 INFO - https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:41:40 INFO - Downloaded 10706572 bytes. 08:41:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:41:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:41:41 INFO - Return code: 0 08:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:41 INFO - https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:41:42 INFO - Downloaded 55966276 bytes. 08:41:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:41:42 INFO - mkdir: /builds/slave/test-pgo/properties 08:41:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:41:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:41:42 INFO - Contents: 08:41:42 INFO - build_url:https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:41:42 INFO - Running post-action listener: _resource_record_post_action 08:41:42 INFO - Running post-action listener: set_extra_try_arguments 08:41:42 INFO - ##### 08:41:42 INFO - ##### Running populate-webroot step. 08:41:42 INFO - ##### 08:41:42 INFO - Running pre-action listener: _resource_record_pre_action 08:41:42 INFO - Running main action method: populate_webroot 08:41:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:42 INFO - '--tppagecycles', 08:41:42 INFO - '7'], 08:41:42 INFO - 'tests': ['tsvgm']}}, 08:41:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:41:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:41:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:41:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'tests': ['damp', 'tps']}, 08:41:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['damp', 'tps']}, 08:41:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:41:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:42 INFO - 'other': {'tests': ['a11yr', 08:41:42 INFO - 'ts_paint', 08:41:42 INFO - 'tpaint', 08:41:42 INFO - 'sessionrestore', 08:41:42 INFO - 'sessionrestore_no_auto_restore']}, 08:41:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['a11yr', 08:41:42 INFO - 'ts_paint', 08:41:42 INFO - 'tpaint', 08:41:42 INFO - 'sessionrestore', 08:41:42 INFO - 'sessionrestore_no_auto_restore']}, 08:41:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['a11yr', 08:41:42 INFO - 'ts_paint', 08:41:42 INFO - 'tpaint', 08:41:42 INFO - 'sessionrestore', 08:41:42 INFO - 'sessionrestore_no_auto_restore']}, 08:41:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['a11yr', 08:41:42 INFO - 'ts_paint', 08:41:42 INFO - 'tpaint', 08:41:42 INFO - 'sessionrestore', 08:41:42 INFO - 'sessionrestore_no_auto_restore']}, 08:41:42 INFO - 'other_l64': {'tests': ['a11yr', 08:41:42 INFO - 'ts_paint', 08:41:42 INFO - 'tpaint', 08:41:42 INFO - 'sessionrestore', 08:41:42 INFO - 'sessionrestore_no_auto_restore']}, 08:41:42 INFO - 'other_nol64': {'tests': ['a11yr', 08:41:42 INFO - 'ts_paint', 08:41:42 INFO - 'tpaint', 08:41:42 INFO - 'sessionrestore', 08:41:42 INFO - 'sessionrestore_no_auto_restore']}, 08:41:42 INFO - 'svgr': {'tests': ['tsvgx', 08:41:42 INFO - 'tsvgr_opacity', 08:41:42 INFO - 'tart', 08:41:42 INFO - 'tscrollx', 08:41:42 INFO - 'cart']}, 08:41:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['tsvgx', 08:41:42 INFO - 'tsvgr_opacity', 08:41:42 INFO - 'tart', 08:41:42 INFO - 'tscrollx', 08:41:42 INFO - 'cart']}, 08:41:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'tests': ['tp5o']}, 08:41:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'talos_options': ['--e10s'], 08:41:42 INFO - 'tests': ['tp5o']}, 08:41:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'talos_options': ['--xperf_path', 08:41:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:42 INFO - 'tests': ['tp5n']}, 08:41:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:42 INFO - 'talos_options': ['--e10s', 08:41:42 INFO - '--xperf_path', 08:41:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:42 INFO - 'tests': ['tp5n']}}, 08:41:42 INFO - 'talos.zip': {'path': '', 08:41:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:42 INFO - Running post-action listener: _resource_record_post_action 08:41:42 INFO - ##### 08:41:42 INFO - ##### Running create-virtualenv step. 08:41:42 INFO - ##### 08:41:42 INFO - Running pre-action listener: _resource_record_pre_action 08:41:42 INFO - Running main action method: create_virtualenv 08:41:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:41:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:41:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:41:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:42 INFO - Using real prefix '/usr' 08:41:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:41:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:45 INFO - Installing pip.................done. 08:41:45 INFO - Return code: 0 08:41:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:41:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:41:45 INFO - Using env: {'DISPLAY': ':0', 08:41:45 INFO - 'HOME': '/home/cltbld', 08:41:45 INFO - 'LANG': 'en_US.UTF-8', 08:41:45 INFO - 'LANGUAGE': 'en_US:en', 08:41:45 INFO - 'LOGNAME': 'cltbld', 08:41:45 INFO - 'MAIL': '/var/mail/cltbld', 08:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:45 INFO - 'MOZ_NO_REMOTE': '1', 08:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:45 INFO - 'NO_EM_RESTART': '1', 08:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:41:45 INFO - 'PWD': '/builds/slave/test-pgo', 08:41:45 INFO - 'SHELL': '/bin/bash', 08:41:45 INFO - 'SHLVL': '1', 08:41:45 INFO - 'TERM': 'linux', 08:41:45 INFO - 'TMOUT': '86400', 08:41:45 INFO - 'USER': 'cltbld', 08:41:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:45 INFO - '_': '/tools/buildbot/bin/python'} 08:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:41:45 INFO - Cleaning up... 08:41:45 INFO - Return code: 0 08:41:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:41:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:41:45 INFO - Using env: {'DISPLAY': ':0', 08:41:45 INFO - 'HOME': '/home/cltbld', 08:41:45 INFO - 'LANG': 'en_US.UTF-8', 08:41:45 INFO - 'LANGUAGE': 'en_US:en', 08:41:45 INFO - 'LOGNAME': 'cltbld', 08:41:45 INFO - 'MAIL': '/var/mail/cltbld', 08:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:45 INFO - 'MOZ_NO_REMOTE': '1', 08:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:45 INFO - 'NO_EM_RESTART': '1', 08:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:41:45 INFO - 'PWD': '/builds/slave/test-pgo', 08:41:45 INFO - 'SHELL': '/bin/bash', 08:41:45 INFO - 'SHLVL': '1', 08:41:45 INFO - 'TERM': 'linux', 08:41:45 INFO - 'TMOUT': '86400', 08:41:45 INFO - 'USER': 'cltbld', 08:41:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:45 INFO - '_': '/tools/buildbot/bin/python'} 08:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:45 INFO - Downloading/unpacking psutil>=0.7.1 08:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:47 INFO - Installing collected packages: psutil 08:41:47 INFO - Running setup.py install for psutil 08:41:47 INFO - building 'psutil._psutil_linux' extension 08:41:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:41:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:41:47 INFO - building 'psutil._psutil_posix' extension 08:41:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:41:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:41:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:47 INFO - Successfully installed psutil 08:41:47 INFO - Cleaning up... 08:41:48 INFO - Return code: 0 08:41:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:41:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:41:48 INFO - Using env: {'DISPLAY': ':0', 08:41:48 INFO - 'HOME': '/home/cltbld', 08:41:48 INFO - 'LANG': 'en_US.UTF-8', 08:41:48 INFO - 'LANGUAGE': 'en_US:en', 08:41:48 INFO - 'LOGNAME': 'cltbld', 08:41:48 INFO - 'MAIL': '/var/mail/cltbld', 08:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:48 INFO - 'MOZ_NO_REMOTE': '1', 08:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:48 INFO - 'NO_EM_RESTART': '1', 08:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:41:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:41:48 INFO - 'SHELL': '/bin/bash', 08:41:48 INFO - 'SHLVL': '1', 08:41:48 INFO - 'TERM': 'linux', 08:41:48 INFO - 'TMOUT': '86400', 08:41:48 INFO - 'USER': 'cltbld', 08:41:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:48 INFO - '_': '/tools/buildbot/bin/python'} 08:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:41:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:41:50 INFO - Installing collected packages: mozsystemmonitor 08:41:50 INFO - Running setup.py install for mozsystemmonitor 08:41:50 INFO - Successfully installed mozsystemmonitor 08:41:50 INFO - Cleaning up... 08:41:50 INFO - Return code: 0 08:41:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:41:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:50 INFO - Using env: {'DISPLAY': ':0', 08:41:50 INFO - 'HOME': '/home/cltbld', 08:41:50 INFO - 'LANG': 'en_US.UTF-8', 08:41:50 INFO - 'LANGUAGE': 'en_US:en', 08:41:50 INFO - 'LOGNAME': 'cltbld', 08:41:50 INFO - 'MAIL': '/var/mail/cltbld', 08:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:50 INFO - 'MOZ_NO_REMOTE': '1', 08:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:50 INFO - 'NO_EM_RESTART': '1', 08:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:41:50 INFO - 'PWD': '/builds/slave/test-pgo', 08:41:50 INFO - 'SHELL': '/bin/bash', 08:41:50 INFO - 'SHLVL': '1', 08:41:50 INFO - 'TERM': 'linux', 08:41:50 INFO - 'TMOUT': '86400', 08:41:50 INFO - 'USER': 'cltbld', 08:41:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:50 INFO - '_': '/tools/buildbot/bin/python'} 08:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:41:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:52 INFO - Downloading docopt-0.6.1.tar.gz 08:41:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:52 INFO - Running setup.py install for blobuploader 08:41:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:41:52 INFO - Running setup.py install for requests 08:41:53 INFO - Running setup.py install for docopt 08:41:53 INFO - Successfully installed blobuploader requests docopt 08:41:53 INFO - Cleaning up... 08:41:53 INFO - Return code: 0 08:41:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:41:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:53 INFO - Using env: {'DISPLAY': ':0', 08:41:53 INFO - 'HOME': '/home/cltbld', 08:41:53 INFO - 'LANG': 'en_US.UTF-8', 08:41:53 INFO - 'LANGUAGE': 'en_US:en', 08:41:53 INFO - 'LOGNAME': 'cltbld', 08:41:53 INFO - 'MAIL': '/var/mail/cltbld', 08:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:53 INFO - 'MOZ_NO_REMOTE': '1', 08:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:53 INFO - 'NO_EM_RESTART': '1', 08:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:41:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:41:53 INFO - 'SHELL': '/bin/bash', 08:41:53 INFO - 'SHLVL': '1', 08:41:53 INFO - 'TERM': 'linux', 08:41:53 INFO - 'TMOUT': '86400', 08:41:53 INFO - 'USER': 'cltbld', 08:41:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:53 INFO - '_': '/tools/buildbot/bin/python'} 08:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:41:53 INFO - Running setup.py (path:/tmp/pip-o4Teie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:41:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:41:53 INFO - Running setup.py (path:/tmp/pip-TJp142-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:41:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:41:53 INFO - Running setup.py (path:/tmp/pip-X_wWja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:41:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:41:53 INFO - Running setup.py (path:/tmp/pip-zhe2AC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:41:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:41:53 INFO - Running setup.py (path:/tmp/pip-GNbHXH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:41:54 INFO - Running setup.py (path:/tmp/pip-3mSc5i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:41:54 INFO - Running setup.py (path:/tmp/pip-pXgxr9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:41:54 INFO - Running setup.py (path:/tmp/pip-W29xhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:41:54 INFO - Running setup.py (path:/tmp/pip-QMM4Iz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:41:54 INFO - Running setup.py (path:/tmp/pip-wW2Crs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:41:54 INFO - Running setup.py (path:/tmp/pip-BUfas0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:41:54 INFO - Running setup.py (path:/tmp/pip-ou38NQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:41:54 INFO - Running setup.py (path:/tmp/pip-u9BjHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:41:54 INFO - Running setup.py (path:/tmp/pip-UiRjKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:41:54 INFO - Running setup.py (path:/tmp/pip-CypvE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:41:54 INFO - Running setup.py (path:/tmp/pip-g_jUgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:41:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:41:54 INFO - Running setup.py (path:/tmp/pip-ZltBtM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:41:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:54 INFO - Running setup.py install for manifestparser 08:41:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Running setup.py install for mozcrash 08:41:55 INFO - Running setup.py install for mozdebug 08:41:55 INFO - Running setup.py install for mozdevice 08:41:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Running setup.py install for mozfile 08:41:55 INFO - Running setup.py install for mozhttpd 08:41:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Running setup.py install for mozinfo 08:41:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Running setup.py install for mozInstall 08:41:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Running setup.py install for mozleak 08:41:55 INFO - Running setup.py install for mozlog 08:41:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:41:55 INFO - Running setup.py install for moznetwork 08:41:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:41:56 INFO - Running setup.py install for mozprocess 08:41:56 INFO - Running setup.py install for mozprofile 08:41:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:41:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:41:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:41:56 INFO - Running setup.py install for mozrunner 08:41:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:41:56 INFO - Running setup.py install for mozscreenshot 08:41:56 INFO - Running setup.py install for moztest 08:41:56 INFO - Running setup.py install for mozversion 08:41:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:41:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:56 INFO - Cleaning up... 08:41:56 INFO - Return code: 0 08:41:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:41:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:56 INFO - Using env: {'DISPLAY': ':0', 08:41:56 INFO - 'HOME': '/home/cltbld', 08:41:56 INFO - 'LANG': 'en_US.UTF-8', 08:41:56 INFO - 'LANGUAGE': 'en_US:en', 08:41:56 INFO - 'LOGNAME': 'cltbld', 08:41:56 INFO - 'MAIL': '/var/mail/cltbld', 08:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:56 INFO - 'MOZ_NO_REMOTE': '1', 08:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:56 INFO - 'NO_EM_RESTART': '1', 08:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:41:56 INFO - 'PWD': '/builds/slave/test-pgo', 08:41:56 INFO - 'SHELL': '/bin/bash', 08:41:56 INFO - 'SHLVL': '1', 08:41:56 INFO - 'TERM': 'linux', 08:41:56 INFO - 'TMOUT': '86400', 08:41:56 INFO - 'USER': 'cltbld', 08:41:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:56 INFO - '_': '/tools/buildbot/bin/python'} 08:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:41:56 INFO - Running setup.py (path:/tmp/pip-qqGIBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:41:56 INFO - Running setup.py (path:/tmp/pip-yE5_PP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:41:57 INFO - Running setup.py (path:/tmp/pip-5E2m9b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:41:57 INFO - Running setup.py (path:/tmp/pip-lbPFBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:41:57 INFO - Running setup.py (path:/tmp/pip-YH6kvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:41:57 INFO - Running setup.py (path:/tmp/pip-p1CjCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:41:57 INFO - Running setup.py (path:/tmp/pip-Yagi7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:41:57 INFO - Running setup.py (path:/tmp/pip-ATo5tD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:41:57 INFO - Running setup.py (path:/tmp/pip-WoT_QN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:41:57 INFO - Running setup.py (path:/tmp/pip-QOHAuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:41:57 INFO - Running setup.py (path:/tmp/pip-pwvrxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:41:57 INFO - Running setup.py (path:/tmp/pip-wghPR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:41:57 INFO - Running setup.py (path:/tmp/pip-QKhrtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:41:57 INFO - Running setup.py (path:/tmp/pip-Nid3R1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:41:57 INFO - Running setup.py (path:/tmp/pip-qri2aM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:41:57 INFO - Running setup.py (path:/tmp/pip-3YrRYT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:41:58 INFO - Running setup.py (path:/tmp/pip-jNTKc4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:59 INFO - Downloading blessings-1.6.tar.gz 08:41:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:59 INFO - Installing collected packages: blessings 08:41:59 INFO - Running setup.py install for blessings 08:42:00 INFO - Successfully installed blessings 08:42:00 INFO - Cleaning up... 08:42:00 INFO - Return code: 0 08:42:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:42:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:42:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:42:00 INFO - Reading from file tmpfile_stdout 08:42:00 INFO - Current package versions: 08:42:00 INFO - argparse == 1.2.1 08:42:00 INFO - blessings == 1.6 08:42:00 INFO - blobuploader == 1.2.4 08:42:00 INFO - docopt == 0.6.1 08:42:00 INFO - manifestparser == 1.1 08:42:00 INFO - mozInstall == 1.12 08:42:00 INFO - mozcrash == 0.16 08:42:00 INFO - mozdebug == 0.1 08:42:00 INFO - mozdevice == 0.48 08:42:00 INFO - mozfile == 1.2 08:42:00 INFO - mozhttpd == 0.7 08:42:00 INFO - mozinfo == 0.9 08:42:00 INFO - mozleak == 0.1 08:42:00 INFO - mozlog == 3.1 08:42:00 INFO - moznetwork == 0.27 08:42:00 INFO - mozprocess == 0.22 08:42:00 INFO - mozprofile == 0.28 08:42:00 INFO - mozrunner == 6.11 08:42:00 INFO - mozscreenshot == 0.1 08:42:00 INFO - mozsystemmonitor == 0.0 08:42:00 INFO - moztest == 0.7 08:42:00 INFO - mozversion == 1.4 08:42:00 INFO - psutil == 3.1.1 08:42:00 INFO - requests == 1.2.3 08:42:00 INFO - wsgiref == 0.1.2 08:42:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:42:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:42:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:00 INFO - Using env: {'DISPLAY': ':0', 08:42:00 INFO - 'HOME': '/home/cltbld', 08:42:00 INFO - 'LANG': 'en_US.UTF-8', 08:42:00 INFO - 'LANGUAGE': 'en_US:en', 08:42:00 INFO - 'LOGNAME': 'cltbld', 08:42:00 INFO - 'MAIL': '/var/mail/cltbld', 08:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:00 INFO - 'MOZ_NO_REMOTE': '1', 08:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:00 INFO - 'NO_EM_RESTART': '1', 08:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:00 INFO - 'SHELL': '/bin/bash', 08:42:00 INFO - 'SHLVL': '1', 08:42:00 INFO - 'TERM': 'linux', 08:42:00 INFO - 'TMOUT': '86400', 08:42:00 INFO - 'USER': 'cltbld', 08:42:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:00 INFO - '_': '/tools/buildbot/bin/python'} 08:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:42:00 INFO - Cleaning up... 08:42:00 INFO - Return code: 0 08:42:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:42:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:42:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:42:00 INFO - Using env: {'DISPLAY': ':0', 08:42:00 INFO - 'HOME': '/home/cltbld', 08:42:00 INFO - 'LANG': 'en_US.UTF-8', 08:42:00 INFO - 'LANGUAGE': 'en_US:en', 08:42:00 INFO - 'LOGNAME': 'cltbld', 08:42:00 INFO - 'MAIL': '/var/mail/cltbld', 08:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:00 INFO - 'MOZ_NO_REMOTE': '1', 08:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:00 INFO - 'NO_EM_RESTART': '1', 08:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:00 INFO - 'SHELL': '/bin/bash', 08:42:00 INFO - 'SHLVL': '1', 08:42:00 INFO - 'TERM': 'linux', 08:42:00 INFO - 'TMOUT': '86400', 08:42:00 INFO - 'USER': 'cltbld', 08:42:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:00 INFO - '_': '/tools/buildbot/bin/python'} 08:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:00 INFO - Downloading/unpacking jsonschema 08:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:02 INFO - Downloading/unpacking functools32 (from jsonschema) 08:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:02 INFO - warning: no files found matching '*.txt' 08:42:02 INFO - no previously-included directories found matching 'build' 08:42:02 INFO - no previously-included directories found matching 'dist' 08:42:02 INFO - no previously-included directories found matching '.git*' 08:42:02 INFO - Installing collected packages: jsonschema, functools32 08:42:02 INFO - Running setup.py install for functools32 08:42:02 INFO - warning: no files found matching '*.txt' 08:42:02 INFO - no previously-included directories found matching 'build' 08:42:02 INFO - no previously-included directories found matching 'dist' 08:42:02 INFO - no previously-included directories found matching '.git*' 08:42:02 INFO - Successfully installed jsonschema functools32 08:42:02 INFO - Cleaning up... 08:42:03 INFO - Return code: 0 08:42:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5cecbd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:42:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:42:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:42:03 INFO - Using env: {'DISPLAY': ':0', 08:42:03 INFO - 'HOME': '/home/cltbld', 08:42:03 INFO - 'LANG': 'en_US.UTF-8', 08:42:03 INFO - 'LANGUAGE': 'en_US:en', 08:42:03 INFO - 'LOGNAME': 'cltbld', 08:42:03 INFO - 'MAIL': '/var/mail/cltbld', 08:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:03 INFO - 'MOZ_NO_REMOTE': '1', 08:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:03 INFO - 'NO_EM_RESTART': '1', 08:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:03 INFO - 'SHELL': '/bin/bash', 08:42:03 INFO - 'SHLVL': '1', 08:42:03 INFO - 'TERM': 'linux', 08:42:03 INFO - 'TMOUT': '86400', 08:42:03 INFO - 'USER': 'cltbld', 08:42:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:03 INFO - '_': '/tools/buildbot/bin/python'} 08:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:03 INFO - Downloading/unpacking flake8 08:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:42:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:42:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:05 INFO - no previously-included directories found matching 'docs/_build' 08:42:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:42:05 INFO - Running setup.py install for pep8 08:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:42:05 INFO - no previously-included directories found matching 'docs/_build' 08:42:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:42:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:42:05 INFO - Cleaning up... 08:42:05 INFO - Return code: 0 08:42:05 INFO - Running post-action listener: _resource_record_post_action 08:42:05 INFO - Running post-action listener: _start_resource_monitoring 08:42:05 INFO - Starting resource monitoring. 08:42:05 INFO - ##### 08:42:05 INFO - ##### Running install step. 08:42:05 INFO - ##### 08:42:05 INFO - Running pre-action listener: _resource_record_pre_action 08:42:05 INFO - Running main action method: install 08:42:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:42:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:42:06 INFO - Reading from file tmpfile_stdout 08:42:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:42:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:42:06 INFO - Reading from file tmpfile_stdout 08:42:06 INFO - Output received: 08:42:06 INFO - Usage: mozinstall [options] installer 08:42:06 INFO - Options: 08:42:06 INFO - -h, --help show this help message and exit 08:42:06 INFO - -d DEST, --destination=DEST 08:42:06 INFO - Directory to install application into. [default: 08:42:06 INFO - "/builds/slave/test-pgo"] 08:42:06 INFO - --app=APP Application being installed. [default: firefox] 08:42:06 INFO - mkdir: /builds/slave/test-pgo/build/application 08:42:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:42:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:42:22 INFO - Reading from file tmpfile_stdout 08:42:22 INFO - Output received: 08:42:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:42:22 INFO - Running post-action listener: _resource_record_post_action 08:42:22 INFO - ##### 08:42:22 INFO - ##### Running run-tests step. 08:42:22 INFO - ##### 08:42:22 INFO - Running pre-action listener: _resource_record_pre_action 08:42:22 INFO - Running main action method: run_tests 08:42:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:42:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:42:22 INFO - Python 2.7.3 08:42:22 INFO - Return code: 0 08:42:22 INFO - grabbing minidump binary from tooltool 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63740>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf64640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf64af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:42:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 08:42:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:42:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:22 INFO - Return code: 0 08:42:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:42:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:42:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:42:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:42:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:42:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:42:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:42:23 INFO - Return code: 0 08:42:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:42:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:42:23 INFO - Using env: {'DISPLAY': ':0', 08:42:23 INFO - 'HOME': '/home/cltbld', 08:42:23 INFO - 'LANG': 'en_US.UTF-8', 08:42:23 INFO - 'LANGUAGE': 'en_US:en', 08:42:23 INFO - 'LOGNAME': 'cltbld', 08:42:23 INFO - 'MAIL': '/var/mail/cltbld', 08:42:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:42:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:23 INFO - 'MOZ_NO_REMOTE': '1', 08:42:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:23 INFO - 'NO_EM_RESTART': '1', 08:42:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:42:23 INFO - 'PWD': '/builds/slave/test-pgo', 08:42:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:42:23 INFO - 'SHELL': '/bin/bash', 08:42:23 INFO - 'SHLVL': '1', 08:42:23 INFO - 'TERM': 'linux', 08:42:23 INFO - 'TMOUT': '86400', 08:42:23 INFO - 'USER': 'cltbld', 08:42:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453394491.46457-447452789', 08:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:23 INFO - '_': '/tools/buildbot/bin/python'} 08:42:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:42:23 INFO - mozversion application_buildid: 20160121053025 08:42:23 INFO - mozversion application_changeset: a7b909eabadf197c6b1988a793c329b6213db042 08:42:23 INFO - mozversion application_display_name: Nightly 08:42:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:23 INFO - mozversion application_name: Firefox 08:42:23 INFO - mozversion application_remotingname: firefox 08:42:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:42:23 INFO - mozversion application_vendor: Mozilla 08:42:23 INFO - mozversion application_version: 46.0a1 08:42:23 INFO - mozversion platform_buildid: 20160121053025 08:42:23 INFO - mozversion platform_changeset: a7b909eabadf197c6b1988a793c329b6213db042 08:42:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:42:23 INFO - mozversion platform_version: 46.0a1 08:42:23 INFO - using testdate: 1453394543 08:42:23 INFO - actual date: 1453394543 08:42:23 INFO - starting webserver on 'localhost:57209' 08:42:23 INFO - SUITE-START | Running 3 tests 08:42:23 INFO - TEST-START | dromaeo_css 08:42:23 INFO - operating with platform_type : linux_ 08:42:23 INFO - Initialising browser for dromaeo_css test... 08:42:23 INFO - TEST-INFO | started process 27470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptSCrtx/profile http://localhost:57209/getInfo.html) 08:42:27 INFO - PROCESS | 27470 | __metrics Screen width/height:1600/1200 08:42:27 INFO - PROCESS | 27470 | colorDepth:24 08:42:27 INFO - PROCESS | 27470 | Browser inner width/height: 1024/697 08:42:27 INFO - PROCESS | 27470 | __metrics 08:42:28 INFO - PROCESS | 27470 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:42:28 INFO - PROCESS | 27470 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:28 INFO - TEST-INFO | 27470: exit 0 08:42:28 INFO - Browser initialized. 08:42:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:28 INFO - TEST-INFO | started process 27564 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptSCrtx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:40 INFO - PROCESS | 27564 | RSS: Main: 149520384 08:42:40 INFO - PROCESS | 27564 | 08:43:31 INFO - PROCESS | 27564 | 1453394611975 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:45:40 INFO - PROCESS | 27564 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57209/tests/dromaeo/cssquery-ext.html) 08:45:41 INFO - PROCESS | 27564 | RSS: Main: 268562432 08:45:41 INFO - PROCESS | 27564 | 08:48:43 INFO - PROCESS | 27564 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-ext.html (next: http://localhost:57209/tests/dromaeo/cssquery-jquery.html) 08:48:44 INFO - PROCESS | 27564 | RSS: Main: 234725376 08:48:44 INFO - PROCESS | 27564 | 08:51:46 INFO - PROCESS | 27564 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57209/tests/dromaeo/cssquery-mootools.html) 08:51:46 INFO - PROCESS | 27564 | RSS: Main: 237191168 08:51:46 INFO - PROCESS | 27564 | 08:54:48 INFO - PROCESS | 27564 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57209/tests/dromaeo/cssquery-prototype.html) 08:54:49 INFO - PROCESS | 27564 | RSS: Main: 214716416 08:54:49 INFO - PROCESS | 27564 | 08:57:51 INFO - PROCESS | 27564 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57209/tests/dromaeo/cssquery-yui.html) 08:57:52 INFO - PROCESS | 27564 | RSS: Main: 213131264 08:57:52 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | Cycle 1(1): loaded http://localhost:57209/tests/dromaeo/cssquery-yui.html (next: http://localhost:57209/tests/dromaeo/cssquery-dojo.html) 09:00:55 INFO - PROCESS | 27564 | RSS: Main: 258600960 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | __start_tp_report 09:00:55 INFO - PROCESS | 27564 | _x_x_mozilla_page_load 09:00:55 INFO - PROCESS | 27564 | _x_x_mozilla_page_load_details 09:00:55 INFO - PROCESS | 27564 | |i|pagename|runs| 09:00:55 INFO - PROCESS | 27564 | |0;dojo.html;3131.185891668166;3133.4359815233247;3193.9041828745144;3194.0737186215997;3228.338190670913;5021.64848460607;5114.360704911886;5174.948250517494;5179.430262671108;5223.895522089556;5105.872353191172;5156.432792392834;5213.087709650815;5221.7389130543415;5226.973865130669;4559.156556037144;4680.555347242023;4730.574248317659;4800.663953523254;4840.225563909775;4656.790444429992;4795.520447955211;4803.087413391462;4812.23004319309;4902.534259245366;4696.600788932945;4752.667313288071;4759.976200119012;4773.928391074137;4784.138855006097;4747.45404278509;4760.476347601761;4763.118823017753;4784.162771514971;4831.371921650198;4730.526947305277;4751.881202969919;4763.69036012658;4767.952320476786;4815.0610630926985;5005.199168133117;5020.121478741242;5030.522100400456;5044.646874718771;5118.4625614310335;5643.068893632546;5645.125005624135;5650.208970744099;5670;5692.117721753135;5692.943070569283;5695.174199741055;5696.3733989261145;5701.116326969326;5708.229389032469;5176.249443830661;5236.1098613235845;5248.947510524922;5251.2123181523075;5317.760700768436;5737.684427356536;5757.596968212269;5757.712114394263;5759.51044161251;5765.711714414262;5441.782328706808;5544.3088220700765;5560.916586251128;5569.805056822992;5605.187247849039;5544.61187716856;5606.6916319602815;5610.07433773431;5628.971855140698;5675.8864822704145;5572.164175373727;5578.721063946868;5579.721013949286;5580.162975553618;5581.525570326487;5570.275864137717;5574.358948720949;5576.832695019156;5577;5579.609427340048;4273.294906340419;4305.84929527465;4346.956530434719;4368.126374725068;4393.0774537347515;3842.9423558646645;3849.4610754494392;3849.6920246380223;3882.378819388884;3891.747036442622;5103.795848166032;5105.336306280234;5106.66806657566;5107.412647545506;5123.538881500683;5470.589705772083;5530.5022547970875;5573.27547418833;5584.776608935678;5651.576131790132;5097.6941383517105;5109.591232701375;5111.207762796773;5115.462876397924;5117.795288188505;4683.5082316356975;4701.106789710013;4701.976490117528;4722.386089808303;4769.2130798417875;5697.974364614409;5711.428857114339;5730.914036289376;5779.306483222041;5827.24245848037;5485.780568777363;5492.313460817398;5495.642783219078;5500.642458240201;5509.917351239815;5664.716764161693;5711.685857277889;5717.685527296038;5729.427057294237;5747.224124743273;5524.06090964529;5536.750846211849;5570.554355651457;5574;5610.18652295423;5597.188407680945;5615.157726341082;5624.437556244343;5626.24045753818;5631.662100273997;5262.526372626482;5371.033214021358;5480.068388373907;5495.038368285614;5537.501624853782;5386.380566234933;5456.781728730965;5459.590530710133;5465.890682186414;5501.807436739855;5364.168553874156;5369;5407.945920540744;5409.78360865561;5467.72661366938;5369.946300536944;5398.3791863934575;5444.128939369682;5474.863128421662;5501.724913754216;5340.359156901197;5399.649022813504;5402.59480538969;5407.324084489439;5422.48486393792 09:00:55 INFO - PROCESS | 27564 | |1;ext.html;529.4784637132424;548.5858177076307;558.7485631465842;560.0283508113422;573.5440324941671;26717.198484045486;27441.451170976594;35869.641303586955;35965;36076.45885311723;38779.80610096952;39226.8038659807;39247.41128883069;39376;39442.408363874565;7697.34572561333;7787.415943804237;7839.568823714693;7851.0578730552415;7858.253465920729;8703.912960870373;8855.468671879675;8859.246964008067;8865.601047952858;8870.778230544223;8768.649254029831;8823.426477278956;8852.955735221314;8885.155910188554;8886.244669203126;8737;8790.033096359395;8813.867791983126;8814.382993190478;8827.867581986275;8633.913660863436;8705.042445331008;8745.737627871174;8771.605277762515;8773.078826723166;37769.43345849787;38359.23281534354;38369.80815095935;38389.232215355536;38411.807940960396;3300.339932013607;3369.0903456066726;3581.5164952731307;3799.696024318048;3847.442120892455;29191;29519.70480295191;29572.8521357394;30708.53937190944;30753.231169220948;3853.3064048471265;3938.251732170907;3947.4670919426085;3969.28552860485;3981.7810020448865;201668;201747.99126004422;202053;202164;202392;52666.73666631642;53910;56486.71756641273;57933.71033144807;59306.110408343906;54285.45714542883;54289.72855135699;54609.180862287096;54674;54701.45298547043;11576.24754390962;11648.767024659459;11700;11700.88299117015;11744.236624619543;8354.707585234488;8437.114103019218;8444.240018398374;8750.47497150173;8963.775905602412;19031.619367612846;19108.42674719733;19186;19223.51941201453;19225.615487690167;6784;7059.788206353817;7138.428925685933;7140.321669441395;7188.281171882874;941.5480569326761;1007.0332480818496;1007.7984403119406;1055.8257887448638;1068.9786204275872;27971;28217.858910705316;28640.713592863805;28881.71118288832;29461.26346841303;1014.0822555587206;1037.6835065305154;1073.6456969200144;1134.177721152158;1155.260633194756;13731.862681373259;13837.515686950908;13854.584362469142;14061.08602940826;14061.226632535105;280912;281806;282716;283059;283919;49658.75170624196;49821;50071.74964125229;50148.74925625348;50196;1268.4989429175423;1309.7904335306496;1322.761902857495;1325.0393464737795;1332.2872263339068;27012.32469188286;27151.321216968943;27870.86064569664;28019.719802801712;28065.85967070233;45328.77335613301;45455.31817022681;45662.31506527471;45790.77104614589;45896.54103458922;269384;271886;271908;272010;272148;27771;31041.844790776806;31290;31542.369152617277;31694.683053170094;35358.823205883804;35968;36445.45331819972;36819.263614728094;36822.631773682995;29173.562396563644;30693.23266918345;31316.217094572818;31805.681943181196;31880.84059579687;27526.724732752416;31690.20774480564;31832;31905.8404707975;32194.678053220105;31829.135377816106;32180.19549511187;32229;32264.35471290514;32288.67711322857;30222.244443889078;31008;31655.643651141738;32478.83760581182;32491.35017299688;22576.774232258125;23469.76530234744;23518;24119.638205427284;24124.75875241225 09:00:55 INFO - PROCESS | 27564 | |2;jquery.html;366.7048026338797;366.7964279824696;367.7921974084642;368.9778613283202;378.36057063562595;13609.319534023283;14013.649658758537;16379.18104094795;17296.74054889176;18082.728759068625;15622.453214137508;15874.84125158748;15887.36450541977;16004.75992860108;16689.83310166901;4942.901141977167;5107.846764597068;5119.616028797836;5120.539151476366;5121.359830021247;3767.7362584619086;3886.203328317688;5078.4413714491375;5330.227117068022;5529.917051244234;5311.2298716686055;5511.696856672901;5527.198556209347;5537.307836520435;5538.363088244863;5494.09347457669;5511.421300763443;5565.499105080562;5568.888622227553;5577.581681373873;5172.5344718975475;5347.946520534783;5361.356637203521;5379.220013098079;5382.838514844561;13110;13185.274809885452;15022.924885375613;20018.799812001984;20131;2106.4628519727526;2142.2502124256544;2158.665406861939;2171.695962565242;2314.5139520700673;9519.809603807886;9698.224142068617;9779.168770654504;9866.753331166707;11153.776924461465;1767.7525146479504;1798.1818272686028;1809.4390738870993;1831.359024341483;1837.9081045947783;57074.999999999585;57096.42903570952;58483;58671.41328586702;59275;9943.353682010646;10131.848022279672;10228.386296822215;10252.948735256425;10302.536385862653;13644.795328070088;13686.452541898412;13692.110012849333;13692.65768355779;13704.52034178799;6703.262641109474;6731.697073631698;6765.492588055916;6806.659667016629;6897.3447522485285;5993.340732519419;6041.2750469943885;6049.637021778707;6087.969560152171;6201.193844800147;4072.205919845602;4482.618977386894;4485.6860019798305;4543.704659197141;4564.794584243717;1691.7716108325465;1754.9473515794546;1781.7260658629143;1791.480470663519;1803.1344954421952;913.4062859141611;924.4776701163821;932.9953350233205;941.75985123793;994.683758135846;13068.738625227443;13872.393557248095;14745.410183592536;15146.772798408032;15211.543653690185;935.3218916285774;937.4094320578129;938.7324612485409;997.6558087459815;997.7106639074588;9255.490947997925;9266.675666351646;9516.38143520669;9562.760930976781;9612.663556775618;495683;498275;505618;514357;514567;70403;71338.64330678314;72338.63830680813;72764;73583.89624155642;1097.8572785537829;1108.9057430118369;1109.522905150793;1111.8888111188978;1127.7800828838463;14183.858161418666;14425.567232983027;14480.710385792014;14514.419423222953;14755;33127;33306.5004024935;33470.330593388484;34060.31879362449;34338.31323373468;41959.58040419557;42843;43294;44919.77540112279;46661.30008049814;7187.9640601796655;7453.962730186315;7465.021769231266;7482.96258518704;7500.287472690085;9647.517624118906;10586.311889727143;10699.090577301016;10965.396903170402;11201.887981120084;9445.716628501155;9519.571619277287;9546.18857397129;9751.219902407933;9821.950890245504;6656.866862662623;9502.097300756417;9526.85709714341;9754.756131096496;9932.453715045742;8889.422187557788;9079.818403631758;9306.255499559884;9435.905640943778;9587.664431744855;7310.96344518274;7312.986890315174;7359.521631093961;7497.475176737576;7552.13150487679;7698.8845167321415;9407.811843763224;9436.056394360508;9535.38020028696;9650.517474126125 09:00:55 INFO - PROCESS | 27564 | |3;mootools.html;1338.2973938682196;1469.0598017268949;1474.498670452046;1635.9018458892467;1802.3871883559586;6934.202566704824;7541.09506859177;7708.2291770822885;7734.342580880632;7740.496867703595;7549.245075492448;7728.227177282269;7733.0720313562315;7734.6906123755125;7734.8453030939345;2034.888081155536;2070.3064473401428;2086.2802333195023;2376.5009348036933;2412.9396765080837;2071.6892466130053;2299.4481324482085;2348.0842471436154;2355.057976809273;2362.385779697274;2290;2301.608726516496;2304.608216603173;2305.4121199094207;2376.4771750215014;2287.1994801819396;2317.965230521535;2324.6048171810835;2325.860448373086;2332.2070496031347;2260.400993736661;2271.965920511177;2272.6363781794835;2274.5450909817937;2278.1456953642382;7823.647935842901;7867.803304917423;7895.881561776578;7913.723019694341;7917.802054948615;4778.737169455679;4917.8278760243575;4922.163232250526;4927.6550641455115;4937.210046392596;3162.778605497616;3185;3286.4413049781597;3305.8512366943305;3308.2556424804466;1075.7095584192302;1109.9889001110048;1124.0951034417292;1129.3675541696593;1179.7935361311822;10938.726531836688;10943.398113103776;10953.233273670847;10974.561017559288;10991.285566438077;4340;4387.912241755147;4434.512203657595;4459.063596644676;4485.910281794346;9370.765730856783;9394;9397.765055873659;9400.482973436527;9401.811963760687;4916.778744956486;4918.385201849769;4943.72809495474;4951.059298733301;4951.455339912607;4451.666125040635;4493.865184044484;4519.276915693474;4524.117797029613;4525.818967241339;3424.092615456906;3501.4222653262436;3752.7185461090526;3812.942805857914;3842.3275926712713;1194.5639841457805;1234.4876876096318;1239.4112796421628;1253.385840937952;1253.4296894912793;1042.6090216168936;1043.3218408034838;1215.9696007599705;1301.1997621462733;1323.8874695650977;7116.039334689751;7189.532680375759;7207.387372073327;7217.6030318333;7220.963895180491;1104.5029736618394;1124.8706398764248;1125.1167833250859;1142.097742783192;1148.2019996102795;5733.483986441241;5821.15593238978;5830.912536311958;5832.125181222766;5839.591228613956;9417.670381536751;9435.198008169382;9526.095020973135;9653.324267301221;9654.75863103428;9404.717858464257;9500.19248363883;9549.952250238843;9559.761005974768;9562.713118606453;7183.820404489825;7305.1233851938105;7311.926880731125;7328.926710732824;7426.220246874109;7137.643117843983;7159.140903091662;7183.353498185188;7188.568685878864;7199.460040497089;8187.631556580087;8397.454165479225;8491.8726219108;8629.09394513567;8644.697435589724;8566.52884091381;8715.738527844174;8736.694215702673;8809.823803524021;8830.646774128963;6927.618980955895;7032.472564557576;7041.647917603997;7045.013698082375;7051.894221586783;6470;6644.767433139817;7136.3220494052985;7430.071241094864;7494.887576686463;6989;7036.366726994595;7099.07711997437;7120.643967801486;7156.069710937545;6794.558353706993;6904.516683832084;6968.477364197807;7082.220955694766;7090.255523169993;6728.3271672832325;6753;6791.490638202254;6791.762288319885;6797.388235058868;6356.713947872265;6489.091527186103;6501;6579.243387010555;6635.303293154342;6622.867542649216;6662.167229096363;6668.0331351954665;6677.9332206679255;6679.198496180489 09:00:55 INFO - PROCESS | 27564 | |4;prototype.html;335.57382124701627;342.939985502537;351.5447495493336;353.16124205013085;357.79963220596466;5679.488846003869;5789.073748200289;5792.623479473837;5799.913001304979;5828.650280983139;5589.944100558993;5692.402297758737;5701.34434540028;5713.085906255;5738.942610573903;4539.00141968768;4542.114287713881;4546.386237857896;4549.567791059844;4556.04323092151;4328.3074708046715;4408.493023302313;4420.756858372788;4431.711938723973;4544.681872268942;4442.3558584005295;4473.463184417875;4478.731276123443;4480.238359478896;4499.842505512308;4505.752183629899;4507.616852567536;4514.097180563867;4514.954850451486;4519.231730605805;3997.360422332413;3998.1204135090525;4007.7394969327192;4013.036871150932;4015.6988225882883;5396.325459317585;5522.22688823565;5523.558115350762;5525.4474552544825;5539.639923405006;5128.333316668846;5156.458571849939;5163.561097306733;5165.354330708661;5165.690058596496;5852.795152169696;6166.938330616681;6172.567920245585;6213.56505044647;6234.750609975596;4196.51740049892;4221.472315960505;4307.719998200107;4310.892227694333;4316.072044510414;6306.716197771111;6350.745970161188;6361.713722882481;6370.299267080663;6373.075903993941;4402.713823601455;4403.515613282536;4406.427164468599;4407.845725399596;4412.205802955499;4353.10761293934;4456.131054444417;4461.375407442961;4467.12890986261;4478.529754375743;5116.718580478035;5151.510606492452;5153.845384638467;5156.767945442464;5158.767855446514;6121.234845644294;6182.783602573888;6184.257889053342;6190.288116866618;6190.81427557174;1563.4215340324154;1588.6187315044306;1591.2123498868134;1591.6498370358502;1592.418767149982;1065.0893486069454;1072.0405237312561;1073.3452593917705;1073.4310815267763;1099.5491848342142;5863.442972917651;5863.589548731547;5871.915470008085;5872.148538461899;5876.764929402776;6324.3991820776955;6326.49388048955;6334.873302534015;6339.841503962438;6340.809775706736;5870.178175055496;5879.794207202727;5885.764569417261;5888.116782482662;5888.882222355614;3311.850966706504;3431.3995050865997;3432.3993301172195;3434.4504879219203;3438.7249020078334;6555.147830781968;6591.83520411984;6592.813293607197;6592.967035164794;6595.373439523238;6448.9355106449275;6458.38645328693;6466.805995820133;6478.708458119396;6480.902786458207;6480.2547707013355;6592.80221593353;6633.303503132198;6639.7012134455035;6639.966800165968;6205.937940620716;6340.936590634219;6377.330380310186;6404.93595064062;6429.8714025720155;6216.316205217332;6325.462335701517;6332.2717887441695;6334.746610135728;6356.141920840812;6676.132102826601;6681.899771503528;6684.63234522106;6686.53194276396;6692.59844409337;4324.978375108104;4420.933685994777;4452.532484089124;4452.5992660660695;4461.10777844426;6314.810555683337;6363.681815909279;6367.3314301997625;6367.87264254703;6370.8088757337355;6199.163112979871;6203.7828675996125;6205.03821907605;6206.255249370104;6213.813585592439;6055.818325450244;6182.05265341416;6186.288576813544;6188.226471691039;6189.226346706661;6100.633961962297;6132.938670613236;6158.876822463615;6159.753609855556;6161.753529858935;6288.496920246278;6297.118403423616;6298.527610429144;6304.779332723333;6309.936900631119;5903.291605007426;6098.603590766586;6110.725017374318;6115.938840611537;6117.235345581802 09:00:55 INFO - PROCESS | 27564 | |5;yui.html;766.8197973476232;851.2041241439258;869.5478351257347;870.6604424274531;898.2320116300563;13310.401031953561;13402.463901443944;13461;13464.865351346483;13544.593662190138;11209.943950280238;12696.746065078716;12878.871211287884;12891.355432228374;12895.226286422798;665.0954701605813;793.8769490728946;812.4231795425255;813.6989313953845;814.3851392198911;792.4532072869702;796.6813274690141;800.403699244064;800.6637212370789;801.0907619851453;692.8406466512705;706.8409607838247;856.2850020233113;857.0529564830865;858.4205661178679;809.3929552835374;819.3527113580265;824.1675907333636;824.7443292579289;826.2976470000511;608.8964875971095;609.4606273447986;610.1854024876794;610.2372034956304;610.5207412181461;12305.20016198953;12327.630171094881;12351.32067736274;12363.690907727289;12369.196002259825;11578.652640420802;11752.882471175264;11934.940325298317;12001.87998120025;12056.63830085099;10636.149108071335;10652;10669.35983840972;10686.091682207021;11062.22564420491;3582.1044738815294;3676.74262801604;3718.1448266898497;3723.72072094594;3790.7156963227594;46318.305225421645;47037.529624704;48890;48956.755216224046;48989.26516102262;10083.647072352433;10271.7432064199;10294.742631434125;10334.483275836179;10428.843567346496;17948.282068717104;17967.910160449115;17972.1013949302;17977.19102640384;18027.54931126706;7245.311695388929;7340.302671246223;7437.367823735043;7469.215732348134;7537.170911199873;4293.914121717548;4296.419983302214;4301.65586753059;4324.805383757738;4393.033532622818;2937.8237305761295;2964.451576458362;2969.85150742462;2972.1677930179585;2977.0027040941095;552.1221258199482;566.6486778197544;568.5678884048153;570.0821677099866;577.4225774225774;477.739631900615;501.34574380433156;509.12430619334685;552.6628756458557;657.947364210862;8049.758507244792;8486.830263394697;8646;8651.178138076873;8661;537.6800803521899;544.5833937038169;545.9535939445192;583.4865318519676;584.2054805464564;3790.6209379061875;3799.35410980134;3890.7860067696547;3922.666573341298;4129.380592911028;54688.453115468335;56679.43320566742;56873.715631421575;56896;56938.430615693316;48276.27585586219;48943.5105648939;48974.51025489771;49103.508964909895;49529.752351238014;43069.35395969;43404.56595434069;43766;44114.338284925754;44792.55207447949;8064.919350806417;8146.2261085196815;8175.427720059539;8220.890179825887;8259.917400826154;31583;31713.682863171074;32474;32629.18427039343;32658.183545411553;37967.430488542144;38361.42457863079;41456.58543414527;42326.15347692967;42556;9794.118529332109;9804.117629413102;10036.698899033041;10092.24308176875;10157.695269141937;10989.395583242998;10995.670129896116;11164;11257.49341279628;11553.256796619602;10335.483225838829;10468.424236667057;10597.841032384365;10695.94652026735;11075.390853503135;10601.946990265;10776.838347424638;10850.565977361133;10935.617253396093;11325.830112548483;9019.819603608023;9702.27232957517;9718.076782705632;9730.026997300214;10648.946755266174;9141.77145571366;9401.086392139536;9485.193758530602;9699.466529340672;9839.163671088038;9495.24038076966;9561.665341713286;9580.28147888925;9587.952060239653;9625.951870240604 09:00:55 INFO - PROCESS | 27564 | __end_tp_report 09:00:55 INFO - PROCESS | 27564 | __start_cc_report 09:00:55 INFO - PROCESS | 27564 | _x_x_mozilla_cycle_collect,985 09:00:55 INFO - PROCESS | 27564 | __end_cc_report 09:00:55 INFO - PROCESS | 27564 | __startTimestamp1453395655342__endTimestamp 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | ------- Summary: start ------- 09:00:55 INFO - PROCESS | 27564 | Number of tests: 6 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | [#0] dojo.html Cycles:165 Average:5181.60 Median:5398.38 stddev:568.68 (10.5%) stddev-sans-first:547.20 09:00:55 INFO - PROCESS | 27564 | Values: 3131.2 3133.4 3193.9 3194.1 3228.3 5021.6 5114.4 5174.9 5179.4 5223.9 5105.9 5156.4 5213.1 5221.7 5227.0 4559.2 4680.6 4730.6 4800.7 4840.2 4656.8 4795.5 4803.1 4812.2 4902.5 4696.6 4752.7 4760.0 4773.9 4784.1 4747.5 4760.5 4763.1 4784.2 4831.4 4730.5 4751.9 4763.7 4768.0 4815.1 5005.2 5020.1 5030.5 5044.6 5118.5 5643.1 5645.1 5650.2 5670.0 5692.1 5692.9 5695.2 5696.4 5701.1 5708.2 5176.2 5236.1 5248.9 5251.2 5317.8 5737.7 5757.6 5757.7 5759.5 5765.7 5441.8 5544.3 5560.9 5569.8 5605.2 5544.6 5606.7 5610.1 5629.0 5675.9 5572.2 5578.7 5579.7 5580.2 5581.5 5570.3 5574.4 5576.8 5577.0 5579.6 4273.3 4305.8 4347.0 4368.1 4393.1 3842.9 3849.5 3849.7 3882.4 3891.7 5103.8 5105.3 5106.7 5107.4 5123.5 5470.6 5530.5 5573.3 5584.8 5651.6 5097.7 5109.6 5111.2 5115.5 5117.8 4683.5 4701.1 4702.0 4722.4 4769.2 5698.0 5711.4 5730.9 5779.3 5827.2 5485.8 5492.3 5495.6 5500.6 5509.9 5664.7 5711.7 5717.7 5729.4 5747.2 5524.1 5536.8 5570.6 5574.0 5610.2 5597.2 5615.2 5624.4 5626.2 5631.7 5262.5 5371.0 5480.1 5495.0 5537.5 5386.4 5456.8 5459.6 5465.9 5501.8 5364.2 5369.0 5407.9 5409.8 5467.7 5369.9 5398.4 5444.1 5474.9 5501.7 5340.4 5399.6 5402.6 5407.3 5422.5 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | [#1] ext.html Cycles:180 Average:41370.88 Median:17895.85 stddev:66419.27 (371.1%) stddev-sans-first:66534.80 09:00:55 INFO - PROCESS | 27564 | Values: 529.5 548.6 558.7 560.0 573.5 26717.2 27441.5 35869.6 35965.0 36076.5 38779.8 39226.8 39247.4 39376.0 39442.4 7697.3 7787.4 7839.6 7851.1 7858.3 8703.9 8855.5 8859.2 8865.6 8870.8 8768.6 8823.4 8853.0 8885.2 8886.2 8737.0 8790.0 8813.9 8814.4 8827.9 8633.9 8705.0 8745.7 8771.6 8773.1 37769.4 38359.2 38369.8 38389.2 38411.8 3300.3 3369.1 3581.5 3799.7 3847.4 29191.0 29519.7 29572.9 30708.5 30753.2 3853.3 3938.3 3947.5 3969.3 3981.8 201668.0 201748.0 202053.0 202164.0 202392.0 52666.7 53910.0 56486.7 57933.7 59306.1 54285.5 54289.7 54609.2 54674.0 54701.5 11576.2 11648.8 11700.0 11700.9 11744.2 8354.7 8437.1 8444.2 8750.5 8963.8 19031.6 19108.4 19186.0 19223.5 19225.6 6784.0 7059.8 7138.4 7140.3 7188.3 941.5 1007.0 1007.8 1055.8 1069.0 27971.0 28217.9 28640.7 28881.7 29461.3 1014.1 1037.7 1073.6 1134.2 1155.3 13731.9 13837.5 13854.6 14061.1 14061.2 280912.0 281806.0 282716.0 283059.0 283919.0 49658.8 49821.0 50071.7 50148.7 50196.0 1268.5 1309.8 1322.8 1325.0 1332.3 27012.3 27151.3 27870.9 28019.7 28065.9 45328.8 45455.3 45662.3 45790.8 45896.5 269384.0 271886.0 271908.0 272010.0 272148.0 27771.0 31041.8 31290.0 31542.4 31694.7 35358.8 35968.0 36445.5 36819.3 36822.6 29173.6 30693.2 31316.2 31805.7 31880.8 27526.7 31690.2 31832.0 31905.8 32194.7 31829.1 32180.2 32229.0 32264.4 32288.7 30222.2 31008.0 31655.6 32478.8 32491.4 22576.8 23469.8 23518.0 24119.6 24124.8 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | [#2] jquery.html Cycles:180 Average:26360.90 Median:514462.00 stddev:82714.11 (16.1%) stddev-sans-first:82923.12 09:00:55 INFO - PROCESS | 27564 | Values: 366.7 366.8 367.8 369.0 378.4 13609.3 14013.6 16379.2 17296.7 18082.7 15622.5 15874.8 15887.4 16004.8 16689.8 4942.9 5107.8 5119.6 5120.5 5121.4 3767.7 3886.2 5078.4 5330.2 5529.9 5311.2 5511.7 5527.2 5537.3 5538.4 5494.1 5511.4 5565.5 5568.9 5577.6 5172.5 5347.9 5361.4 5379.2 5382.8 13110.0 13185.3 15022.9 20018.8 20131.0 2106.5 2142.3 2158.7 2171.7 2314.5 9519.8 9698.2 9779.2 9866.8 11153.8 1767.8 1798.2 1809.4 1831.4 1837.9 57075.0 57096.4 58483.0 58671.4 59275.0 9943.4 10131.8 10228.4 10252.9 10302.5 13644.8 13686.5 13692.1 13692.7 13704.5 6703.3 6731.7 6765.5 6806.7 6897.3 5993.3 6041.3 6049.6 6088.0 6201.2 4072.2 4482.6 4485.7 4543.7 4564.8 1691.8 1754.9 1781.7 1791.5 1803.1 913.4 924.5 933.0 941.8 994.7 13068.7 13872.4 14745.4 15146.8 15211.5 935.3 937.4 938.7 997.7 997.7 9255.5 9266.7 9516.4 9562.8 9612.7 495683.0 498275.0 505618.0 514357.0 514567.0 70403.0 71338.6 72338.6 72764.0 73583.9 1097.9 1108.9 1109.5 1111.9 1127.8 14183.9 14425.6 14480.7 14514.4 14755.0 33127.0 33306.5 33470.3 34060.3 34338.3 41959.6 42843.0 43294.0 44919.8 46661.3 7188.0 7454.0 7465.0 7483.0 7500.3 9647.5 10586.3 10699.1 10965.4 11201.9 9445.7 9519.6 9546.2 9751.2 9822.0 6656.9 9502.1 9526.9 9754.8 9932.5 8889.4 9079.8 9306.3 9435.9 9587.7 7311.0 7313.0 7359.5 7497.5 7552.1 7698.9 9407.8 9436.1 9535.4 9650.5 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | [#3] mootools.html Cycles:180 Average:5514.87 Median:6413.36 stddev:2836.42 (44.2%) stddev-sans-first:2827.00 09:00:55 INFO - PROCESS | 27564 | Values: 1338.3 1469.1 1474.5 1635.9 1802.4 6934.2 7541.1 7708.2 7734.3 7740.5 7549.2 7728.2 7733.1 7734.7 7734.8 2034.9 2070.3 2086.3 2376.5 2412.9 2071.7 2299.4 2348.1 2355.1 2362.4 2290.0 2301.6 2304.6 2305.4 2376.5 2287.2 2318.0 2324.6 2325.9 2332.2 2260.4 2272.0 2272.6 2274.5 2278.1 7823.6 7867.8 7895.9 7913.7 7917.8 4778.7 4917.8 4922.2 4927.7 4937.2 3162.8 3185.0 3286.4 3305.9 3308.3 1075.7 1110.0 1124.1 1129.4 1179.8 10938.7 10943.4 10953.2 10974.6 10991.3 4340.0 4387.9 4434.5 4459.1 4485.9 9370.8 9394.0 9397.8 9400.5 9401.8 4916.8 4918.4 4943.7 4951.1 4951.5 4451.7 4493.9 4519.3 4524.1 4525.8 3424.1 3501.4 3752.7 3812.9 3842.3 1194.6 1234.5 1239.4 1253.4 1253.4 1042.6 1043.3 1216.0 1301.2 1323.9 7116.0 7189.5 7207.4 7217.6 7221.0 1104.5 1124.9 1125.1 1142.1 1148.2 5733.5 5821.2 5830.9 5832.1 5839.6 9417.7 9435.2 9526.1 9653.3 9654.8 9404.7 9500.2 9550.0 9559.8 9562.7 7183.8 7305.1 7311.9 7328.9 7426.2 7137.6 7159.1 7183.4 7188.6 7199.5 8187.6 8397.5 8491.9 8629.1 8644.7 8566.5 8715.7 8736.7 8809.8 8830.6 6927.6 7032.5 7041.6 7045.0 7051.9 6470.0 6644.8 7136.3 7430.1 7494.9 6989.0 7036.4 7099.1 7120.6 7156.1 6794.6 6904.5 6968.5 7082.2 7090.3 6728.3 6753.0 6791.5 6791.8 6797.4 6356.7 6489.1 6501.0 6579.2 6635.3 6622.9 6662.2 6668.0 6677.9 6679.2 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | [#4] prototype.html Cycles:180 Average:5171.47 Median:5858.12 stddev:1543.99 (26.4%) stddev-sans-first:1505.05 09:00:55 INFO - PROCESS | 27564 | Values: 335.6 342.9 351.5 353.2 357.8 5679.5 5789.1 5792.6 5799.9 5828.7 5589.9 5692.4 5701.3 5713.1 5738.9 4539.0 4542.1 4546.4 4549.6 4556.0 4328.3 4408.5 4420.8 4431.7 4544.7 4442.4 4473.5 4478.7 4480.2 4499.8 4505.8 4507.6 4514.1 4515.0 4519.2 3997.4 3998.1 4007.7 4013.0 4015.7 5396.3 5522.2 5523.6 5525.4 5539.6 5128.3 5156.5 5163.6 5165.4 5165.7 5852.8 6166.9 6172.6 6213.6 6234.8 4196.5 4221.5 4307.7 4310.9 4316.1 6306.7 6350.7 6361.7 6370.3 6373.1 4402.7 4403.5 4406.4 4407.8 4412.2 4353.1 4456.1 4461.4 4467.1 4478.5 5116.7 5151.5 5153.8 5156.8 5158.8 6121.2 6182.8 6184.3 6190.3 6190.8 1563.4 1588.6 1591.2 1591.6 1592.4 1065.1 1072.0 1073.3 1073.4 1099.5 5863.4 5863.6 5871.9 5872.1 5876.8 6324.4 6326.5 6334.9 6339.8 6340.8 5870.2 5879.8 5885.8 5888.1 5888.9 3311.9 3431.4 3432.4 3434.5 3438.7 6555.1 6591.8 6592.8 6593.0 6595.4 6448.9 6458.4 6466.8 6478.7 6480.9 6480.3 6592.8 6633.3 6639.7 6640.0 6205.9 6340.9 6377.3 6404.9 6429.9 6216.3 6325.5 6332.3 6334.7 6356.1 6676.1 6681.9 6684.6 6686.5 6692.6 4325.0 4420.9 4452.5 4452.6 4461.1 6314.8 6363.7 6367.3 6367.9 6370.8 6199.2 6203.8 6205.0 6206.3 6213.8 6055.8 6182.1 6186.3 6188.2 6189.2 6100.6 6132.9 6158.9 6159.8 6161.8 6288.5 6297.1 6298.5 6304.8 6309.9 5903.3 6098.6 6110.7 6115.9 6117.2 09:00:55 INFO - PROCESS | 27564 | 09:00:55 INFO - PROCESS | 27564 | [#5] yui.html Cycles:180 Average:13222.06 Median:23757.63 stddev:15288.02 (64.3%) stddev-sans-first:15302.29 09:00:55 INFO - PROCESS | 27564 | Values: 766.8 851.2 869.5 870.7 898.2 13310.4 13402.5 13461.0 13464.9 13544.6 11209.9 12696.7 12878.9 12891.4 12895.2 665.1 793.9 812.4 813.7 814.4 792.5 796.7 800.4 800.7 801.1 692.8 706.8 856.3 857.1 858.4 809.4 819.4 824.2 824.7 826.3 608.9 609.5 610.2 610.2 610.5 12305.2 12327.6 12351.3 12363.7 12369.2 11578.7 11752.9 11934.9 12001.9 12056.6 10636.1 10652.0 10669.4 10686.1 11062.2 3582.1 3676.7 3718.1 3723.7 3790.7 46318.3 47037.5 48890.0 48956.8 48989.3 10083.6 10271.7 10294.7 10334.5 10428.8 17948.3 17967.9 17972.1 17977.2 18027.5 7245.3 7340.3 7437.4 7469.2 7537.2 4293.9 4296.4 4301.7 4324.8 4393.0 2937.8 2964.5 2969.9 2972.2 2977.0 552.1 566.6 568.6 570.1 577.4 477.7 501.3 509.1 552.7 657.9 8049.8 8486.8 8646.0 8651.2 8661.0 537.7 544.6 546.0 583.5 584.2 3790.6 3799.4 3890.8 3922.7 4129.4 54688.5 56679.4 56873.7 56896.0 56938.4 48276.3 48943.5 48974.5 49103.5 49529.8 43069.4 43404.6 43766.0 44114.3 44792.6 8064.9 8146.2 8175.4 8220.9 8259.9 31583.0 31713.7 32474.0 32629.2 32658.2 37967.4 38361.4 41456.6 42326.2 42556.0 9794.1 9804.1 10036.7 10092.2 10157.7 10989.4 10995.7 11164.0 11257.5 11553.3 10335.5 10468.4 10597.8 10695.9 11075.4 10601.9 10776.8 10850.6 10935.6 11325.8 9019.8 9702.3 9718.1 9730.0 10648.9 9141.8 9401.1 9485.2 9699.5 9839.2 9495.2 9561.7 9580.3 9588.0 9626.0 09:00:55 INFO - PROCESS | 27564 | -------- Summary: end -------- 09:00:55 INFO - PROCESS | 27564 | 09:00:56 INFO - TEST-INFO | 27564: exit 0 09:00:56 INFO - TEST-OK | dromaeo_css | took 1112329ms 09:00:56 INFO - TEST-START | kraken 09:00:56 INFO - operating with platform_type : linux_ 09:00:56 INFO - Initialising browser for kraken test... 09:00:56 INFO - TEST-INFO | started process 27763 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJSBXyv/profile http://localhost:57209/getInfo.html) 09:00:59 INFO - PROCESS | 27763 | __metrics Screen width/height:1600/1200 09:00:59 INFO - PROCESS | 27763 | colorDepth:24 09:00:59 INFO - PROCESS | 27763 | Browser inner width/height: 1024/697 09:00:59 INFO - PROCESS | 27763 | __metrics 09:00:59 INFO - PROCESS | 27763 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:01:00 INFO - PROCESS | 27763 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:01 INFO - TEST-INFO | 27763: exit 0 09:01:01 INFO - Browser initialized. 09:01:01 INFO - Running cycle 1/1 for kraken test... 09:01:01 INFO - TEST-INFO | started process 27842 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJSBXyv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:12 INFO - PROCESS | 27842 | RSS: Main: 149544960 09:01:12 INFO - PROCESS | 27842 | 09:01:15 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:16 INFO - PROCESS | 27842 | RSS: Main: 185827328 09:01:16 INFO - PROCESS | 27842 | 09:01:18 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-dft) 09:01:19 INFO - PROCESS | 27842 | RSS: Main: 177545216 09:01:19 INFO - PROCESS | 27842 | 09:01:22 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-fft) 09:01:22 INFO - PROCESS | 27842 | RSS: Main: 161320960 09:01:22 INFO - PROCESS | 27842 | 09:01:24 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57209/tests/kraken/driver.html?testName=audio-oscillator) 09:01:25 INFO - PROCESS | 27842 | RSS: Main: 163848192 09:01:25 INFO - PROCESS | 27842 | 09:01:27 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:28 INFO - PROCESS | 27842 | RSS: Main: 163233792 09:01:28 INFO - PROCESS | 27842 | 09:01:30 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57209/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:31 INFO - PROCESS | 27842 | RSS: Main: 165900288 09:01:31 INFO - PROCESS | 27842 | 09:01:34 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57209/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:35 INFO - PROCESS | 27842 | RSS: Main: 167088128 09:01:35 INFO - PROCESS | 27842 | 09:01:38 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57209/tests/kraken/driver.html?testName=json-parse-financial) 09:01:38 INFO - PROCESS | 27842 | RSS: Main: 167616512 09:01:38 INFO - PROCESS | 27842 | 09:01:40 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:40 INFO - PROCESS | 27842 | RSS: Main: 179884032 09:01:40 INFO - PROCESS | 27842 | 09:01:42 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:43 INFO - PROCESS | 27842 | RSS: Main: 178339840 09:01:43 INFO - PROCESS | 27842 | 09:01:45 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:45 INFO - PROCESS | 27842 | RSS: Main: 188035072 09:01:45 INFO - PROCESS | 27842 | 09:01:48 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:48 INFO - PROCESS | 27842 | RSS: Main: 196730880 09:01:48 INFO - PROCESS | 27842 | 09:01:51 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:52 INFO - PROCESS | 27842 | RSS: Main: 195436544 09:01:52 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | Cycle 1(1): loaded http://localhost:57209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57209/tests/kraken/driver.html?testName=ai-astar) 09:01:53 INFO - PROCESS | 27842 | RSS: Main: 254005248 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | __start_tp_report 09:01:53 INFO - PROCESS | 27842 | _x_x_mozilla_page_load 09:01:53 INFO - PROCESS | 27842 | _x_x_mozilla_page_load_details 09:01:53 INFO - PROCESS | 27842 | |i|pagename|runs| 09:01:53 INFO - PROCESS | 27842 | |0;ai-astar;112;110;106;111;110;112;111;112;104;110 09:01:53 INFO - PROCESS | 27842 | |1;audio-beat-detection;154;126;153;166;129;152;153;129;167;128 09:01:53 INFO - PROCESS | 27842 | |2;audio-dft;164;161;161;160;171;160;160;160;165;162 09:01:53 INFO - PROCESS | 27842 | |3;audio-fft;73;73;96;97;72;72;74;119;97;73 09:01:53 INFO - PROCESS | 27842 | |4;audio-oscillator;97;97;140;97;96;95;141;97;97;138 09:01:53 INFO - PROCESS | 27842 | |5;imaging-gaussian-blur;109;109;110;109;110;110;110;109;110;109 09:01:53 INFO - PROCESS | 27842 | |6;imaging-darkroom;146;146;146;146;146;148;147;148;147;148 09:01:53 INFO - PROCESS | 27842 | |7;imaging-desaturate;95;98;96;96;97;96;95;96;96;95 09:01:53 INFO - PROCESS | 27842 | |8;json-parse-financial;58;57;57;56;56;57;57;57;61;56 09:01:53 INFO - PROCESS | 27842 | |9;json-stringify-tinderbox;68;68;68;69;69;69;67;68;68;68 09:01:53 INFO - PROCESS | 27842 | |10;stanford-crypto-aes;82;81;82;83;83;82;83;85;83;85 09:01:53 INFO - PROCESS | 27842 | |11;stanford-crypto-ccm;122;119;115;119;126;121;129;122;122;135 09:01:53 INFO - PROCESS | 27842 | |12;stanford-crypto-pbkdf2;150;135;144;146;146;135;148;148;145;150 09:01:53 INFO - PROCESS | 27842 | |13;stanford-crypto-sha256-iterative;68;68;69;67;67;66;71;69;67;70 09:01:53 INFO - PROCESS | 27842 | __end_tp_report 09:01:53 INFO - PROCESS | 27842 | __start_cc_report 09:01:53 INFO - PROCESS | 27842 | _x_x_mozilla_cycle_collect,907 09:01:53 INFO - PROCESS | 27842 | __end_cc_report 09:01:53 INFO - PROCESS | 27842 | __startTimestamp1453395713983__endTimestamp 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | ------- Summary: start ------- 09:01:53 INFO - PROCESS | 27842 | Number of tests: 14 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.70 (2.4%) stddev-sans-first:2.74 09:01:53 INFO - PROCESS | 27842 | Values: 112.0 110.0 106.0 111.0 110.0 112.0 111.0 112.0 104.0 110.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:153.00 stddev:16.12 (10.5%) stddev-sans-first:16.82 09:01:53 INFO - PROCESS | 27842 | Values: 154.0 126.0 153.0 166.0 129.0 152.0 153.0 129.0 167.0 128.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#2] audio-dft Cycles:10 Average:162.40 Median:161.50 stddev:3.50 (2.2%) stddev-sans-first:3.67 09:01:53 INFO - PROCESS | 27842 | Values: 164.0 161.0 161.0 160.0 171.0 160.0 160.0 160.0 165.0 162.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#3] audio-fft Cycles:10 Average:84.60 Median:73.50 stddev:16.51 (22.5%) stddev-sans-first:16.97 09:01:53 INFO - PROCESS | 27842 | Values: 73.0 73.0 96.0 97.0 72.0 72.0 74.0 119.0 97.0 73.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:97.00 stddev:20.84 (21.5%) stddev-sans-first:21.61 09:01:53 INFO - PROCESS | 27842 | Values: 97.0 97.0 140.0 97.0 96.0 95.0 141.0 97.0 97.0 138.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:01:53 INFO - PROCESS | 27842 | Values: 109.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 09:01:53 INFO - PROCESS | 27842 | Values: 146.0 146.0 146.0 146.0 146.0 148.0 147.0 148.0 147.0 148.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 09:01:53 INFO - PROCESS | 27842 | Values: 95.0 98.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 95.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.48 (2.6%) stddev-sans-first:1.54 09:01:53 INFO - PROCESS | 27842 | Values: 58.0 57.0 57.0 56.0 56.0 57.0 57.0 57.0 61.0 56.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 09:01:53 INFO - PROCESS | 27842 | Values: 68.0 68.0 68.0 69.0 69.0 69.0 67.0 68.0 68.0 68.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.29 (1.6%) stddev-sans-first:1.32 09:01:53 INFO - PROCESS | 27842 | Values: 82.0 81.0 82.0 83.0 83.0 82.0 83.0 85.0 83.0 85.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:122.00 stddev:5.70 (4.7%) stddev-sans-first:6.03 09:01:53 INFO - PROCESS | 27842 | Values: 122.0 119.0 115.0 119.0 126.0 121.0 129.0 122.0 122.0 135.0 09:01:53 INFO - PROCESS | 27842 | 09:01:53 INFO - PROCESS | 27842 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:147.00 stddev:5.48 (3.7%) stddev-sans-first:5.46 09:01:53 INFO - PROCESS | 27842 | Values: 150.0 135.0 144.0 146.0 146.0 135.0 148.0 148.0 145.0 150.0 09:01:53 INFO - PROCESS | 27842 | 09:01:54 INFO - PROCESS | 27842 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.55 (2.3%) stddev-sans-first:1.64 09:01:54 INFO - PROCESS | 27842 | Values: 68.0 68.0 69.0 67.0 67.0 66.0 71.0 69.0 67.0 70.0 09:01:54 INFO - PROCESS | 27842 | -------- Summary: end -------- 09:01:54 INFO - PROCESS | 27842 | 09:01:54 INFO - TEST-INFO | 27842: exit 0 09:01:54 INFO - TEST-OK | kraken | took 58891ms 09:01:54 INFO - TEST-START | v8_7 09:01:54 INFO - operating with platform_type : linux_ 09:01:54 INFO - Initialising browser for v8_7 test... 09:01:54 INFO - TEST-INFO | started process 28093 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBvr8ho/profile http://localhost:57209/getInfo.html) 09:01:58 INFO - PROCESS | 28093 | __metrics Screen width/height:1600/1200 09:01:58 INFO - PROCESS | 28093 | colorDepth:24 09:01:58 INFO - PROCESS | 28093 | Browser inner width/height: 1024/697 09:01:58 INFO - PROCESS | 28093 | __metrics 09:01:58 INFO - PROCESS | 28093 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:01:58 INFO - PROCESS | 28093 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:59 INFO - TEST-INFO | 28093: exit 0 09:01:59 INFO - Browser initialized. 09:01:59 INFO - Running cycle 1/1 for v8_7 test... 09:01:59 INFO - TEST-INFO | started process 28176 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBvr8ho/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:11 INFO - PROCESS | 28176 | RSS: Main: 149663744 09:02:11 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | Cycle 1(1): loaded http://localhost:57209/tests/v8_7/run.html (next: http://localhost:57209/tests/v8_7/run.html) 09:02:34 INFO - PROCESS | 28176 | RSS: Main: 555364352 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | __start_tp_report 09:02:34 INFO - PROCESS | 28176 | _x_x_mozilla_page_load 09:02:34 INFO - PROCESS | 28176 | _x_x_mozilla_page_load_details 09:02:34 INFO - PROCESS | 28176 | |i|pagename|runs| 09:02:34 INFO - PROCESS | 28176 | |0;Richards;167.0564650851988 09:02:34 INFO - PROCESS | 28176 | |1;DeltaBlue;188.82175226586102 09:02:34 INFO - PROCESS | 28176 | |2;Encrypt;282.4060999717594 09:02:34 INFO - PROCESS | 28176 | |3;Decrypt;5251.308900523561 09:02:34 INFO - PROCESS | 28176 | |4;RayTrace;1976.2845849802372 09:02:34 INFO - PROCESS | 28176 | |5;Earley;790.6793048973144 09:02:34 INFO - PROCESS | 28176 | |6;Boyer;12395.061728395061 09:02:34 INFO - PROCESS | 28176 | |7;RegExp;43229.166666666664 09:02:34 INFO - PROCESS | 28176 | |8;Splay;597.7286312014345 09:02:34 INFO - PROCESS | 28176 | |9;NavierStokes;4835.748792270531 09:02:34 INFO - PROCESS | 28176 | __end_tp_report 09:02:34 INFO - PROCESS | 28176 | __startTimestamp1453395754402__endTimestamp 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | ------- Summary: start ------- 09:02:34 INFO - PROCESS | 28176 | Number of tests: 10 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#0] Richards Cycles:1 Average:167.06 Median:167.06 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 167.1 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#1] DeltaBlue Cycles:1 Average:188.82 Median:188.82 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 188.8 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#2] Encrypt Cycles:1 Average:282.41 Median:282.41 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 282.4 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 5251.3 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 1976.3 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#5] Earley Cycles:1 Average:790.68 Median:790.68 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 790.7 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 12395.1 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#7] RegExp Cycles:1 Average:43229.17 Median:43229.17 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 43229.2 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#8] Splay Cycles:1 Average:597.73 Median:597.73 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 597.7 09:02:34 INFO - PROCESS | 28176 | 09:02:34 INFO - PROCESS | 28176 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 09:02:34 INFO - PROCESS | 28176 | Values: 4835.7 09:02:34 INFO - PROCESS | 28176 | -------- Summary: end -------- 09:02:34 INFO - PROCESS | 28176 | 09:02:35 INFO - TEST-INFO | 28176: exit 0 09:02:35 INFO - TEST-OK | v8_7 | took 40402ms 09:02:35 INFO - SUITE-END | took 1211s 09:02:35 INFO - Completed test suite (00:20:11) 09:02:35 INFO - Working with test: dromaeo_css 09:02:35 INFO - Generating results file: dromaeo_css 09:02:35 INFO - Working with test: kraken 09:02:35 INFO - Generating results file: kraken 09:02:35 INFO - javascript benchmark 09:02:35 INFO - Working with test: v8_7 09:02:35 INFO - Generating results file: v8_7 09:02:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:02:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 09:02:35 INFO - process_Request line: dromaeo_css 6709.13 graph.html#tests=[[72,64,35]] 09:02:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:02:35 INFO - process_Request line: kraken 1508.50 graph.html#tests=[[232,64,35]] 09:02:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:02:35 INFO - process_Request line: v8_7 18823.60 graph.html#tests=[[230,64,35]] 09:02:35 INFO - RETURN: dromaeo_css: 6709.13 09:02:35 INFO - RETURN: kraken: 1508.50 09:02:35 INFO - RETURN: v8_7: 18823.60 09:02:35 INFO - javascript benchmark 09:02:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3131.185891668166, 3133.4359815233247, 3193.9041828745144, 3194.0737186215997, 3228.338190670913, 5021.64848460607, 5114.360704911886, 5174.948250517494, 5179.430262671108, 5223.895522089556, 5105.872353191172, 5156.432792392834, 5213.087709650815, 5221.7389130543415, 5226.973865130669, 4559.156556037144, 4680.555347242023, 4730.574248317659, 4800.663953523254, 4840.225563909775, 4656.790444429992, 4795.520447955211, 4803.087413391462, 4812.23004319309, 4902.534259245366, 4696.600788932945, 4752.667313288071, 4759.976200119012, 4773.928391074137, 4784.138855006097, 4747.45404278509, 4760.476347601761, 4763.118823017753, 4784.162771514971, 4831.371921650198, 4730.526947305277, 4751.881202969919, 4763.69036012658, 4767.952320476786, 4815.0610630926985, 5005.199168133117, 5020.121478741242, 5030.522100400456, 5044.646874718771, 5118.4625614310335, 5643.068893632546, 5645.125005624135, 5650.208970744099, 5670.0, 5692.117721753135, 5692.943070569283, 5695.174199741055, 5696.3733989261145, 5701.116326969326, 5708.229389032469, 5176.249443830661, 5236.1098613235845, 5248.947510524922, 5251.2123181523075, 5317.760700768436, 5737.684427356536, 5757.596968212269, 5757.712114394263, 5759.51044161251, 5765.711714414262, 5441.782328706808, 5544.3088220700765, 5560.916586251128, 5569.805056822992, 5605.187247849039, 5544.61187716856, 5606.6916319602815, 5610.07433773431, 5628.971855140698, 5675.8864822704145, 5572.164175373727, 5578.721063946868, 5579.721013949286, 5580.162975553618, 5581.525570326487, 5570.275864137717, 5574.358948720949, 5576.832695019156, 5577.0, 5579.609427340048, 4273.294906340419, 4305.84929527465, 4346.956530434719, 4368.126374725068, 4393.0774537347515, 3842.9423558646645, 3849.4610754494392, 3849.6920246380223, 3882.378819388884, 3891.747036442622, 5103.795848166032, 5105.336306280234, 5106.66806657566, 5107.412647545506, 5123.538881500683, 5470.589705772083, 5530.5022547970875, 5573.27547418833, 5584.776608935678, 5651.576131790132, 5097.6941383517105, 5109.591232701375, 5111.207762796773, 5115.462876397924, 5117.795288188505, 4683.5082316356975, 4701.106789710013, 4701.976490117528, 4722.386089808303, 4769.2130798417875, 5697.974364614409, 5711.428857114339, 5730.914036289376, 5779.306483222041, 5827.24245848037, 5485.780568777363, 5492.313460817398, 5495.642783219078, 5500.642458240201, 5509.917351239815, 5664.716764161693, 5711.685857277889, 5717.685527296038, 5729.427057294237, 5747.224124743273, 5524.06090964529, 5536.750846211849, 5570.554355651457, 5574.0, 5610.18652295423, 5597.188407680945, 5615.157726341082, 5624.437556244343, 5626.24045753818, 5631.662100273997, 5262.526372626482, 5371.033214021358, 5480.068388373907, 5495.038368285614, 5537.501624853782, 5386.380566234933, 5456.781728730965, 5459.590530710133, 5465.890682186414, 5501.807436739855, 5364.168553874156, 5369.0, 5407.945920540744, 5409.78360865561, 5467.72661366938, 5369.946300536944, 5398.3791863934575, 5444.128939369682, 5474.863128421662, 5501.724913754216, 5340.359156901197, 5399.649022813504, 5402.59480538969, 5407.324084489439, 5422.48486393792], "unit": "score", "name": "dojo.html", "value": 5145.527258895119}, {"lowerIsBetter": false, "replicates": [529.4784637132424, 548.5858177076307, 558.7485631465842, 560.0283508113422, 573.5440324941671, 26717.198484045486, 27441.451170976594, 35869.641303586955, 35965.0, 36076.45885311723, 38779.80610096952, 39226.8038659807, 39247.41128883069, 39376.0, 39442.408363874565, 7697.34572561333, 7787.415943804237, 7839.568823714693, 7851.0578730552415, 7858.253465920729, 8703.912960870373, 8855.468671879675, 8859.246964008067, 8865.601047952858, 8870.778230544223, 8768.649254029831, 8823.426477278956, 8852.955735221314, 8885.155910188554, 8886.244669203126, 8737.0, 8790.033096359395, 8813.867791983126, 8814.382993190478, 8827.867581986275, 8633.913660863436, 8705.042445331008, 8745.737627871174, 8771.605277762515, 8773.078826723166, 37769.43345849787, 38359.23281534354, 38369.80815095935, 38389.232215355536, 38411.807940960396, 3300.339932013607, 3369.0903456066726, 3581.5164952731307, 3799.696024318048, 3847.442120892455, 29191.0, 29519.70480295191, 29572.8521357394, 30708.53937190944, 30753.231169220948, 3853.3064048471265, 3938.251732170907, 3947.4670919426085, 3969.28552860485, 3981.7810020448865, 201668.0, 201747.99126004422, 202053.0, 202164.0, 202392.0, 52666.73666631642, 53910.0, 56486.71756641273, 57933.71033144807, 59306.110408343906, 54285.45714542883, 54289.72855135699, 54609.180862287096, 54674.0, 54701.45298547043, 11576.24754390962, 11648.767024659459, 11700.0, 11700.88299117015, 11744.236624619543, 8354.707585234488, 8437.114103019218, 8444.240018398374, 8750.47497150173, 8963.775905602412, 19031.619367612846, 19108.42674719733, 19186.0, 19223.51941201453, 19225.615487690167, 6784.0, 7059.788206353817, 7138.428925685933, 7140.321669441395, 7188.281171882874, 941.5480569326761, 1007.0332480818496, 1007.7984403119406, 1055.8257887448638, 1068.9786204275872, 27971.0, 28217.858910705316, 28640.713592863805, 28881.71118288832, 29461.26346841303, 1014.0822555587206, 1037.6835065305154, 1073.6456969200144, 1134.177721152158, 1155.260633194756, 13731.862681373259, 13837.515686950908, 13854.584362469142, 14061.08602940826, 14061.226632535105, 280912.0, 281806.0, 282716.0, 283059.0, 283919.0, 49658.75170624196, 49821.0, 50071.74964125229, 50148.74925625348, 50196.0, 1268.4989429175423, 1309.7904335306496, 1322.761902857495, 1325.0393464737795, 1332.2872263339068, 27012.32469188286, 27151.321216968943, 27870.86064569664, 28019.719802801712, 28065.85967070233, 45328.77335613301, 45455.31817022681, 45662.31506527471, 45790.77104614589, 45896.54103458922, 269384.0, 271886.0, 271908.0, 272010.0, 272148.0, 27771.0, 31041.844790776806, 31290.0, 31542.369152617277, 31694.683053170094, 35358.823205883804, 35968.0, 36445.45331819972, 36819.263614728094, 36822.631773682995, 29173.562396563644, 30693.23266918345, 31316.217094572818, 31805.681943181196, 31880.84059579687, 27526.724732752416, 31690.20774480564, 31832.0, 31905.8404707975, 32194.678053220105, 31829.135377816106, 32180.19549511187, 32229.0, 32264.35471290514, 32288.67711322857, 30222.244443889078, 31008.0, 31655.643651141738, 32478.83760581182, 32491.35017299688, 22576.774232258125, 23469.76530234744, 23518.0, 24119.638205427284, 24124.75875241225], "unit": "score", "name": "ext.html", "value": 17226.056900367636}, {"lowerIsBetter": false, "replicates": [366.7048026338797, 366.7964279824696, 367.7921974084642, 368.9778613283202, 378.36057063562595, 13609.319534023283, 14013.649658758537, 16379.18104094795, 17296.74054889176, 18082.728759068625, 15622.453214137508, 15874.84125158748, 15887.36450541977, 16004.75992860108, 16689.83310166901, 4942.901141977167, 5107.846764597068, 5119.616028797836, 5120.539151476366, 5121.359830021247, 3767.7362584619086, 3886.203328317688, 5078.4413714491375, 5330.227117068022, 5529.917051244234, 5311.2298716686055, 5511.696856672901, 5527.198556209347, 5537.307836520435, 5538.363088244863, 5494.09347457669, 5511.421300763443, 5565.499105080562, 5568.888622227553, 5577.581681373873, 5172.5344718975475, 5347.946520534783, 5361.356637203521, 5379.220013098079, 5382.838514844561, 13110.0, 13185.274809885452, 15022.924885375613, 20018.799812001984, 20131.0, 2106.4628519727526, 2142.2502124256544, 2158.665406861939, 2171.695962565242, 2314.5139520700673, 9519.809603807886, 9698.224142068617, 9779.168770654504, 9866.753331166707, 11153.776924461465, 1767.7525146479504, 1798.1818272686028, 1809.4390738870993, 1831.359024341483, 1837.9081045947783, 57074.999999999585, 57096.42903570952, 58483.0, 58671.41328586702, 59275.0, 9943.353682010646, 10131.848022279672, 10228.386296822215, 10252.948735256425, 10302.536385862653, 13644.795328070088, 13686.452541898412, 13692.110012849333, 13692.65768355779, 13704.52034178799, 6703.262641109474, 6731.697073631698, 6765.492588055916, 6806.659667016629, 6897.3447522485285, 5993.340732519419, 6041.2750469943885, 6049.637021778707, 6087.969560152171, 6201.193844800147, 4072.205919845602, 4482.618977386894, 4485.6860019798305, 4543.704659197141, 4564.794584243717, 1691.7716108325465, 1754.9473515794546, 1781.7260658629143, 1791.480470663519, 1803.1344954421952, 913.4062859141611, 924.4776701163821, 932.9953350233205, 941.75985123793, 994.683758135846, 13068.738625227443, 13872.393557248095, 14745.410183592536, 15146.772798408032, 15211.543653690185, 935.3218916285774, 937.4094320578129, 938.7324612485409, 997.6558087459815, 997.7106639074588, 9255.490947997925, 9266.675666351646, 9516.38143520669, 9562.760930976781, 9612.663556775618, 495683.0, 498275.0, 505618.0, 514357.0, 514567.0, 70403.0, 71338.64330678314, 72338.63830680813, 72764.0, 73583.89624155642, 1097.8572785537829, 1108.9057430118369, 1109.522905150793, 1111.8888111188978, 1127.7800828838463, 14183.858161418666, 14425.567232983027, 14480.710385792014, 14514.419423222953, 14755.0, 33127.0, 33306.5004024935, 33470.330593388484, 34060.31879362449, 34338.31323373468, 41959.58040419557, 42843.0, 43294.0, 44919.77540112279, 46661.30008049814, 7187.9640601796655, 7453.962730186315, 7465.021769231266, 7482.96258518704, 7500.287472690085, 9647.517624118906, 10586.311889727143, 10699.090577301016, 10965.396903170402, 11201.887981120084, 9445.716628501155, 9519.571619277287, 9546.18857397129, 9751.219902407933, 9821.950890245504, 6656.866862662623, 9502.097300756417, 9526.85709714341, 9754.756131096496, 9932.453715045742, 8889.422187557788, 9079.818403631758, 9306.255499559884, 9435.905640943778, 9587.664431744855, 7310.96344518274, 7312.986890315174, 7359.521631093961, 7497.475176737576, 7552.13150487679, 7698.8845167321415, 9407.811843763224, 9436.056394360508, 9535.38020028696, 9650.517474126125], "unit": "score", "name": "jquery.html", "value": 7969.701803965962}, {"lowerIsBetter": false, "replicates": [1338.2973938682196, 1469.0598017268949, 1474.498670452046, 1635.9018458892467, 1802.3871883559586, 6934.202566704824, 7541.09506859177, 7708.2291770822885, 7734.342580880632, 7740.496867703595, 7549.245075492448, 7728.227177282269, 7733.0720313562315, 7734.6906123755125, 7734.8453030939345, 2034.888081155536, 2070.3064473401428, 2086.2802333195023, 2376.5009348036933, 2412.9396765080837, 2071.6892466130053, 2299.4481324482085, 2348.0842471436154, 2355.057976809273, 2362.385779697274, 2290.0, 2301.608726516496, 2304.608216603173, 2305.4121199094207, 2376.4771750215014, 2287.1994801819396, 2317.965230521535, 2324.6048171810835, 2325.860448373086, 2332.2070496031347, 2260.400993736661, 2271.965920511177, 2272.6363781794835, 2274.5450909817937, 2278.1456953642382, 7823.647935842901, 7867.803304917423, 7895.881561776578, 7913.723019694341, 7917.802054948615, 4778.737169455679, 4917.8278760243575, 4922.163232250526, 4927.6550641455115, 4937.210046392596, 3162.778605497616, 3185.0, 3286.4413049781597, 3305.8512366943305, 3308.2556424804466, 1075.7095584192302, 1109.9889001110048, 1124.0951034417292, 1129.3675541696593, 1179.7935361311822, 10938.726531836688, 10943.398113103776, 10953.233273670847, 10974.561017559288, 10991.285566438077, 4340.0, 4387.912241755147, 4434.512203657595, 4459.063596644676, 4485.910281794346, 9370.765730856783, 9394.0, 9397.765055873659, 9400.482973436527, 9401.811963760687, 4916.778744956486, 4918.385201849769, 4943.72809495474, 4951.059298733301, 4951.455339912607, 4451.666125040635, 4493.865184044484, 4519.276915693474, 4524.117797029613, 4525.818967241339, 3424.092615456906, 3501.4222653262436, 3752.7185461090526, 3812.942805857914, 3842.3275926712713, 1194.5639841457805, 1234.4876876096318, 1239.4112796421628, 1253.385840937952, 1253.4296894912793, 1042.6090216168936, 1043.3218408034838, 1215.9696007599705, 1301.1997621462733, 1323.8874695650977, 7116.039334689751, 7189.532680375759, 7207.387372073327, 7217.6030318333, 7220.963895180491, 1104.5029736618394, 1124.8706398764248, 1125.1167833250859, 1142.097742783192, 1148.2019996102795, 5733.483986441241, 5821.15593238978, 5830.912536311958, 5832.125181222766, 5839.591228613956, 9417.670381536751, 9435.198008169382, 9526.095020973135, 9653.324267301221, 9654.75863103428, 9404.717858464257, 9500.19248363883, 9549.952250238843, 9559.761005974768, 9562.713118606453, 7183.820404489825, 7305.1233851938105, 7311.926880731125, 7328.926710732824, 7426.220246874109, 7137.643117843983, 7159.140903091662, 7183.353498185188, 7188.568685878864, 7199.460040497089, 8187.631556580087, 8397.454165479225, 8491.8726219108, 8629.09394513567, 8644.697435589724, 8566.52884091381, 8715.738527844174, 8736.694215702673, 8809.823803524021, 8830.646774128963, 6927.618980955895, 7032.472564557576, 7041.647917603997, 7045.013698082375, 7051.894221586783, 6470.0, 6644.767433139817, 7136.3220494052985, 7430.071241094864, 7494.887576686463, 6989.0, 7036.366726994595, 7099.07711997437, 7120.643967801486, 7156.069710937545, 6794.558353706993, 6904.516683832084, 6968.477364197807, 7082.220955694766, 7090.255523169993, 6728.3271672832325, 6753.0, 6791.490638202254, 6791.762288319885, 6797.388235058868, 6356.713947872265, 6489.091527186103, 6501.0, 6579.243387010555, 6635.303293154342, 6622.867542649216, 6662.167229096363, 6668.0331351954665, 6677.9332206679255, 6679.198496180489], "unit": "score", "name": "mootools.html", "value": 4553.111763277089}, {"lowerIsBetter": false, "replicates": [335.57382124701627, 342.939985502537, 351.5447495493336, 353.16124205013085, 357.79963220596466, 5679.488846003869, 5789.073748200289, 5792.623479473837, 5799.913001304979, 5828.650280983139, 5589.944100558993, 5692.402297758737, 5701.34434540028, 5713.085906255, 5738.942610573903, 4539.00141968768, 4542.114287713881, 4546.386237857896, 4549.567791059844, 4556.04323092151, 4328.3074708046715, 4408.493023302313, 4420.756858372788, 4431.711938723973, 4544.681872268942, 4442.3558584005295, 4473.463184417875, 4478.731276123443, 4480.238359478896, 4499.842505512308, 4505.752183629899, 4507.616852567536, 4514.097180563867, 4514.954850451486, 4519.231730605805, 3997.360422332413, 3998.1204135090525, 4007.7394969327192, 4013.036871150932, 4015.6988225882883, 5396.325459317585, 5522.22688823565, 5523.558115350762, 5525.4474552544825, 5539.639923405006, 5128.333316668846, 5156.458571849939, 5163.561097306733, 5165.354330708661, 5165.690058596496, 5852.795152169696, 6166.938330616681, 6172.567920245585, 6213.56505044647, 6234.750609975596, 4196.51740049892, 4221.472315960505, 4307.719998200107, 4310.892227694333, 4316.072044510414, 6306.716197771111, 6350.745970161188, 6361.713722882481, 6370.299267080663, 6373.075903993941, 4402.713823601455, 4403.515613282536, 4406.427164468599, 4407.845725399596, 4412.205802955499, 4353.10761293934, 4456.131054444417, 4461.375407442961, 4467.12890986261, 4478.529754375743, 5116.718580478035, 5151.510606492452, 5153.845384638467, 5156.767945442464, 5158.767855446514, 6121.234845644294, 6182.783602573888, 6184.257889053342, 6190.288116866618, 6190.81427557174, 1563.4215340324154, 1588.6187315044306, 1591.2123498868134, 1591.6498370358502, 1592.418767149982, 1065.0893486069454, 1072.0405237312561, 1073.3452593917705, 1073.4310815267763, 1099.5491848342142, 5863.442972917651, 5863.589548731547, 5871.915470008085, 5872.148538461899, 5876.764929402776, 6324.3991820776955, 6326.49388048955, 6334.873302534015, 6339.841503962438, 6340.809775706736, 5870.178175055496, 5879.794207202727, 5885.764569417261, 5888.116782482662, 5888.882222355614, 3311.850966706504, 3431.3995050865997, 3432.3993301172195, 3434.4504879219203, 3438.7249020078334, 6555.147830781968, 6591.83520411984, 6592.813293607197, 6592.967035164794, 6595.373439523238, 6448.9355106449275, 6458.38645328693, 6466.805995820133, 6478.708458119396, 6480.902786458207, 6480.2547707013355, 6592.80221593353, 6633.303503132198, 6639.7012134455035, 6639.966800165968, 6205.937940620716, 6340.936590634219, 6377.330380310186, 6404.93595064062, 6429.8714025720155, 6216.316205217332, 6325.462335701517, 6332.2717887441695, 6334.746610135728, 6356.141920840812, 6676.132102826601, 6681.899771503528, 6684.63234522106, 6686.53194276396, 6692.59844409337, 4324.978375108104, 4420.933685994777, 4452.532484089124, 4452.5992660660695, 4461.10777844426, 6314.810555683337, 6363.681815909279, 6367.3314301997625, 6367.87264254703, 6370.8088757337355, 6199.163112979871, 6203.7828675996125, 6205.03821907605, 6206.255249370104, 6213.813585592439, 6055.818325450244, 6182.05265341416, 6186.288576813544, 6188.226471691039, 6189.226346706661, 6100.633961962297, 6132.938670613236, 6158.876822463615, 6159.753609855556, 6161.753529858935, 6288.496920246278, 6297.118403423616, 6298.527610429144, 6304.779332723333, 6309.936900631119, 5903.291605007426, 6098.603590766586, 6110.725017374318, 6115.938840611537, 6117.235345581802], "unit": "score", "name": "prototype.html", "value": 4678.151948576835}, {"lowerIsBetter": false, "replicates": [766.8197973476232, 851.2041241439258, 869.5478351257347, 870.6604424274531, 898.2320116300563, 13310.401031953561, 13402.463901443944, 13461.0, 13464.865351346483, 13544.593662190138, 11209.943950280238, 12696.746065078716, 12878.871211287884, 12891.355432228374, 12895.226286422798, 665.0954701605813, 793.8769490728946, 812.4231795425255, 813.6989313953845, 814.3851392198911, 792.4532072869702, 796.6813274690141, 800.403699244064, 800.6637212370789, 801.0907619851453, 692.8406466512705, 706.8409607838247, 856.2850020233113, 857.0529564830865, 858.4205661178679, 809.3929552835374, 819.3527113580265, 824.1675907333636, 824.7443292579289, 826.2976470000511, 608.8964875971095, 609.4606273447986, 610.1854024876794, 610.2372034956304, 610.5207412181461, 12305.20016198953, 12327.630171094881, 12351.32067736274, 12363.690907727289, 12369.196002259825, 11578.652640420802, 11752.882471175264, 11934.940325298317, 12001.87998120025, 12056.63830085099, 10636.149108071335, 10652.0, 10669.35983840972, 10686.091682207021, 11062.22564420491, 3582.1044738815294, 3676.74262801604, 3718.1448266898497, 3723.72072094594, 3790.7156963227594, 46318.305225421645, 47037.529624704, 48890.0, 48956.755216224046, 48989.26516102262, 10083.647072352433, 10271.7432064199, 10294.742631434125, 10334.483275836179, 10428.843567346496, 17948.282068717104, 17967.910160449115, 17972.1013949302, 17977.19102640384, 18027.54931126706, 7245.311695388929, 7340.302671246223, 7437.367823735043, 7469.215732348134, 7537.170911199873, 4293.914121717548, 4296.419983302214, 4301.65586753059, 4324.805383757738, 4393.033532622818, 2937.8237305761295, 2964.451576458362, 2969.85150742462, 2972.1677930179585, 2977.0027040941095, 552.1221258199482, 566.6486778197544, 568.5678884048153, 570.0821677099866, 577.4225774225774, 477.739631900615, 501.34574380433156, 509.12430619334685, 552.6628756458557, 657.947364210862, 8049.758507244792, 8486.830263394697, 8646.0, 8651.178138076873, 8661.0, 537.6800803521899, 544.5833937038169, 545.9535939445192, 583.4865318519676, 584.2054805464564, 3790.6209379061875, 3799.35410980134, 3890.7860067696547, 3922.666573341298, 4129.380592911028, 54688.453115468335, 56679.43320566742, 56873.715631421575, 56896.0, 56938.430615693316, 48276.27585586219, 48943.5105648939, 48974.51025489771, 49103.508964909895, 49529.752351238014, 43069.35395969, 43404.56595434069, 43766.0, 44114.338284925754, 44792.55207447949, 8064.919350806417, 8146.2261085196815, 8175.427720059539, 8220.890179825887, 8259.917400826154, 31583.0, 31713.682863171074, 32474.0, 32629.18427039343, 32658.183545411553, 37967.430488542144, 38361.42457863079, 41456.58543414527, 42326.15347692967, 42556.0, 9794.118529332109, 9804.117629413102, 10036.698899033041, 10092.24308176875, 10157.695269141937, 10989.395583242998, 10995.670129896116, 11164.0, 11257.49341279628, 11553.256796619602, 10335.483225838829, 10468.424236667057, 10597.841032384365, 10695.94652026735, 11075.390853503135, 10601.946990265, 10776.838347424638, 10850.565977361133, 10935.617253396093, 11325.830112548483, 9019.819603608023, 9702.27232957517, 9718.076782705632, 9730.026997300214, 10648.946755266174, 9141.77145571366, 9401.086392139536, 9485.193758530602, 9699.466529340672, 9839.163671088038, 9495.24038076966, 9561.665341713286, 9580.28147888925, 9587.952060239653, 9625.951870240604], "unit": "score", "name": "yui.html", "value": 6060.693376720151}], "name": "dromaeo_css", "value": 6709.132883846231}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 106.0, 111.0, 110.0, 112.0, 111.0, 112.0, 104.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 153.0, 166.0, 129.0, 152.0, 153.0, 129.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 160.0, 171.0, 160.0, 160.0, 160.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 96.0, 97.0, 72.0, 72.0, 74.0, 119.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 140.0, 97.0, 96.0, 95.0, 141.0, 97.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 61.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 82.0, 83.0, 83.0, 82.0, 83.0, 85.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 115.0, 119.0, 126.0, 121.0, 129.0, 122.0, 122.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [150.0, 135.0, 144.0, 146.0, 146.0, 135.0, 148.0, 148.0, 145.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 67.0, 66.0, 71.0, 69.0, 67.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1508.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0564650851988], "unit": "score", "name": "Richards", "value": 211.31777200000008}, {"lowerIsBetter": false, "replicates": [188.82175226586102], "unit": "score", "name": "DeltaBlue", "value": 350.16092799999996}, {"lowerIsBetter": false, "replicates": [282.4060999717594], "unit": "score", "name": "Encrypt", "value": 942.5469209999999}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [790.6793048973144], "unit": "score", "name": "Earley", "value": 842.8992587412586}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [43229.166666666664], "unit": "score", "name": "RegExp", "value": 21.073387951807216}, {"lowerIsBetter": false, "replicates": [597.7286312014345], "unit": "score", "name": "Splay", "value": 136.33444300000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18823.595358834566}]} 09:02:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18823.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6709.13"}}} 09:02:35 INFO - Return code: 0 09:02:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:02:35 INFO - # TBPL SUCCESS # 09:02:35 INFO - Running post-action listener: _resource_record_post_action 09:02:35 INFO - Running post-run listener: _resource_record_post_run 09:02:36 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 548114432; Read time: 0; Write time: 591788 09:02:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246837248; Read time: 0; Write time: 335900 09:02:36 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 301088768; Read time: 0; Write time: 255868 09:02:36 INFO - Running post-run listener: _upload_blobber_files 09:02:36 INFO - Blob upload gear active. 09:02:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:02:36 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:02:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:02:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:02:37 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:38 INFO - (blobuploader) - INFO - Done attempting. 09:02:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:02:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:39 INFO - (blobuploader) - INFO - Done attempting. 09:02:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:39 INFO - Return code: 0 09:02:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:02:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74b0e0156230a0462335f47c7f63e6174801fe32ac2f30991748ac69cc8af8c53d8dce0ec130a94a9c9f44047c35596d3e80e16d213777ffd07e9282704dbb3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd992e5c308eb05f75211e752bfcf2f40cf4d7e9d790b7000acd9a4dfd7666158be22ff6b629d647ce9ebd4aea673240fd6b90b9b1f214304d3ee2d7f58250fd"} 09:02:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:02:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:02:39 INFO - Contents: 09:02:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74b0e0156230a0462335f47c7f63e6174801fe32ac2f30991748ac69cc8af8c53d8dce0ec130a94a9c9f44047c35596d3e80e16d213777ffd07e9282704dbb3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd992e5c308eb05f75211e752bfcf2f40cf4d7e9d790b7000acd9a4dfd7666158be22ff6b629d647ce9ebd4aea673240fd6b90b9b1f214304d3ee2d7f58250fd"} 09:02:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:39 INFO - Copying logs to upload dir... 09:02:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:02:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.315477 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-21 09:02:38.968074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 09:02:38.971986) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74b0e0156230a0462335f47c7f63e6174801fe32ac2f30991748ac69cc8af8c53d8dce0ec130a94a9c9f44047c35596d3e80e16d213777ffd07e9282704dbb3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd992e5c308eb05f75211e752bfcf2f40cf4d7e9d790b7000acd9a4dfd7666158be22ff6b629d647ce9ebd4aea673240fd6b90b9b1f214304d3ee2d7f58250fd"} build_url:https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/W8y7qda3TcqhPvllpkAGWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74b0e0156230a0462335f47c7f63e6174801fe32ac2f30991748ac69cc8af8c53d8dce0ec130a94a9c9f44047c35596d3e80e16d213777ffd07e9282704dbb3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd992e5c308eb05f75211e752bfcf2f40cf4d7e9d790b7000acd9a4dfd7666158be22ff6b629d647ce9ebd4aea673240fd6b90b9b1f214304d3ee2d7f58250fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 09:02:38.999143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:02:38.999821) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453394491.46457-447452789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:02:39.083806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 09:02:39.084483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 09:02:39.085109) ========= ========= Total master_lag: 0.29 =========