builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1449572377.77 results: success (0) buildid: 20151208021525 builduid: 83690e1bffe3428a98519ae8ba91a49a revision: 396725444e10c322b95becb2619e6837c9308b09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.770921) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.771412) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.772179) ========= bash -c pwd in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004961 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.816322) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.816672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.844999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.845305) ========= rm -rf properties in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024940 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.896867) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.897188) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.897577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.897890) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-08 02:59:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-08 02:59:38 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.259448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:38.169828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:38.170176) ========= rm -rf scripts in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.355699 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:38.537936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:38.538369) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 396725444e10c322b95becb2619e6837c9308b09 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 396725444e10c322b95becb2619e6837c9308b09 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-08 02:59:38,755 truncating revision to first 12 chars 2015-12-08 02:59:38,755 Setting DEBUG logging. 2015-12-08 02:59:38,755 attempt 1/10 2015-12-08 02:59:38,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/396725444e10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-08 02:59:39,069 unpacking tar archive at: fx-team-396725444e10/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.140610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.140973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.151521) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.151902) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.152394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-08 02:59:39.152734) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:39 INFO - MultiFileLogger online at 20151208 02:59:39 in /builds/slave/test 02:59:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:59:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:39 INFO - {'append_to_log': False, 02:59:39 INFO - 'base_work_dir': '/builds/slave/test', 02:59:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:59:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:39 INFO - 'branch': 'Fx-Team-Non-PGO', 02:59:39 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:39 INFO - 'config_files': ('talos/linux_config.py',), 02:59:39 INFO - 'default_actions': ('clobber', 02:59:39 INFO - 'read-buildbot-config', 02:59:39 INFO - 'download-and-extract', 02:59:39 INFO - 'populate-webroot', 02:59:39 INFO - 'create-virtualenv', 02:59:39 INFO - 'install', 02:59:39 INFO - 'run-tests'), 02:59:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:39 INFO - 'download_minidump_stackwalk': True, 02:59:39 INFO - 'download_symbols': 'ondemand', 02:59:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:39 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:39 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:39 INFO - 'installer_path': 'installer.exe', 02:59:39 INFO - 'log_level': 'info', 02:59:39 INFO - 'log_name': 'talos', 02:59:39 INFO - 'log_to_console': True, 02:59:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:39 INFO - 'opt_config_files': (), 02:59:39 INFO - 'pip_index': False, 02:59:39 INFO - 'sps_profile': False, 02:59:39 INFO - 'sps_profile_interval': 0, 02:59:39 INFO - 'suite': 'dromaeojs-e10s', 02:59:39 INFO - 'system_bits': '64', 02:59:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:39 INFO - 'title': 'talos-linux64-ix-058', 02:59:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:39 INFO - 'use_talos_json': True, 02:59:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:39 INFO - 'work_dir': 'build'} 02:59:39 INFO - ##### 02:59:39 INFO - ##### Running clobber step. 02:59:39 INFO - ##### 02:59:39 INFO - Running pre-action listener: _resource_record_pre_action 02:59:39 INFO - Running main action method: clobber 02:59:39 INFO - rmtree: /builds/slave/test/build 02:59:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:44 INFO - Running post-action listener: _resource_record_post_action 02:59:44 INFO - ##### 02:59:44 INFO - ##### Running read-buildbot-config step. 02:59:44 INFO - ##### 02:59:44 INFO - Running pre-action listener: _resource_record_pre_action 02:59:44 INFO - Running main action method: read_buildbot_config 02:59:44 INFO - Using buildbot properties: 02:59:44 INFO - { 02:59:44 INFO - "properties": { 02:59:44 INFO - "buildnumber": 811, 02:59:44 INFO - "product": "firefox", 02:59:44 INFO - "script_repo_revision": "production", 02:59:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:59:44 INFO - "repository": "", 02:59:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:59:44 INFO - "buildid": "20151208021525", 02:59:44 INFO - "slavename": "talos-linux64-ix-058", 02:59:44 INFO - "pgo_build": "False", 02:59:44 INFO - "basedir": "/builds/slave/test", 02:59:44 INFO - "project": "", 02:59:44 INFO - "platform": "ubuntu64_hw", 02:59:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:59:44 INFO - "slavebuilddir": "test", 02:59:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:59:44 INFO - "branch": "fx-team", 02:59:44 INFO - "repo_path": "integration/fx-team", 02:59:44 INFO - "stage_platform": "linux64", 02:59:44 INFO - "builduid": "83690e1bffe3428a98519ae8ba91a49a", 02:59:44 INFO - "revision": "396725444e10c322b95becb2619e6837c9308b09" 02:59:44 INFO - }, 02:59:44 INFO - "sourcestamp": { 02:59:44 INFO - "repository": "", 02:59:44 INFO - "hasPatch": false, 02:59:44 INFO - "project": "", 02:59:44 INFO - "branch": "fx-team-linux64-talos", 02:59:44 INFO - "changes": [ 02:59:44 INFO - { 02:59:44 INFO - "category": null, 02:59:44 INFO - "files": [ 02:59:44 INFO - { 02:59:44 INFO - "url": null, 02:59:44 INFO - "name": "https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:59:44 INFO - } 02:59:44 INFO - ], 02:59:44 INFO - "repository": "", 02:59:44 INFO - "rev": "396725444e10c322b95becb2619e6837c9308b09", 02:59:44 INFO - "who": "cbook@mozilla.com", 02:59:44 INFO - "when": 1449572278, 02:59:44 INFO - "number": 7044683, 02:59:44 INFO - "comments": "Bug 951714 - DevTools Themes: Update network panel table headers to match new theme. r=vporof", 02:59:44 INFO - "project": "", 02:59:44 INFO - "at": "Tue 08 Dec 2015 02:57:58", 02:59:44 INFO - "branch": "fx-team-linux64-talos", 02:59:44 INFO - "revlink": "", 02:59:44 INFO - "properties": [ 02:59:44 INFO - [ 02:59:44 INFO - "buildid", 02:59:44 INFO - "20151208021525", 02:59:44 INFO - "Change" 02:59:44 INFO - ], 02:59:44 INFO - [ 02:59:44 INFO - "builduid", 02:59:44 INFO - "83690e1bffe3428a98519ae8ba91a49a", 02:59:44 INFO - "Change" 02:59:44 INFO - ], 02:59:44 INFO - [ 02:59:44 INFO - "pgo_build", 02:59:44 INFO - "False", 02:59:44 INFO - "Change" 02:59:44 INFO - ] 02:59:44 INFO - ], 02:59:44 INFO - "revision": "396725444e10c322b95becb2619e6837c9308b09" 02:59:44 INFO - } 02:59:44 INFO - ], 02:59:44 INFO - "revision": "396725444e10c322b95becb2619e6837c9308b09" 02:59:44 INFO - } 02:59:44 INFO - } 02:59:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:59:44 INFO - Running post-action listener: _resource_record_post_action 02:59:44 INFO - ##### 02:59:44 INFO - ##### Running download-and-extract step. 02:59:44 INFO - ##### 02:59:44 INFO - Running pre-action listener: _resource_record_pre_action 02:59:44 INFO - Running main action method: download_and_extract 02:59:44 INFO - mkdir: /builds/slave/test/build/tests 02:59:44 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')]} 02:59:44 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json 02:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json 02:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:59:46 INFO - Downloaded 1302 bytes. 02:59:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:59:46 INFO - Using the following test package requirements: 02:59:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:59:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:46 INFO - u'jsshell-linux-x86_64.zip'], 02:59:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:59:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:59:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:59:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:59:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:59:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:59:46 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')]} 02:59:46 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:48 INFO - Downloaded 21860240 bytes. 02:59:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:59:49 INFO - Return code: 0 02:59:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:59:49 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')]} 02:59:49 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:50 INFO - Downloaded 21860240 bytes. 02:59:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:59:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:59:52 INFO - Return code: 0 02:59:52 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')]} 02:59:52 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:59:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:59:53 INFO - Downloaded 11132074 bytes. 02:59:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:59:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:59:53 INFO - Return code: 0 02:59: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')]} 02:59:53 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:59:54 INFO - Downloaded 57728835 bytes. 02:59:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:55 INFO - mkdir: /builds/slave/test/properties 02:59:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:55 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:55 INFO - Contents: 02:59:55 INFO - build_url:https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:55 INFO - Running post-action listener: _resource_record_post_action 02:59:55 INFO - Running post-action listener: set_extra_try_arguments 02:59:55 INFO - ##### 02:59:55 INFO - ##### Running populate-webroot step. 02:59:55 INFO - ##### 02:59:55 INFO - Running pre-action listener: _resource_record_pre_action 02:59:55 INFO - Running main action method: populate_webroot 02:59:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:59:55 INFO - '../fennec_ids.txt'], 02:59:55 INFO - 'tests': ['tcheck2']}, 02:59:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:55 INFO - '--tppagecycles', 02:59:55 INFO - '7'], 02:59:55 INFO - 'tests': ['tsvgm']}}, 02:59:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:59:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:59:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:59:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'tests': ['damp', 'tps']}, 02:59:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['damp', 'tps']}, 02:59:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:59:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:55 INFO - 'other': {'tests': ['a11yr', 02:59:55 INFO - 'ts_paint', 02:59:55 INFO - 'tpaint', 02:59:55 INFO - 'sessionrestore', 02:59:55 INFO - 'sessionrestore_no_auto_restore']}, 02:59:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['a11yr', 02:59:55 INFO - 'ts_paint', 02:59:55 INFO - 'tpaint', 02:59:55 INFO - 'sessionrestore', 02:59:55 INFO - 'sessionrestore_no_auto_restore']}, 02:59:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['a11yr', 02:59:55 INFO - 'ts_paint', 02:59:55 INFO - 'tpaint', 02:59:55 INFO - 'sessionrestore', 02:59:55 INFO - 'sessionrestore_no_auto_restore']}, 02:59:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['a11yr', 02:59:55 INFO - 'ts_paint', 02:59:55 INFO - 'tpaint', 02:59:55 INFO - 'sessionrestore', 02:59:55 INFO - 'sessionrestore_no_auto_restore']}, 02:59:55 INFO - 'other_l64': {'tests': ['a11yr', 02:59:55 INFO - 'ts_paint', 02:59:55 INFO - 'tpaint', 02:59:55 INFO - 'sessionrestore', 02:59:55 INFO - 'sessionrestore_no_auto_restore']}, 02:59:55 INFO - 'other_nol64': {'tests': ['a11yr', 02:59:55 INFO - 'ts_paint', 02:59:55 INFO - 'tpaint', 02:59:55 INFO - 'sessionrestore', 02:59:55 INFO - 'sessionrestore_no_auto_restore']}, 02:59:55 INFO - 'svgr': {'tests': ['tsvgx', 02:59:55 INFO - 'tsvgr_opacity', 02:59:55 INFO - 'tart', 02:59:55 INFO - 'tscrollx', 02:59:55 INFO - 'cart']}, 02:59:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['tsvgx', 02:59:55 INFO - 'tsvgr_opacity', 02:59:55 INFO - 'tart', 02:59:55 INFO - 'tscrollx', 02:59:55 INFO - 'cart']}, 02:59:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'tests': ['tp5o']}, 02:59:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'talos_options': ['--e10s'], 02:59:55 INFO - 'tests': ['tp5o']}, 02:59:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'talos_options': ['--xperf_path', 02:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:55 INFO - 'tests': ['tp5n']}, 02:59:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:55 INFO - 'talos_options': ['--e10s', 02:59:55 INFO - '--xperf_path', 02:59:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:55 INFO - 'tests': ['tp5n']}}, 02:59:55 INFO - 'talos.zip': {'path': '', 02:59:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:55 INFO - Running post-action listener: _resource_record_post_action 02:59:55 INFO - ##### 02:59:55 INFO - ##### Running create-virtualenv step. 02:59:55 INFO - ##### 02:59:55 INFO - Running pre-action listener: _resource_record_pre_action 02:59:55 INFO - Running main action method: create_virtualenv 02:59:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:59:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:56 INFO - Using real prefix '/usr' 02:59:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:58 INFO - Installing pip.................done. 02:59:58 INFO - Return code: 0 02:59:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:58 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')]} 02:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:58 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')]} 02:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 02:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:59:58 INFO - Using env: {'DISPLAY': ':0', 02:59:58 INFO - 'HOME': '/home/cltbld', 02:59:58 INFO - 'LANG': 'en_US.UTF-8', 02:59:58 INFO - 'LANGUAGE': 'en_US:en', 02:59:58 INFO - 'LOGNAME': 'cltbld', 02:59:58 INFO - 'MAIL': '/var/mail/cltbld', 02:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:58 INFO - 'MOZ_NO_REMOTE': '1', 02:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:58 INFO - 'NO_EM_RESTART': '1', 02:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:58 INFO - 'PWD': '/builds/slave/test', 02:59:58 INFO - 'SHELL': '/bin/bash', 02:59:58 INFO - 'SHLVL': '1', 02:59:58 INFO - 'TERM': 'linux', 02:59:58 INFO - 'TMOUT': '86400', 02:59:58 INFO - 'USER': 'cltbld', 02:59:58 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 02:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:58 INFO - '_': '/tools/buildbot/bin/python'} 02:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:58 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 02:59:58 INFO - Cleaning up... 02:59:58 INFO - Return code: 0 02:59:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:59:58 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')]} 02:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:58 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')]} 02:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 02:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 02:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 02:59:58 INFO - Using env: {'DISPLAY': ':0', 02:59:58 INFO - 'HOME': '/home/cltbld', 02:59:58 INFO - 'LANG': 'en_US.UTF-8', 02:59:58 INFO - 'LANGUAGE': 'en_US:en', 02:59:58 INFO - 'LOGNAME': 'cltbld', 02:59:58 INFO - 'MAIL': '/var/mail/cltbld', 02:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:58 INFO - 'MOZ_NO_REMOTE': '1', 02:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:58 INFO - 'NO_EM_RESTART': '1', 02:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:58 INFO - 'PWD': '/builds/slave/test', 02:59:58 INFO - 'SHELL': '/bin/bash', 02:59:58 INFO - 'SHLVL': '1', 02:59:58 INFO - 'TERM': 'linux', 02:59:58 INFO - 'TMOUT': '86400', 02:59:58 INFO - 'USER': 'cltbld', 02:59:58 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 02:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:58 INFO - '_': '/tools/buildbot/bin/python'} 02:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:59 INFO - Downloading/unpacking psutil>=0.7.1 02:59:59 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 02:59:59 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 02:59:59 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 02:59:59 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 02:59:59 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 02:59:59 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 03:00:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:00:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:01 INFO - Installing collected packages: psutil 03:00:01 INFO - Running setup.py install for psutil 03:00:01 INFO - building 'psutil._psutil_linux' extension 03:00:01 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 03:00:02 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 03:00:02 INFO - building 'psutil._psutil_posix' extension 03:00:02 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 03:00:02 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 03:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:02 INFO - Successfully installed psutil 03:00:02 INFO - Cleaning up... 03:00:02 INFO - Return code: 0 03:00:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:00:02 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')]} 03:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:02 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')]} 03:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 03:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 03:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:00:02 INFO - Using env: {'DISPLAY': ':0', 03:00:02 INFO - 'HOME': '/home/cltbld', 03:00:02 INFO - 'LANG': 'en_US.UTF-8', 03:00:02 INFO - 'LANGUAGE': 'en_US:en', 03:00:02 INFO - 'LOGNAME': 'cltbld', 03:00:02 INFO - 'MAIL': '/var/mail/cltbld', 03:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:02 INFO - 'MOZ_NO_REMOTE': '1', 03:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:02 INFO - 'NO_EM_RESTART': '1', 03:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:02 INFO - 'PWD': '/builds/slave/test', 03:00:02 INFO - 'SHELL': '/bin/bash', 03:00:02 INFO - 'SHLVL': '1', 03:00:02 INFO - 'TERM': 'linux', 03:00:02 INFO - 'TMOUT': '86400', 03:00:02 INFO - 'USER': 'cltbld', 03:00:02 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:02 INFO - '_': '/tools/buildbot/bin/python'} 03:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:00:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:00:04 INFO - Installing collected packages: mozsystemmonitor 03:00:04 INFO - Running setup.py install for mozsystemmonitor 03:00:04 INFO - Successfully installed mozsystemmonitor 03:00:04 INFO - Cleaning up... 03:00:04 INFO - Return code: 0 03:00:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:04 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')]} 03:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:04 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')]} 03:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 03:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 03:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:00:04 INFO - Using env: {'DISPLAY': ':0', 03:00:04 INFO - 'HOME': '/home/cltbld', 03:00:04 INFO - 'LANG': 'en_US.UTF-8', 03:00:04 INFO - 'LANGUAGE': 'en_US:en', 03:00:04 INFO - 'LOGNAME': 'cltbld', 03:00:04 INFO - 'MAIL': '/var/mail/cltbld', 03:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:04 INFO - 'MOZ_NO_REMOTE': '1', 03:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:04 INFO - 'NO_EM_RESTART': '1', 03:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:04 INFO - 'PWD': '/builds/slave/test', 03:00:04 INFO - 'SHELL': '/bin/bash', 03:00:04 INFO - 'SHLVL': '1', 03:00:04 INFO - 'TERM': 'linux', 03:00:04 INFO - 'TMOUT': '86400', 03:00:04 INFO - 'USER': 'cltbld', 03:00:04 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:04 INFO - '_': '/tools/buildbot/bin/python'} 03:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:06 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 03:00:06 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 03:00:06 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 03:00:06 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 03:00:06 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 03:00:06 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 03:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:07 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 03:00:07 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 03:00:07 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 03:00:07 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 03:00:07 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 03:00:07 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 03:00:07 INFO - Downloading docopt-0.6.1.tar.gz 03:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:07 INFO - Running setup.py install for blobuploader 03:00:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:07 INFO - Running setup.py install for requests 03:00:08 INFO - Running setup.py install for docopt 03:00:08 INFO - Successfully installed blobuploader requests docopt 03:00:08 INFO - Cleaning up... 03:00:08 INFO - Return code: 0 03:00:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:08 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')]} 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:08 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')]} 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 03:00:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 03:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 03:00:08 INFO - Using env: {'DISPLAY': ':0', 03:00:08 INFO - 'HOME': '/home/cltbld', 03:00:08 INFO - 'LANG': 'en_US.UTF-8', 03:00:08 INFO - 'LANGUAGE': 'en_US:en', 03:00:08 INFO - 'LOGNAME': 'cltbld', 03:00:08 INFO - 'MAIL': '/var/mail/cltbld', 03:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:08 INFO - 'MOZ_NO_REMOTE': '1', 03:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:08 INFO - 'NO_EM_RESTART': '1', 03:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:08 INFO - 'PWD': '/builds/slave/test', 03:00:08 INFO - 'SHELL': '/bin/bash', 03:00:08 INFO - 'SHLVL': '1', 03:00:08 INFO - 'TERM': 'linux', 03:00:08 INFO - 'TMOUT': '86400', 03:00:08 INFO - 'USER': 'cltbld', 03:00:08 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:08 INFO - '_': '/tools/buildbot/bin/python'} 03:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:08 INFO - Running setup.py (path:/tmp/pip-gC_yFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:08 INFO - Running setup.py (path:/tmp/pip-rn58GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:08 INFO - Running setup.py (path:/tmp/pip-dyz8Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:08 INFO - Running setup.py (path:/tmp/pip-kguyxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:08 INFO - Running setup.py (path:/tmp/pip-ggfeUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:08 INFO - Running setup.py (path:/tmp/pip-bmWNwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:08 INFO - Running setup.py (path:/tmp/pip-A5W3xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:08 INFO - Running setup.py (path:/tmp/pip-Yzmv4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:08 INFO - Running setup.py (path:/tmp/pip-amTLEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:09 INFO - Running setup.py (path:/tmp/pip-5ltVwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:09 INFO - Running setup.py (path:/tmp/pip-Ok2Zx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:09 INFO - Running setup.py (path:/tmp/pip-sU5k6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:09 INFO - Running setup.py (path:/tmp/pip-fQ69wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:09 INFO - Running setup.py (path:/tmp/pip-gMGqz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:09 INFO - Running setup.py (path:/tmp/pip-GNGSAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:09 INFO - Running setup.py (path:/tmp/pip-y3m010-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:09 INFO - Running setup.py (path:/tmp/pip-AfCHN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:09 INFO - Running setup.py install for manifestparser 03:00:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Running setup.py install for mozcrash 03:00:09 INFO - Running setup.py install for mozdebug 03:00:09 INFO - Running setup.py install for mozdevice 03:00:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Running setup.py install for mozfile 03:00:10 INFO - Running setup.py install for mozhttpd 03:00:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Running setup.py install for mozinfo 03:00:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Running setup.py install for mozInstall 03:00:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Running setup.py install for mozleak 03:00:10 INFO - Running setup.py install for mozlog 03:00:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Running setup.py install for moznetwork 03:00:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Running setup.py install for mozprocess 03:00:10 INFO - Running setup.py install for mozprofile 03:00:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:10 INFO - Running setup.py install for mozrunner 03:00:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:11 INFO - Running setup.py install for mozscreenshot 03:00:11 INFO - Running setup.py install for moztest 03:00:11 INFO - Running setup.py install for mozversion 03:00:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:11 INFO - Cleaning up... 03:00:11 INFO - Return code: 0 03:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:11 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')]} 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 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')]} 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 03:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 03:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 03:00:11 INFO - Using env: {'DISPLAY': ':0', 03:00:11 INFO - 'HOME': '/home/cltbld', 03:00:11 INFO - 'LANG': 'en_US.UTF-8', 03:00:11 INFO - 'LANGUAGE': 'en_US:en', 03:00:11 INFO - 'LOGNAME': 'cltbld', 03:00:11 INFO - 'MAIL': '/var/mail/cltbld', 03:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:11 INFO - 'MOZ_NO_REMOTE': '1', 03:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:11 INFO - 'NO_EM_RESTART': '1', 03:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:11 INFO - 'PWD': '/builds/slave/test', 03:00:11 INFO - 'SHELL': '/bin/bash', 03:00:11 INFO - 'SHLVL': '1', 03:00:11 INFO - 'TERM': 'linux', 03:00:11 INFO - 'TMOUT': '86400', 03:00:11 INFO - 'USER': 'cltbld', 03:00:11 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:11 INFO - '_': '/tools/buildbot/bin/python'} 03:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:11 INFO - Running setup.py (path:/tmp/pip-rUVmaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:11 INFO - Running setup.py (path:/tmp/pip-apYeT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:11 INFO - Running setup.py (path:/tmp/pip-6dKo62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:11 INFO - Running setup.py (path:/tmp/pip-jbnsFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:11 INFO - Running setup.py (path:/tmp/pip-RqQYuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:11 INFO - Running setup.py (path:/tmp/pip-jSJ1KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:12 INFO - Running setup.py (path:/tmp/pip-rkFmdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:12 INFO - Running setup.py (path:/tmp/pip-5tTbhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:12 INFO - Running setup.py (path:/tmp/pip-J5WVpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:12 INFO - Running setup.py (path:/tmp/pip-jEL5ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:12 INFO - Running setup.py (path:/tmp/pip-HcCh4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:12 INFO - Running setup.py (path:/tmp/pip-SQYxXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:12 INFO - Running setup.py (path:/tmp/pip-rl8MdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:12 INFO - Running setup.py (path:/tmp/pip-oACraC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:12 INFO - Running setup.py (path:/tmp/pip-Ig7ZT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:12 INFO - Running setup.py (path:/tmp/pip-9DEGVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:12 INFO - Running setup.py (path:/tmp/pip-jzTm8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:12 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 03:00:12 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 03:00:12 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 03:00:12 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 03:00:12 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 03:00:12 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 03:00:14 INFO - Downloading blessings-1.5.1.tar.gz 03:00:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:14 INFO - Installing collected packages: blessings 03:00:14 INFO - Running setup.py install for blessings 03:00:14 INFO - Successfully installed blessings 03:00:14 INFO - Cleaning up... 03:00:14 INFO - Return code: 0 03:00:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:14 INFO - Reading from file tmpfile_stdout 03:00:14 INFO - Current package versions: 03:00:14 INFO - argparse == 1.2.1 03:00:14 INFO - blessings == 1.5.1 03:00:14 INFO - blobuploader == 1.2.4 03:00:14 INFO - docopt == 0.6.1 03:00:14 INFO - manifestparser == 1.1 03:00:14 INFO - mozInstall == 1.12 03:00:14 INFO - mozcrash == 0.16 03:00:14 INFO - mozdebug == 0.1 03:00:14 INFO - mozdevice == 0.47 03:00:14 INFO - mozfile == 1.2 03:00:14 INFO - mozhttpd == 0.7 03:00:14 INFO - mozinfo == 0.9 03:00:14 INFO - mozleak == 0.1 03:00:14 INFO - mozlog == 3.1 03:00:14 INFO - moznetwork == 0.27 03:00:14 INFO - mozprocess == 0.22 03:00:14 INFO - mozprofile == 0.27 03:00:14 INFO - mozrunner == 6.11 03:00:14 INFO - mozscreenshot == 0.1 03:00:14 INFO - mozsystemmonitor == 0.0 03:00:14 INFO - moztest == 0.7 03:00:14 INFO - mozversion == 1.4 03:00:14 INFO - psutil == 3.1.1 03:00:14 INFO - requests == 1.2.3 03:00:14 INFO - wsgiref == 0.1.2 03:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:14 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')]} 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 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')]} 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 03:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 03:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 03:00:14 INFO - Using env: {'DISPLAY': ':0', 03:00:14 INFO - 'HOME': '/home/cltbld', 03:00:14 INFO - 'LANG': 'en_US.UTF-8', 03:00:14 INFO - 'LANGUAGE': 'en_US:en', 03:00:14 INFO - 'LOGNAME': 'cltbld', 03:00:14 INFO - 'MAIL': '/var/mail/cltbld', 03:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:14 INFO - 'MOZ_NO_REMOTE': '1', 03:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:14 INFO - 'NO_EM_RESTART': '1', 03:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:14 INFO - 'PWD': '/builds/slave/test', 03:00:14 INFO - 'SHELL': '/bin/bash', 03:00:14 INFO - 'SHLVL': '1', 03:00:14 INFO - 'TERM': 'linux', 03:00:14 INFO - 'TMOUT': '86400', 03:00:14 INFO - 'USER': 'cltbld', 03:00:14 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:14 INFO - '_': '/tools/buildbot/bin/python'} 03:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:15 INFO - Cleaning up... 03:00:15 INFO - Return code: 0 03:00:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:15 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')]} 03:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:15 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')]} 03:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 03:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 03:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:00:15 INFO - Using env: {'DISPLAY': ':0', 03:00:15 INFO - 'HOME': '/home/cltbld', 03:00:15 INFO - 'LANG': 'en_US.UTF-8', 03:00:15 INFO - 'LANGUAGE': 'en_US:en', 03:00:15 INFO - 'LOGNAME': 'cltbld', 03:00:15 INFO - 'MAIL': '/var/mail/cltbld', 03:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:15 INFO - 'MOZ_NO_REMOTE': '1', 03:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:15 INFO - 'NO_EM_RESTART': '1', 03:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:15 INFO - 'PWD': '/builds/slave/test', 03:00:15 INFO - 'SHELL': '/bin/bash', 03:00:15 INFO - 'SHLVL': '1', 03:00:15 INFO - 'TERM': 'linux', 03:00:15 INFO - 'TMOUT': '86400', 03:00:15 INFO - 'USER': 'cltbld', 03:00:15 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:15 INFO - '_': '/tools/buildbot/bin/python'} 03:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:15 INFO - Downloading/unpacking jsonschema 03:00:15 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 03:00:15 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 03:00:15 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 03:00:15 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 03:00:15 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 03:00:15 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 03:00:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:00:17 INFO - Downloading/unpacking functools32 (from jsonschema) 03:00:17 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 03:00:17 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 03:00:17 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 03:00:17 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 03:00:17 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 03:00:17 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 03:00:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:17 INFO - warning: no files found matching '*.txt' 03:00:17 INFO - no previously-included directories found matching 'build' 03:00:17 INFO - no previously-included directories found matching 'dist' 03:00:17 INFO - no previously-included directories found matching '.git*' 03:00:17 INFO - Installing collected packages: jsonschema, functools32 03:00:17 INFO - Running setup.py install for functools32 03:00:17 INFO - warning: no files found matching '*.txt' 03:00:17 INFO - no previously-included directories found matching 'build' 03:00:17 INFO - no previously-included directories found matching 'dist' 03:00:17 INFO - no previously-included directories found matching '.git*' 03:00:17 INFO - Successfully installed jsonschema functools32 03:00:17 INFO - Cleaning up... 03:00:17 INFO - Return code: 0 03:00:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:00:17 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')]} 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:17 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')]} 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7faf68a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 03:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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/build 03:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 03:00:17 INFO - Using env: {'DISPLAY': ':0', 03:00:17 INFO - 'HOME': '/home/cltbld', 03:00:17 INFO - 'LANG': 'en_US.UTF-8', 03:00:17 INFO - 'LANGUAGE': 'en_US:en', 03:00:17 INFO - 'LOGNAME': 'cltbld', 03:00:17 INFO - 'MAIL': '/var/mail/cltbld', 03:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:17 INFO - 'MOZ_NO_REMOTE': '1', 03:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:17 INFO - 'NO_EM_RESTART': '1', 03:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:17 INFO - 'PWD': '/builds/slave/test', 03:00:17 INFO - 'SHELL': '/bin/bash', 03:00:17 INFO - 'SHLVL': '1', 03:00:17 INFO - 'TERM': 'linux', 03:00:17 INFO - 'TMOUT': '86400', 03:00:17 INFO - 'USER': 'cltbld', 03:00:17 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:17 INFO - '_': '/tools/buildbot/bin/python'} 03:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:17 INFO - Downloading/unpacking flake8 03:00:17 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 03:00:17 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 03:00:17 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 03:00:17 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 03:00:17 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 03:00:17 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 03:00:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:00:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:00:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:00:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:00:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:00:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:19 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 03:00:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:20 INFO - no previously-included directories found matching 'docs/_build' 03:00:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:00:20 INFO - Running setup.py install for pep8 03:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:20 INFO - no previously-included directories found matching 'docs/_build' 03:00:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:00:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:00:20 INFO - Cleaning up... 03:00:20 INFO - Return code: 0 03:00:20 INFO - Running post-action listener: _resource_record_post_action 03:00:20 INFO - Running post-action listener: _start_resource_monitoring 03:00:20 INFO - Starting resource monitoring. 03:00:20 INFO - ##### 03:00:20 INFO - ##### Running install step. 03:00:20 INFO - ##### 03:00:20 INFO - Running pre-action listener: _resource_record_pre_action 03:00:20 INFO - Running main action method: install 03:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:20 INFO - Reading from file tmpfile_stdout 03:00:20 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:20 INFO - Reading from file tmpfile_stdout 03:00:20 INFO - Output received: 03:00:20 INFO - Usage: mozinstall [options] installer 03:00:20 INFO - Options: 03:00:20 INFO - -h, --help show this help message and exit 03:00:20 INFO - -d DEST, --destination=DEST 03:00:20 INFO - Directory to install application into. [default: 03:00:20 INFO - "/builds/slave/test"] 03:00:20 INFO - --app=APP Application being installed. [default: firefox] 03:00:20 INFO - mkdir: /builds/slave/test/build/application 03:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:00:35 INFO - Reading from file tmpfile_stdout 03:00:35 INFO - Output received: 03:00:35 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:35 INFO - Running post-action listener: _resource_record_post_action 03:00:35 INFO - ##### 03:00:35 INFO - ##### Running run-tests step. 03:00:35 INFO - ##### 03:00:35 INFO - Running pre-action listener: _resource_record_pre_action 03:00:35 INFO - Running main action method: run_tests 03:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:35 INFO - Python 2.7.3 03:00:35 INFO - Return code: 0 03:00:35 INFO - grabbing minidump binary from tooltool 03:00: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')]} 03:00:35 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/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 0x14c50b0>, '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 0x14c5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:00:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:00:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:35 INFO - Return code: 0 03:00:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:00:36 INFO - Return code: 0 03:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test/build 03:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 03:00:36 INFO - Using env: {'DISPLAY': ':0', 03:00:36 INFO - 'HOME': '/home/cltbld', 03:00:36 INFO - 'LANG': 'en_US.UTF-8', 03:00:36 INFO - 'LANGUAGE': 'en_US:en', 03:00:36 INFO - 'LOGNAME': 'cltbld', 03:00:36 INFO - 'MAIL': '/var/mail/cltbld', 03:00:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:36 INFO - 'MOZ_NO_REMOTE': '1', 03:00:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:36 INFO - 'NO_EM_RESTART': '1', 03:00:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:36 INFO - 'PWD': '/builds/slave/test', 03:00:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:36 INFO - 'SHELL': '/bin/bash', 03:00:36 INFO - 'SHLVL': '1', 03:00:36 INFO - 'TERM': 'linux', 03:00:36 INFO - 'TMOUT': '86400', 03:00:36 INFO - 'USER': 'cltbld', 03:00:36 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992', 03:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:36 INFO - '_': '/tools/buildbot/bin/python'} 03:00:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 03:00:36 INFO - mozversion INFO | application_buildid: 20151208021525 03:00:36 INFO - mozversion INFO | application_changeset: 396725444e10c322b95becb2619e6837c9308b09 03:00:36 INFO - mozversion INFO | application_display_name: Nightly 03:00:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:36 INFO - mozversion INFO | application_name: Firefox 03:00:36 INFO - mozversion INFO | application_remotingname: firefox 03:00:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:00:36 INFO - mozversion INFO | application_vendor: Mozilla 03:00:36 INFO - mozversion INFO | application_version: 45.0a1 03:00:36 INFO - mozversion INFO | platform_buildid: 20151208021525 03:00:36 INFO - mozversion INFO | platform_changeset: 396725444e10c322b95becb2619e6837c9308b09 03:00:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:00:36 INFO - mozversion INFO | platform_version: 45.0a1 03:00:36 INFO - 2015-12-08 03:00:36,883 DEBUG : using testdate: 1449572436 03:00:36 INFO - 2015-12-08 03:00:36,883 DEBUG : actual date: 1449572436 03:00:36 INFO - 2015-12-08 03:00:36,962 INFO : starting webserver on 'localhost:52917' 03:00:36 INFO - 2015-12-08 03:00:36,963 INFO : Starting test suite talos-linux64-ix-058.e 03:00:36 INFO - 2015-12-08 03:00:36,963 INFO : Starting test dromaeo_css 03:00:36 INFO - 2015-12-08 03:00:36,963 DEBUG : operating with platform_type : linux_ 03:00:36 INFO - 2015-12-08 03:00:36,964 INFO : Initialising browser for dromaeo_css test... 03:00:37 INFO - 2015-12-08 03:00:37,008 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGMzb5P/profile http://localhost:52917/getInfo.html 03:00:43 INFO - 2015-12-08 03:00:43,140 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:00:43 INFO - 2015-12-08 03:00:43,140 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:00:43 INFO - 2015-12-08 03:00:43,140 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:00:43 INFO - 2015-12-08 03:00:43,140 DEBUG : BROWSER_OUTPUT: __metrics 03:00:43 INFO - 2015-12-08 03:00:43,257 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:00:44 INFO - 2015-12-08 03:00:44,205 INFO : Browser initialized. 03:00:44 INFO - 2015-12-08 03:00:44,205 INFO : Running cycle 1/1 for dromaeo_css test... 03:00:44 INFO - 2015-12-08 03:00:44,205 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGMzb5P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:00:56 INFO - 2015-12-08 03:00:56,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 142835712 03:00:56 INFO - 2015-12-08 03:00:56,299 DEBUG : BROWSER_OUTPUT: 03:01:45 INFO - 2015-12-08 03:01:45,915 DEBUG : BROWSER_OUTPUT: 1449572505914 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] 03:03:57 INFO - 2015-12-08 03:03:57,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52917/tests/dromaeo/cssquery-ext.html) 03:03:58 INFO - 2015-12-08 03:03:58,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 145477632 03:03:58 INFO - 2015-12-08 03:03:58,790 DEBUG : BROWSER_OUTPUT: 03:07:00 INFO - 2015-12-08 03:07:00,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/dromaeo/cssquery-ext.html (next: http://localhost:52917/tests/dromaeo/cssquery-jquery.html) 03:07:01 INFO - 2015-12-08 03:07:01,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 145821696 03:07:01 INFO - 2015-12-08 03:07:01,268 DEBUG : BROWSER_OUTPUT: 03:10:02 INFO - 2015-12-08 03:10:02,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52917/tests/dromaeo/cssquery-mootools.html) 03:10:03 INFO - 2015-12-08 03:10:03,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 146182144 03:10:03 INFO - 2015-12-08 03:10:03,578 DEBUG : BROWSER_OUTPUT: 03:13:05 INFO - 2015-12-08 03:13:05,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52917/tests/dromaeo/cssquery-prototype.html) 03:13:05 INFO - 2015-12-08 03:13:05,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 144637952 03:13:05 INFO - 2015-12-08 03:13:05,987 DEBUG : BROWSER_OUTPUT: 03:16:08 INFO - 2015-12-08 03:16:08,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52917/tests/dromaeo/cssquery-yui.html) 03:16:09 INFO - 2015-12-08 03:16:09,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 144642048 03:16:09 INFO - 2015-12-08 03:16:09,299 DEBUG : BROWSER_OUTPUT: 03:19:11 INFO - 2015-12-08 03:19:11,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/dromaeo/cssquery-yui.html (next: http://localhost:52917/tests/dromaeo/cssquery-dojo.html) 03:19:11 INFO - 2015-12-08 03:19:11,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 147910656 03:19:11 INFO - 2015-12-08 03:19:11,997 DEBUG : BROWSER_OUTPUT: 03:19:11 INFO - 2015-12-08 03:19:11,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:19:11 INFO - 2015-12-08 03:19:11,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:19:11 INFO - 2015-12-08 03:19:11,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:19:11 INFO - 2015-12-08 03:19:11,997 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:19:11 INFO - 2015-12-08 03:19:11,998 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2662.5074361243164;2669.506141363849;2704.7430494103064;2717.660292463442;2727.399972006158;4582.862514124582;4733.644976626754;4756.476787553366;4761.785719642616;4783.330333753273;4634.189016922042;4720.575148236658;4739.123262196487;4762.1428142934255;4772.80908763649;4339.761313127777;4389.3196554534015;4479.7984090716;4481.596656300932;4516.1193567254395;4250.2562051641;4388.626966707818;4430.933535996963;4441.600255976961;4528.071745292224;4285.35719642053;4307.569243075714;4377.190219809314;4399.098184872094;4410.977945110254;4439.467263928349;4443.37792709021;4450.977745111286;4453.866384008485;4501.347304640809;4192.538820729717;4297.892552686177;4423.424954755893;4439.933400998988;4465.732056076646;4616.192166370872;4651.348811166439;4665.486796452387;4713.316569097496;4717.268823332389;5132.486751324875;5149.588032957355;5151.407588127376;5155.71643559604;5158.871028224287;4702.153612349775;4915.311856340079;4927;5172.32759741235;5237.816676416307;4663.626909847204;4733.810647574127;4745.596624286905;4762.809487620457;4787.616990640775;5240.3973543042275;5242.135047717084;5245.763940622681;5248.790048398021;5284.841454756363;4847.927281090787;4930.9013819723405;4935.802567897315;5022.6233032522705;5023.899522009539;5095.159298715745;5095.719735414514;5118.181091025418;5121.8463446096675;5174.922376164361;5047.192449208183;5057.342545469065;5060.443351231362;5063.949360506348;5097.235414687752;4803.951960480351;4890.779914903838;4958.528939750718;5036.370453693288;5072.137736584789;4296.419983302214;4300.182965236595;4302.075053863435;4316.072044510445;4339.045410009793;3782.962170378316;3785.7917814519915;3799.2781371539318;3813.923721525554;3820.522434695663;4218.198542276958;4296.914061718748;4345.435093437896;4407.933880991788;4440.933385999213;5150.639455238173;5164.302819119371;5194.376674798973;5201.973990130101;5234.7906083756225;4242.85150019754;4394.560543945579;4428.202923473741;4450.043240703199;4479.148961697267;4464.4865840428765;4493.326001099861;4506.6169375602785;4517.11916176349;4517.390152329459;4792.95207047925;4850.442199147144;4860.173770459101;4861.51384861511;4861.708297502161;4913.582345500672;5140;5143.254228136974;5149.922751158811;5202.609804264771;4764.285357196448;4777.522247775195;4809.398825146856;4824.252240902666;4866.756662166948;5022.096022715946;5035.370578677665;5040.924386134284;5070.188769796815;5080.796768129381;4879.829205977774;4973;5123.38519377677;5125.948740512547;5163.044836705221;4921.237208232729;4952.925706114339;4956.405231372259;4969.254611808257;5008.69947803133;4917.655764096622;5067.391912970467;5068.493150684902;5069.264956581349;5124.052050370693;4646.8141274348645;4722.5513576210205;4745.691530050535;4950.6782059166035;5013.974930125326;5001.949980500149;5005.749712514433;5014.4484106747495;5030.974845125751;5048.873778155576;4885.975570122127;4904.043711476371;4911.63162762787;4934.18585933317;4974.054929563516 03:19:11 INFO - 2015-12-08 03:19:11,998 DEBUG : BROWSER_OUTPUT: |1;ext.html;509.3404041765913;533.410581307655;537.8252068077875;539.4443722965345;579.5913880714091;26913.865430672842;36059.81970090149;36549.634503654954;36595.81702091486;36635.45046824296;39404.80297598515;40050;40053;40073.398899016465;40106.19787604246;7833.412494062954;7897.763067107996;7949.880751788728;7963.60181990901;8010.719624813133;7672.3478504327195;7852.960735196316;7853.685852565891;7873.685052597889;7917.287444130027;7798.532088074734;7818.14000459949;7845.372370210398;7896.60516974149;7905.960470197641;7815.452918295721;7815.765527034198;7870.449068565203;7897.6840926362875;7915.525068495908;7656.61716914152;7779.805504862367;7792.259735325135;7803.726869559595;7808.921910780877;36766.632333676585;37266.254674906624;37352.813235933645;37367;37401.43897841507;2686.1404350607813;2916.7083291670874;3020.0486846643457;3514.4728290756593;3526.2418580005165;28007.29981750452;28155.43689126206;28391.858040709663;28430.573541396894;28758;3156.6685498022607;3292.818894960776;3303.5540202072893;3344.185699729095;3378.8986330410125;210916;211049;211953;211958;286444.9999999979;43660.78169609132;54939.725301374034;56535.15197272044;56624.433755661914;56713;55087;55139.724301378235;55509.72245138748;55604.72197639067;55648.44351556433;14107.435702571987;14119.647008824657;14155.433782648784;14220.502282420273;14300.570982870531;10914.236003479838;11095.50070246841;11161.497732602053;11176.329420234812;11203.383813890152;18751.90624046871;18896.811031889505;18929.621407571773;18972.430827075208;18980.905095474434;6955.756548520778;7214.206437291894;7224.747133850396;7247.094113235846;7398.926010739931;807.5356669914822;909.8316811389914;953.5041778275258;965.35803690545;1003.3528374198747;25957.610635840476;26278.73721262801;26287.868560657458;26291.342716432242;26324.868375658;917.7659696777279;967.7403263380087;968.3028219681959;968.4286271100085;1039.443897514841;13908.304584770722;13921.582352529238;13957;14111.858881411259;14690;253949;259422;260036;260424;260607;45002.77498612486;45310.54689453129;45324;45497.772511137235;45532.77233613877;1238.6655602987144;1244.3156264054733;1247.014858261981;1254.943527541263;1257.9811302830465;26090.86954565291;26264.73735262623;26865.865670672305;26884.731152689004;26926.326841828326;39466.802665986484;40005;40293.39559906662;40318.59681403266;40381.394279086424;247426;247561;249512;250067;250493;27980.160595182177;29020;29378.796590255388;29596.704032959395;29630;33582.832085839415;33638.47711421702;33670.49494257539;34350.31299374049;34406.311873761886;30023.69976300209;31378.686213137575;32020.83989580037;32400.675993239765;32682.509762353107;31705.36589268248;31737.365252694355;31765.20586985344;31798.205044874063;31896.36207275888;28558.286042849097;29145.271368215963;29462.852685736434;29546.409071818012;29702.851485742434;25948;26290.605640915783;26910.730892690823;27325;27539.862300688368;23289.650655239846;23681.881590591936;24037.399065022815;24309;24853.25440236796 03:19:11 INFO - 2015-12-08 03:19:11,998 DEBUG : BROWSER_OUTPUT: |2;jquery.html;281.66481886555;281.9168345338126;282.313977035803;282.8797760951595;285.83707286846504;13053.216806991588;13324.40040198191;15198.848011519882;15620.843791562094;15691.293891774883;10337.689869303915;10398.740031499216;10494.737631559216;14969.7006059879;16273.698104151668;4516.412866327373;4546.47715512717;4594.839180628679;4604.286335617984;4624.676272660915;4486.551344865504;4841.741147301709;5037.773300201499;5041.546260836524;5041.991601679661;4954.984228233204;5007.073691367091;5015.7492125393765;5032.974835125838;5186.325777648919;5174.560162386202;5194.298769666103;5215.895682086356;5230.241614965847;5241.266222728783;5021.271915572258;5032.84901452957;5039.748012599392;5046.293518907356;5050.191969284897;18282.177302021442;18388.724169137473;18850.71723924142;18883.81116188834;18897.62204755911;1705.2156008236102;1796.2276221225;1810.167323031407;1814.609858880347;1846.704527275643;9122.407043542149;9245.72262832116;11452.312861228353;12779;13099.934500327437;1739.1304347826087;1748.2657283940775;1794.1388133695768;1795.2998330651058;1798.505411011969;56026.43973560294;57981;58366.12450813241;58460.70769646167;59006;9463.817022872141;9679.70960871175;9740.707778766648;9748.171405430476;9752.609895604097;12338;12355.444005019795;12412.503499860086;12418.192817467016;12455.314957677414;6802;6845.075914751545;6853.691583878737;6873.243943166248;6875.140607424072;6288.339724328971;6337.2395312562785;6356.396142366468;6367.681615919186;6377.808665740035;3971.126352202511;4044.5348784890116;4099.323611604052;4105.876823695294;4126.051008268115;1692.33152904602;1743.128435782109;1751.9649607008043;1757.674830156425;1765.496833402474;819.3035919468405;841.3647695989489;853.2406158518924;929.9023602521773;989.6387818446216;15363.23183840826;15654.13902235388;16194.170497492069;16305.918470407572;17485.213165407586;837.9790505237296;843.0894633795486;848.3128665780614;851.9829603408022;855.3242938078972;9312.90687093134;9343.299252556086;9374.437533747998;9448.244140468745;9574.234061275081;462327;487266;489763;500031;504183;69745.65127174332;73668;74920;75547;78190;1055.3193190392153;1062.9043386095288;1068.0667990936429;1102.509383324413;1104.9668509944715;14092.859071409155;14098.436062557383;14112.717745645235;14135.222562759147;14288.499902503363;33937;34564.48153277753;34805;35155.824220878734;35443.468347975315;44408.333874992546;45232;46398;46894.53105468902;47087.293690593986;8380.832383352177;8474.61864216124;8476.36427267945;8532.402731808963;8595.09751476086;12742.745145097231;15100.924495377452;15449;15559.377624894878;15670.216489175724;13544.255065971467;13694.315284235548;13961.790573141208;13970.441182352592;14047.719045619235;12962.481500739865;13149.671258218621;13477.797833032708;13877.028607997343;13908.678675525809;13266.403011864297;13848.930755346562;14049.789253161414;14274.571762847132;14446.061006034573;8288.83422331562;8804.691835785718;8829.60266788009;8887.066857979818;8915.242204412698;12873.485060597472;13708.65728356799;14078.577642670736;14210;14816.481423150139 03:19:11 INFO - 2015-12-08 03:19:11,998 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1487.7247709173796;1623.448027670592;1645.6461860699956;1650.64511130107;1695.508302592248;6945.374916257536;7046.365827075562;7209.927900721004;7231.059962204906;7271.163816161136;7195.784126476201;7213.783586492401;7259.60072196029;7289.599072051035;7291.927080729191;2038.2662241593052;2095.6227878981776;2095.947601309972;2096.088201632287;2097.832173426122;2052.907619157134;2080.1991233375106;2082.3232449453913;2088.3734879536155;2099.5590925905576;1986.3643634037114;2052.445839623301;2065.2771529964466;2065.297798748425;2083.802038806311;1950.2783969931074;2023.2918478532542;2024.0992758222596;2027.908744106504;2031.3702752146883;2035.3588619584784;2083.749950005994;2087.551176497045;2089.6238677038127;2095.98952005239;6980.476464265201;7020.964895175492;7048.823779405505;7053.188883278437;7086.043384143178;4153.958460415418;4194.916101677949;4209.915801683949;4212.304969679999;4235.639970602502;2737.7262273772462;2752.270648278208;2810.8313501189996;2820;2830.037787152378;842.9578521073922;850.4132148817296;857.5412154497315;861.2464093917822;901;9573.760655983586;9689.660861869801;9690.90309096907;9715.07706767856;9743.561539730728;3549.5385599872366;3656.104254457675;3694.9261014779554;3700.833462494194;3730.403135498307;7674.040744906887;7681.731139410093;7688.423368247404;7696.422768292288;7698.884516732253;4186.665066794649;4193.496780386373;4201.390798334224;4208.431861698693;4225.471816022997;3851.30676478231;3852.210296889131;3854.5759966403675;3858.1704933439446;3870.3613903706137;2987.05907639093;3013.839671726357;3015.502442097073;3018.59249001382;3027.409655117231;848.5629900601195;850.9914900851036;851.6976473351995;852.8464876322197;853.8206976534873;743.1639405668623;747.5141158247075;843.717354686187;920.4523308631353;937.704623043739;6437.678116094176;6489.837754056092;6499.837504062436;6501.902471462932;6522.282548919615;563.5773170122408;567.7814041594016;574.133059080791;580.3007376111775;720.4488566246825;5015.172496538104;5090.160123579642;5095.15929871567;5114.3095682083185;5117.078925793393;8197.262246397853;8597.18326758957;8652;8676;8683.826323473495;8490.811286419907;8529.317654587618;8530.402871798915;8544.273736732448;8556.529390883437;6198.535109866778;6303.842403939938;6305.527085468608;6776.627285499345;6793.45652347811;6619.271880093283;6664.50016248793;6691.866162676816;6696.296888826603;6725.461963042847;7430.925690743024;7715.305622494003;7727.150013498398;7754.108277548155;7784.6886124554385;7620.618969051636;7871.291583757489;7883.408744344312;7899.68401263966;7991.320737737357;6191.752329906753;6229.906551401642;6244.313125556276;6248.812535623939;6291;6893;6903.0680858083515;6961.164660240804;6971.51199416036;6987.650617469005;6191.597546159665;6372.171617689671;6418;6480.805575832733;6611.537192396679;5345.679259244458;6111.266648002268;6120.908186377119;6138.723757430837;6291.874162516816;6395.552311338161;6408.487321014214;6454.935450645621;6465.450436712932;6475.773347932988;5814.534837212928;5832.94167058324;5842.795502157404;5847.356790752929;5868.677222752619;5811.738471768866;6008.068749343859;6010.939890601213;6029.78895738647;6033.064874944391 03:19:11 INFO - 2015-12-08 03:19:11,999 DEBUG : BROWSER_OUTPUT: |4;prototype.html;261.6546159070028;263.8232384302517;266.68797506916906;266.68930695739465;270.7103399362682;5646.943530564693;5656.2929633795775;5657.519110875575;5705.115707065401;5822.184894114816;5642.7178641067985;5657.20799088128;5659.51894089003;5672.092465205568;5696.515796157331;4040.2323558523935;4119.773412462313;4120.072983578701;4169.937450938239;4170.436991006206;4127.050778320988;4130.442390277304;4134.689898257628;4137.1518838638;4147;4072.9389059164137;4076.388541718736;4082.530508991474;4093.2018256440006;4114.526829414611;4057.2494088593703;4091.6931230157707;4093.140440507497;4094.5700701426217;4104.569020252875;3443.466262729281;3446.172918499542;3470.889315419067;3476.89569312921;3496.650334966483;5353.544948679328;5376.489233522809;5410.567154627621;5425.37608175061;5430.131179011379;4732.905341893177;4753.191957367221;4755.595774359183;4757.643176761757;4764.95235047652;5847.649141051551;5878.559108066869;5885.323187833368;5906.704664766745;5913.615614985012;3762.9059273518105;3822.5986271441375;3868.458415821787;3894.0654242981764;3902.0635047588657;6196.473299769525;6256.749730010794;6312.968435157841;6318.684065796738;6334.081558174085;3967.2462232175794;3969.325214713506;3969.4839670842607;3970.463987361727;3983.382575700771;4024.75851448914;4029.5567487576345;4033.515978082649;4043.0498832774274;4049.4735684360844;4594.379758732595;4597.103564804831;4739.928901066487;4746.406699162605;4758.95241047592;5940.6435613863305;5956.434138756811;5956.791512297049;5959.255093113361;5967;1409.189715913354;1417.496788640018;1424.8361438434506;1425.950091746784;1429.5139652517985;900.0999000999001;909.8999110097884;923.690563661181;928.6563971330651;932.8693982842408;5131.358580177478;5132.538071573576;5139.948600514022;5145.871353216199;5162.92255616166;6200.782972596027;6212.347703491158;6219.129321894939;6227.688615569294;6239.532035097386;5165.457626949192;5168.2764412982215;5168.8449346519665;5170.689758614495;5173.456787037307;3259.625143108573;3328.500724891237;3370.1574606348413;3372.0895358253133;3379.9155021124175;5845.152452894392;5846.327672317738;5849.853753656107;5877.324107727581;5907.232059832194;6478.838029049217;6480.4815614750705;6484.578502397329;6494.902576461357;6513.316101809241;5739.110437882052;5841.766329346779;5905.379935106752;5908.113782932594;5918.7928422505;6300.117983482224;6307.180066591313;6308.959021761541;6312.14786003902;6312.873742525216;6069;6114.57197996136;6131.509479241561;6134.539909506716;6137.048757442603;5737.254156959569;5870.26621672291;5878.588498805043;5884.823455296348;5903.380145084704;3991.6207960243732;4020.0552870076094;4036.959630403776;4045.271851066836;4045.3931910213705;5950.434708702666;6058.939410605837;6227.252729672468;6281.874362512815;6316.431521163117;5887.852803679943;5958.523318134452;6042.123892035718;6055.878882422415;6057.454829065229;5939.940600593939;6019.217501724747;6031.276246850406;6033.637981721111;6041.214642096499;5696.658200507983;5886.057600991577;5887.735051922588;5898.852528686817;5911.704414779329;6020.096985452217;6020.939790602038;6053.848653783514;6068.4841788448475;6085.6348619083;5936.881262374642;5937.7921772737745;5940.287165540163;5941.792037278848;5948.702564871825 03:19:12 INFO - 2015-12-08 03:19:12,000 DEBUG : BROWSER_OUTPUT: |5;yui.html;614.9938500614993;655.5837043477393;665.7936039827654;734.562935053643;735.2904447208444;11279.32324060556;11565.884341156587;11584.13119016074;11592.42037898106;11636.360000199986;13720.58838234852;13965.16209027459;13968.790468142986;13971.510997115103;13985;780.6487080813628;787.6967367563486;797.2744802229972;800.6997375984006;801.5911884938694;799.0291795468505;800.1438460846896;805.046020465747;806.2622700229283;806.4516129032256;820.1306614988132;823.4112609484217;832.068083746205;832.2717622080679;832.2883934236231;818.97133600324;821.0188824354868;824.5671022713094;827.0241115483727;828.5401602110826;606.8270542895253;611.425260255363;613.5153228949125;614.0942110387188;614.8155553333982;11619.883801161965;11653.242539235007;11715.355655439032;11737.765244695143;11742.708302086763;10836.512356943957;10949;11178.27341222818;11223.943880280627;11273.830892536618;9133.543322833899;9160.404573702688;9384.577694003787;9515.762105947337;9526.571304291323;3185.649578546358;3218.4689526228144;3225.645179030305;3275.3285576457006;3280.4423248047888;39552.40671389931;39721.96911985096;40033.79983100095;40148.59851401507;40194.19611607781;8547.102554231717;8671.826563468696;8730.476171429607;8981.640734370552;9001.909980900107;15416;15522;15593.844061559239;15611;15646.843531564766;5966.552508561876;6300.495960323255;6340.587861789061;6520.380563846427;6587.077809106729;3525.4183059794846;3571.8035508047305;3595.496630471736;3689.409694448875;3700.2229531798625;2572.3954870605394;2592.7666510014187;2616.0974463810335;2618.2407101940603;2620.0305886822;464.428752634255;467.87601285659326;469.08762457020765;481.3285466773901;481.99759001205473;454.8180727708877;514.3750343332869;552.4751883890582;578.0721941284178;581.7492391358613;7551.509151905108;7752.920213818957;7961.761147165595;7984.281414672707;7991.721324588154;439.68123110744455;516.3468212710924;555.9444055594489;609.9146119543268;625.6308777821016;3636.7636103653176;3663.99864185385;3712.406015037581;3759.135398858223;3782.981085094612;48332.75833620809;48812;48909.51090489049;49041;49100.75449622729;44415.33376999348;44475.332870006976;44959.55040449554;45064.54935450669;45325.54674453279;39990.40014399786;40226.19547609032;40409.39385909214;40441;40683.98290042713;7547.207543208104;7586.848263034598;8179.877301840358;8301.46040507365;8412.747617571482;29814.552781708724;30466.543001854545;30533.08400747981;30636.234094147825;32162;38941.41587876241;39341.6065839338;39507.802460987514;40097.39853902136;40402.1919561613;9943.453110079015;10054.29619926598;10055.69832905014;10113.089821915768;10323.174146068146;11217.55129794799;11268.492917818554;11271.718207044889;11585.420728963349;11628.302301861577;9981.401115932777;9982.401055936667;10199.065499451151;10296.07335339823;10631.415272160106;10077.69766906994;10166.491675416348;10365.585376584851;10610;10794.56821727122;8936.508492033001;9594.232461402931;9766.609335626496;10170.288079834341;11005.61480348184;9056.320775941698;9093.590788414405;9175.816483670156;9228.95385523068;9325.207357374698;8557.44376615518;8922.55387230649;9092.499912504876;9133.908660913306;9235.07649235071 03:19:12 INFO - 2015-12-08 03:19:12,000 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,317 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: __startTimestamp1449573551990__endTimestamp 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,001 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4704.40 Median:4803.95 stddev:491.04 (10.2%) stddev-sans-first:465.69 03:19:12 INFO - 2015-12-08 03:19:12,002 DEBUG : BROWSER_OUTPUT: Values: 2662.5 2669.5 2704.7 2717.7 2727.4 4582.9 4733.6 4756.5 4761.8 4783.3 4634.2 4720.6 4739.1 4762.1 4772.8 4339.8 4389.3 4479.8 4481.6 4516.1 4250.3 4388.6 4430.9 4441.6 4528.1 4285.4 4307.6 4377.2 4399.1 4411.0 4439.5 4443.4 4451.0 4453.9 4501.3 4192.5 4297.9 4423.4 4439.9 4465.7 4616.2 4651.3 4665.5 4713.3 4717.3 5132.5 5149.6 5151.4 5155.7 5158.9 4702.2 4915.3 4927.0 5172.3 5237.8 4663.6 4733.8 4745.6 4762.8 4787.6 5240.4 5242.1 5245.8 5248.8 5284.8 4847.9 4930.9 4935.8 5022.6 5023.9 5095.2 5095.7 5118.2 5121.8 5174.9 5047.2 5057.3 5060.4 5063.9 5097.2 4804.0 4890.8 4958.5 5036.4 5072.1 4296.4 4300.2 4302.1 4316.1 4339.0 3783.0 3785.8 3799.3 3813.9 3820.5 4218.2 4296.9 4345.4 4407.9 4440.9 5150.6 5164.3 5194.4 5202.0 5234.8 4242.9 4394.6 4428.2 4450.0 4479.1 4464.5 4493.3 4506.6 4517.1 4517.4 4793.0 4850.4 4860.2 4861.5 4861.7 4913.6 5140.0 5143.3 5149.9 5202.6 4764.3 4777.5 4809.4 4824.3 4866.8 5022.1 5035.4 5040.9 5070.2 5080.8 4879.8 4973.0 5123.4 5125.9 5163.0 4921.2 4952.9 4956.4 4969.3 5008.7 4917.7 5067.4 5068.5 5069.3 5124.1 4646.8 4722.6 4745.7 4950.7 5014.0 5001.9 5005.7 5014.4 5031.0 5048.9 4886.0 4904.0 4911.6 4934.2 4974.1 03:19:12 INFO - 2015-12-08 03:19:12,002 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,002 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40092.42 Median:32541.59 stddev:64040.50 (196.8%) stddev-sans-first:64151.19 03:19:12 INFO - 2015-12-08 03:19:12,002 DEBUG : BROWSER_OUTPUT: Values: 509.3 533.4 537.8 539.4 579.6 26913.9 36059.8 36549.6 36595.8 36635.5 39404.8 40050.0 40053.0 40073.4 40106.2 7833.4 7897.8 7949.9 7963.6 8010.7 7672.3 7853.0 7853.7 7873.7 7917.3 7798.5 7818.1 7845.4 7896.6 7906.0 7815.5 7815.8 7870.4 7897.7 7915.5 7656.6 7779.8 7792.3 7803.7 7808.9 36766.6 37266.3 37352.8 37367.0 37401.4 2686.1 2916.7 3020.0 3514.5 3526.2 28007.3 28155.4 28391.9 28430.6 28758.0 3156.7 3292.8 3303.6 3344.2 3378.9 210916.0 211049.0 211953.0 211958.0 286445.0 43660.8 54939.7 56535.2 56624.4 56713.0 55087.0 55139.7 55509.7 55604.7 55648.4 14107.4 14119.6 14155.4 14220.5 14300.6 10914.2 11095.5 11161.5 11176.3 11203.4 18751.9 18896.8 18929.6 18972.4 18980.9 6955.8 7214.2 7224.7 7247.1 7398.9 807.5 909.8 953.5 965.4 1003.4 25957.6 26278.7 26287.9 26291.3 26324.9 917.8 967.7 968.3 968.4 1039.4 13908.3 13921.6 13957.0 14111.9 14690.0 253949.0 259422.0 260036.0 260424.0 260607.0 45002.8 45310.5 45324.0 45497.8 45532.8 1238.7 1244.3 1247.0 1254.9 1258.0 26090.9 26264.7 26865.9 26884.7 26926.3 39466.8 40005.0 40293.4 40318.6 40381.4 247426.0 247561.0 249512.0 250067.0 250493.0 27980.2 29020.0 29378.8 29596.7 29630.0 33582.8 33638.5 33670.5 34350.3 34406.3 30023.7 31378.7 32020.8 32400.7 32682.5 31705.4 31737.4 31765.2 31798.2 31896.4 28558.3 29145.3 29462.9 29546.4 29702.9 25948.0 26290.6 26910.7 27325.0 27539.9 23289.7 23681.9 24037.4 24309.0 24853.3 03:19:12 INFO - 2015-12-08 03:19:12,002 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,002 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26621.86 Median:4102.60 stddev:79944.07 (1948.6%) stddev-sans-first:80143.87 03:19:12 INFO - 2015-12-08 03:19:12,003 DEBUG : BROWSER_OUTPUT: Values: 281.7 281.9 282.3 282.9 285.8 13053.2 13324.4 15198.8 15620.8 15691.3 10337.7 10398.7 10494.7 14969.7 16273.7 4516.4 4546.5 4594.8 4604.3 4624.7 4486.6 4841.7 5037.8 5041.5 5042.0 4955.0 5007.1 5015.7 5033.0 5186.3 5174.6 5194.3 5215.9 5230.2 5241.3 5021.3 5032.8 5039.7 5046.3 5050.2 18282.2 18388.7 18850.7 18883.8 18897.6 1705.2 1796.2 1810.2 1814.6 1846.7 9122.4 9245.7 11452.3 12779.0 13099.9 1739.1 1748.3 1794.1 1795.3 1798.5 56026.4 57981.0 58366.1 58460.7 59006.0 9463.8 9679.7 9740.7 9748.2 9752.6 12338.0 12355.4 12412.5 12418.2 12455.3 6802.0 6845.1 6853.7 6873.2 6875.1 6288.3 6337.2 6356.4 6367.7 6377.8 3971.1 4044.5 4099.3 4105.9 4126.1 1692.3 1743.1 1752.0 1757.7 1765.5 819.3 841.4 853.2 929.9 989.6 15363.2 15654.1 16194.2 16305.9 17485.2 838.0 843.1 848.3 852.0 855.3 9312.9 9343.3 9374.4 9448.2 9574.2 462327.0 487266.0 489763.0 500031.0 504183.0 69745.7 73668.0 74920.0 75547.0 78190.0 1055.3 1062.9 1068.1 1102.5 1105.0 14092.9 14098.4 14112.7 14135.2 14288.5 33937.0 34564.5 34805.0 35155.8 35443.5 44408.3 45232.0 46398.0 46894.5 47087.3 8380.8 8474.6 8476.4 8532.4 8595.1 12742.7 15100.9 15449.0 15559.4 15670.2 13544.3 13694.3 13961.8 13970.4 14047.7 12962.5 13149.7 13477.8 13877.0 13908.7 13266.4 13848.9 14049.8 14274.6 14446.1 8288.8 8804.7 8829.6 8887.1 8915.2 12873.5 13708.7 14078.6 14210.0 14816.5 03:19:12 INFO - 2015-12-08 03:19:12,003 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,003 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4911.96 Median:6297.86 stddev:2597.58 (41.2%) stddev-sans-first:2592.12 03:19:12 INFO - 2015-12-08 03:19:12,003 DEBUG : BROWSER_OUTPUT: Values: 1487.7 1623.4 1645.6 1650.6 1695.5 6945.4 7046.4 7209.9 7231.1 7271.2 7195.8 7213.8 7259.6 7289.6 7291.9 2038.3 2095.6 2095.9 2096.1 2097.8 2052.9 2080.2 2082.3 2088.4 2099.6 1986.4 2052.4 2065.3 2065.3 2083.8 1950.3 2023.3 2024.1 2027.9 2031.4 2035.4 2083.7 2087.6 2089.6 2096.0 6980.5 7021.0 7048.8 7053.2 7086.0 4154.0 4194.9 4209.9 4212.3 4235.6 2737.7 2752.3 2810.8 2820.0 2830.0 843.0 850.4 857.5 861.2 901.0 9573.8 9689.7 9690.9 9715.1 9743.6 3549.5 3656.1 3694.9 3700.8 3730.4 7674.0 7681.7 7688.4 7696.4 7698.9 4186.7 4193.5 4201.4 4208.4 4225.5 3851.3 3852.2 3854.6 3858.2 3870.4 2987.1 3013.8 3015.5 3018.6 3027.4 848.6 851.0 851.7 852.8 853.8 743.2 747.5 843.7 920.5 937.7 6437.7 6489.8 6499.8 6501.9 6522.3 563.6 567.8 574.1 580.3 720.4 5015.2 5090.2 5095.2 5114.3 5117.1 8197.3 8597.2 8652.0 8676.0 8683.8 8490.8 8529.3 8530.4 8544.3 8556.5 6198.5 6303.8 6305.5 6776.6 6793.5 6619.3 6664.5 6691.9 6696.3 6725.5 7430.9 7715.3 7727.2 7754.1 7784.7 7620.6 7871.3 7883.4 7899.7 7991.3 6191.8 6229.9 6244.3 6248.8 6291.0 6893.0 6903.1 6961.2 6971.5 6987.7 6191.6 6372.2 6418.0 6480.8 6611.5 5345.7 6111.3 6120.9 6138.7 6291.9 6395.6 6408.5 6454.9 6465.5 6475.8 5814.5 5832.9 5842.8 5847.4 5868.7 5811.7 6008.1 6010.9 6029.8 6033.1 03:19:12 INFO - 2015-12-08 03:19:12,004 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,004 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4864.54 Median:5665.81 stddev:1526.81 (26.9%) stddev-sans-first:1491.50 03:19:12 INFO - 2015-12-08 03:19:12,004 DEBUG : BROWSER_OUTPUT: Values: 261.7 263.8 266.7 266.7 270.7 5646.9 5656.3 5657.5 5705.1 5822.2 5642.7 5657.2 5659.5 5672.1 5696.5 4040.2 4119.8 4120.1 4169.9 4170.4 4127.1 4130.4 4134.7 4137.2 4147.0 4072.9 4076.4 4082.5 4093.2 4114.5 4057.2 4091.7 4093.1 4094.6 4104.6 3443.5 3446.2 3470.9 3476.9 3496.7 5353.5 5376.5 5410.6 5425.4 5430.1 4732.9 4753.2 4755.6 4757.6 4765.0 5847.6 5878.6 5885.3 5906.7 5913.6 3762.9 3822.6 3868.5 3894.1 3902.1 6196.5 6256.7 6313.0 6318.7 6334.1 3967.2 3969.3 3969.5 3970.5 3983.4 4024.8 4029.6 4033.5 4043.0 4049.5 4594.4 4597.1 4739.9 4746.4 4759.0 5940.6 5956.4 5956.8 5959.3 5967.0 1409.2 1417.5 1424.8 1426.0 1429.5 900.1 909.9 923.7 928.7 932.9 5131.4 5132.5 5139.9 5145.9 5162.9 6200.8 6212.3 6219.1 6227.7 6239.5 5165.5 5168.3 5168.8 5170.7 5173.5 3259.6 3328.5 3370.2 3372.1 3379.9 5845.2 5846.3 5849.9 5877.3 5907.2 6478.8 6480.5 6484.6 6494.9 6513.3 5739.1 5841.8 5905.4 5908.1 5918.8 6300.1 6307.2 6309.0 6312.1 6312.9 6069.0 6114.6 6131.5 6134.5 6137.0 5737.3 5870.3 5878.6 5884.8 5903.4 3991.6 4020.1 4037.0 4045.3 4045.4 5950.4 6058.9 6227.3 6281.9 6316.4 5887.9 5958.5 6042.1 6055.9 6057.5 5939.9 6019.2 6031.3 6033.6 6041.2 5696.7 5886.1 5887.7 5898.9 5911.7 6020.1 6020.9 6053.8 6068.5 6085.6 5936.9 5937.8 5940.3 5941.8 5948.7 03:19:12 INFO - 2015-12-08 03:19:12,004 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,005 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12164.33 Median:459.62 stddev:13706.74 (2982.2%) stddev-sans-first:13717.75 03:19:12 INFO - 2015-12-08 03:19:12,005 DEBUG : BROWSER_OUTPUT: Values: 615.0 655.6 665.8 734.6 735.3 11279.3 11565.9 11584.1 11592.4 11636.4 13720.6 13965.2 13968.8 13971.5 13985.0 780.6 787.7 797.3 800.7 801.6 799.0 800.1 805.0 806.3 806.5 820.1 823.4 832.1 832.3 832.3 819.0 821.0 824.6 827.0 828.5 606.8 611.4 613.5 614.1 614.8 11619.9 11653.2 11715.4 11737.8 11742.7 10836.5 10949.0 11178.3 11223.9 11273.8 9133.5 9160.4 9384.6 9515.8 9526.6 3185.6 3218.5 3225.6 3275.3 3280.4 39552.4 39722.0 40033.8 40148.6 40194.2 8547.1 8671.8 8730.5 8981.6 9001.9 15416.0 15522.0 15593.8 15611.0 15646.8 5966.6 6300.5 6340.6 6520.4 6587.1 3525.4 3571.8 3595.5 3689.4 3700.2 2572.4 2592.8 2616.1 2618.2 2620.0 464.4 467.9 469.1 481.3 482.0 454.8 514.4 552.5 578.1 581.7 7551.5 7752.9 7961.8 7984.3 7991.7 439.7 516.3 555.9 609.9 625.6 3636.8 3664.0 3712.4 3759.1 3783.0 48332.8 48812.0 48909.5 49041.0 49100.8 44415.3 44475.3 44959.6 45064.5 45325.5 39990.4 40226.2 40409.4 40441.0 40684.0 7547.2 7586.8 8179.9 8301.5 8412.7 29814.6 30466.5 30533.1 30636.2 32162.0 38941.4 39341.6 39507.8 40097.4 40402.2 9943.5 10054.3 10055.7 10113.1 10323.2 11217.6 11268.5 11271.7 11585.4 11628.3 9981.4 9982.4 10199.1 10296.1 10631.4 10077.7 10166.5 10365.6 10610.0 10794.6 8936.5 9594.2 9766.6 10170.3 11005.6 9056.3 9093.6 9175.8 9229.0 9325.2 8557.4 8922.6 9092.5 9133.9 9235.1 03:19:12 INFO - 2015-12-08 03:19:12,005 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:19:12 INFO - 2015-12-08 03:19:12,005 DEBUG : BROWSER_OUTPUT: 03:19:12 INFO - 2015-12-08 03:19:12,745 INFO : Browser exited with error code: 0 03:19:12 INFO - 2015-12-08 03:19:12,768 INFO : Completed test dromaeo_css (00:18:35) 03:19:12 INFO - 2015-12-08 03:19:12,768 INFO : Starting test kraken 03:19:12 INFO - 2015-12-08 03:19:12,768 DEBUG : operating with platform_type : linux_ 03:19:12 INFO - 2015-12-08 03:19:12,768 INFO : Initialising browser for kraken test... 03:19:12 INFO - 2015-12-08 03:19:12,775 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp04jUqF/profile http://localhost:52917/getInfo.html 03:19:17 INFO - 2015-12-08 03:19:17,436 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:19:17 INFO - 2015-12-08 03:19:17,436 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:19:17 INFO - 2015-12-08 03:19:17,436 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:19:17 INFO - 2015-12-08 03:19:17,436 DEBUG : BROWSER_OUTPUT: __metrics 03:19:17 INFO - 2015-12-08 03:19:17,539 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:19:18 INFO - 2015-12-08 03:19:18,536 INFO : Browser initialized. 03:19:18 INFO - 2015-12-08 03:19:18,537 INFO : Running cycle 1/1 for kraken test... 03:19:18 INFO - 2015-12-08 03:19:18,537 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp04jUqF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:19:30 INFO - 2015-12-08 03:19:30,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 143364096 03:19:30 INFO - 2015-12-08 03:19:30,601 DEBUG : BROWSER_OUTPUT: 03:19:33 INFO - 2015-12-08 03:19:33,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52917/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:33 INFO - 2015-12-08 03:19:33,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 143118336 03:19:33 INFO - 2015-12-08 03:19:33,826 DEBUG : BROWSER_OUTPUT: 03:19:36 INFO - 2015-12-08 03:19:36,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52917/tests/kraken/driver.html?testName=audio-dft) 03:19:37 INFO - 2015-12-08 03:19:37,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 143331328 03:19:37 INFO - 2015-12-08 03:19:37,164 DEBUG : BROWSER_OUTPUT: 03:19:40 INFO - 2015-12-08 03:19:40,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52917/tests/kraken/driver.html?testName=audio-fft) 03:19:40 INFO - 2015-12-08 03:19:40,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 03:19:40 INFO - 2015-12-08 03:19:40,670 DEBUG : BROWSER_OUTPUT: 03:19:42 INFO - 2015-12-08 03:19:42,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52917/tests/kraken/driver.html?testName=audio-oscillator) 03:19:43 INFO - 2015-12-08 03:19:43,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 139857920 03:19:43 INFO - 2015-12-08 03:19:43,385 DEBUG : BROWSER_OUTPUT: 03:19:45 INFO - 2015-12-08 03:19:45,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52917/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:46 INFO - 2015-12-08 03:19:46,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 141185024 03:19:46 INFO - 2015-12-08 03:19:46,228 DEBUG : BROWSER_OUTPUT: 03:19:49 INFO - 2015-12-08 03:19:49,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52917/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:49 INFO - 2015-12-08 03:19:49,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 139665408 03:19:49 INFO - 2015-12-08 03:19:49,885 DEBUG : BROWSER_OUTPUT: 03:19:53 INFO - 2015-12-08 03:19:53,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52917/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:53 INFO - 2015-12-08 03:19:53,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 138014720 03:19:53 INFO - 2015-12-08 03:19:53,957 DEBUG : BROWSER_OUTPUT: 03:19:56 INFO - 2015-12-08 03:19:56,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52917/tests/kraken/driver.html?testName=json-parse-financial) 03:19:57 INFO - 2015-12-08 03:19:57,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 137875456 03:19:57 INFO - 2015-12-08 03:19:57,475 DEBUG : BROWSER_OUTPUT: 03:19:59 INFO - 2015-12-08 03:19:59,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52917/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:59 INFO - 2015-12-08 03:19:59,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 141094912 03:19:59 INFO - 2015-12-08 03:19:59,899 DEBUG : BROWSER_OUTPUT: 03:20:01 INFO - 2015-12-08 03:20:01,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:02 INFO - 2015-12-08 03:20:02,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 141774848 03:20:02 INFO - 2015-12-08 03:20:02,399 DEBUG : BROWSER_OUTPUT: 03:20:04 INFO - 2015-12-08 03:20:04,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:05 INFO - 2015-12-08 03:20:05,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 141144064 03:20:05 INFO - 2015-12-08 03:20:05,206 DEBUG : BROWSER_OUTPUT: 03:20:07 INFO - 2015-12-08 03:20:07,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:08 INFO - 2015-12-08 03:20:08,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 141742080 03:20:08 INFO - 2015-12-08 03:20:08,388 DEBUG : BROWSER_OUTPUT: 03:20:11 INFO - 2015-12-08 03:20:11,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:11 INFO - 2015-12-08 03:20:11,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 139460608 03:20:11 INFO - 2015-12-08 03:20:11,618 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52917/tests/kraken/driver.html?testName=ai-astar) 03:20:13 INFO - 2015-12-08 03:20:13,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 141340672 03:20:13 INFO - 2015-12-08 03:20:13,654 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,657 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:20:13 INFO - 2015-12-08 03:20:13,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:20:13 INFO - 2015-12-08 03:20:13,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:20:13 INFO - 2015-12-08 03:20:13,657 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:20:13 INFO - 2015-12-08 03:20:13,658 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;109;114;115;115;124;114;112;115;115 03:20:13 INFO - 2015-12-08 03:20:13,658 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;132;152;165;131;150;156;130;182;133 03:20:13 INFO - 2015-12-08 03:20:13,658 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;165;163;161;165;166;165;164;164;164 03:20:13 INFO - 2015-12-08 03:20:13,658 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;72;72;73;136;72;73;73 03:20:13 INFO - 2015-12-08 03:20:13,658 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;93;128;94;94;94;130;95;95;140 03:20:13 INFO - 2015-12-08 03:20:13,658 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;110;111 03:20:13 INFO - 2015-12-08 03:20:13,658 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;150;150;149;148;148;148;148;149;147 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;95;96;96;95;95 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;77;77;80;76;77;77;78;78;78;76 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;68;70;69;69;69;68;70 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;85;84;84;92;86;86;84;84 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;131;120;136;129;136;129;123;122;124 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;153;155;148;150;151;151;153;156;137 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;71;71;74;69;71;69;71;69 03:20:13 INFO - 2015-12-08 03:20:13,659 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:20:13 INFO - 2015-12-08 03:20:13,660 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:20:13 INFO - 2015-12-08 03:20:13,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,792 03:20:13 INFO - 2015-12-08 03:20:13,660 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:20:13 INFO - 2015-12-08 03:20:13,660 DEBUG : BROWSER_OUTPUT: __startTimestamp1449573613655__endTimestamp 03:20:13 INFO - 2015-12-08 03:20:13,660 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:3.77 (3.3%) stddev-sans-first:3.99 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 114.0 115.0 115.0 124.0 114.0 112.0 115.0 115.0 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:154.00 stddev:17.91 (11.6%) stddev-sans-first:18.11 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: Values: 165.0 132.0 152.0 165.0 131.0 150.0 156.0 130.0 182.0 133.0 03:20:13 INFO - 2015-12-08 03:20:13,668 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 163.0 161.0 165.0 166.0 165.0 164.0 164.0 164.0 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:72.50 stddev:20.10 (27.7%) stddev-sans-first:21.17 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 72.0 72.0 73.0 136.0 72.0 73.0 73.0 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:18.73 (19.9%) stddev-sans-first:19.53 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: Values: 96.0 93.0 128.0 94.0 94.0 94.0 130.0 95.0 95.0 140.0 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: Values: 148.0 150.0 150.0 149.0 148.0 148.0 148.0 148.0 149.0 147.0 03:20:13 INFO - 2015-12-08 03:20:13,669 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:77.40 Median:77.50 stddev:1.17 (1.5%) stddev-sans-first:1.24 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 80.0 76.0 77.0 77.0 78.0 78.0 78.0 76.0 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.78 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 68.0 70.0 69.0 69.0 69.0 68.0 70.0 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:2.57 (3.0%) stddev-sans-first:2.69 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 85.0 84.0 84.0 92.0 86.0 86.0 84.0 84.0 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:129.00 stddev:5.97 (4.6%) stddev-sans-first:5.91 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: Values: 121.0 131.0 120.0 136.0 129.0 136.0 129.0 123.0 122.0 124.0 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,670 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:152.00 stddev:5.67 (3.7%) stddev-sans-first:5.61 03:20:13 INFO - 2015-12-08 03:20:13,671 DEBUG : BROWSER_OUTPUT: Values: 144.0 153.0 155.0 148.0 150.0 151.0 151.0 153.0 156.0 137.0 03:20:13 INFO - 2015-12-08 03:20:13,671 DEBUG : BROWSER_OUTPUT: 03:20:13 INFO - 2015-12-08 03:20:13,671 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.57 (2.2%) stddev-sans-first:1.64 03:20:13 INFO - 2015-12-08 03:20:13,671 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 71.0 71.0 74.0 69.0 71.0 69.0 71.0 69.0 03:20:13 INFO - 2015-12-08 03:20:13,671 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:20:13 INFO - 2015-12-08 03:20:13,671 DEBUG : BROWSER_OUTPUT: 03:20:14 INFO - 2015-12-08 03:20:14,629 INFO : Browser exited with error code: 0 03:20:14 INFO - 2015-12-08 03:20:14,674 INFO : Completed test kraken (00:01:01) 03:20:14 INFO - 2015-12-08 03:20:14,674 INFO : Starting test v8_7 03:20:14 INFO - 2015-12-08 03:20:14,675 DEBUG : operating with platform_type : linux_ 03:20:14 INFO - 2015-12-08 03:20:14,675 INFO : Initialising browser for v8_7 test... 03:20:14 INFO - 2015-12-08 03:20:14,681 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpimC3gy/profile http://localhost:52917/getInfo.html 03:20:19 INFO - 2015-12-08 03:20:19,300 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:20:19 INFO - 2015-12-08 03:20:19,301 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:20:19 INFO - 2015-12-08 03:20:19,301 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:20:19 INFO - 2015-12-08 03:20:19,301 DEBUG : BROWSER_OUTPUT: __metrics 03:20:19 INFO - 2015-12-08 03:20:19,403 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:20:20 INFO - 2015-12-08 03:20:20,380 INFO : Browser initialized. 03:20:20 INFO - 2015-12-08 03:20:20,381 INFO : Running cycle 1/1 for v8_7 test... 03:20:20 INFO - 2015-12-08 03:20:20,381 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpimC3gy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:20:32 INFO - 2015-12-08 03:20:32,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 143245312 03:20:32 INFO - 2015-12-08 03:20:32,405 DEBUG : BROWSER_OUTPUT: 03:20:53 INFO - 2015-12-08 03:20:53,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52917/tests/v8_7/run.html (next: http://localhost:52917/tests/v8_7/run.html) 03:20:54 INFO - 2015-12-08 03:20:54,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 138248192 03:20:54 INFO - 2015-12-08 03:20:54,156 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,156 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:20:54 INFO - 2015-12-08 03:20:54,156 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:20:54 INFO - 2015-12-08 03:20:54,157 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:20:54 INFO - 2015-12-08 03:20:54,157 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:20:54 INFO - 2015-12-08 03:20:54,157 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0437365901964 03:20:54 INFO - 2015-12-08 03:20:54,157 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.84288354898337 03:20:54 INFO - 2015-12-08 03:20:54,157 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 03:20:54 INFO - 2015-12-08 03:20:54,157 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 03:20:54 INFO - 2015-12-08 03:20:54,158 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 03:20:54 INFO - 2015-12-08 03:20:54,158 DEBUG : BROWSER_OUTPUT: |5;Earley;715.8196134574088 03:20:54 INFO - 2015-12-08 03:20:54,158 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 03:20:54 INFO - 2015-12-08 03:20:54,158 DEBUG : BROWSER_OUTPUT: |7;RegExp;26256.410256410258 03:20:54 INFO - 2015-12-08 03:20:54,158 DEBUG : BROWSER_OUTPUT: |8;Splay;595.7446808510638 03:20:54 INFO - 2015-12-08 03:20:54,158 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 03:20:54 INFO - 2015-12-08 03:20:54,158 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:20:54 INFO - 2015-12-08 03:20:54,159 DEBUG : BROWSER_OUTPUT: __startTimestamp1449573654154__endTimestamp 03:20:54 INFO - 2015-12-08 03:20:54,159 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,159 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:20:54 INFO - 2015-12-08 03:20:54,160 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:20:54 INFO - 2015-12-08 03:20:54,160 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,160 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.04 Median:165.04 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,161 DEBUG : BROWSER_OUTPUT: Values: 165.0 03:20:54 INFO - 2015-12-08 03:20:54,161 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,161 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.84 Median:184.84 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,161 DEBUG : BROWSER_OUTPUT: Values: 184.8 03:20:54 INFO - 2015-12-08 03:20:54,161 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,161 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,161 DEBUG : BROWSER_OUTPUT: Values: 278.4 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: Values: 5202.1 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: Values: 1071.8 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,162 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.82 Median:715.82 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,163 DEBUG : BROWSER_OUTPUT: Values: 715.8 03:20:54 INFO - 2015-12-08 03:20:54,163 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,163 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,163 DEBUG : BROWSER_OUTPUT: Values: 12419.8 03:20:54 INFO - 2015-12-08 03:20:54,163 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,163 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,163 DEBUG : BROWSER_OUTPUT: Values: 26256.4 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.74 Median:595.74 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: Values: 595.7 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: Values: 4835.7 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:20:54 INFO - 2015-12-08 03:20:54,164 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,117 INFO : Browser exited with error code: 0 03:20:55 INFO - 2015-12-08 03:20:55,129 INFO : Completed test v8_7 (00:00:40) 03:20:55 INFO - 2015-12-08 03:20:55,173 INFO : Completed test suite (00:20:18) 03:20:55 INFO - 2015-12-08 03:20:55,174 DEBUG : Working with test: dromaeo_css 03:20:55 INFO - 2015-12-08 03:20:55,174 DEBUG : Generating results file: dromaeo_css 03:20:55 INFO - 2015-12-08 03:20:55,175 DEBUG : Working with test: kraken 03:20:55 INFO - 2015-12-08 03:20:55,175 DEBUG : Generating results file: kraken 03:20:55 INFO - 2015-12-08 03:20:55,176 INFO : javascript benchmark 03:20:55 INFO - 2015-12-08 03:20:55,176 DEBUG : Working with test: v8_7 03:20:55 INFO - 2015-12-08 03:20:55,176 DEBUG : Generating results file: v8_7 03:20:55 INFO - 2015-12-08 03:20:55,176 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:55 INFO - 2015-12-08 03:20:55,229 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:20:55 INFO - 2015-12-08 03:20:55,229 DEBUG : process_Request line: dromaeo_css 6294.27 graph.html#tests=[[72,132,43]] 03:20:55 INFO - 2015-12-08 03:20:55,230 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:55 INFO - 2015-12-08 03:20:55,259 DEBUG : process_Request line: kraken 1546.20 graph.html#tests=[[232,132,43]] 03:20:55 INFO - 2015-12-08 03:20:55,259 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:55 INFO - 2015-12-08 03:20:55,287 DEBUG : process_Request line: v8_7 21340.74 graph.html#tests=[[230,132,43]] 03:20:55 INFO - 2015-12-08 03:20:55,288 INFO : javascript benchmark 03:20:55 INFO - 2015-12-08 03:20:55,291 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2662.5074361243164, 2669.506141363849, 2704.7430494103064, 2717.660292463442, 2727.399972006158, 4582.862514124582, 4733.644976626754, 4756.476787553366, 4761.785719642616, 4783.330333753273, 4634.189016922042, 4720.575148236658, 4739.123262196487, 4762.1428142934255, 4772.80908763649, 4339.761313127777, 4389.3196554534015, 4479.7984090716, 4481.596656300932, 4516.1193567254395, 4250.2562051641, 4388.626966707818, 4430.933535996963, 4441.600255976961, 4528.071745292224, 4285.35719642053, 4307.569243075714, 4377.190219809314, 4399.098184872094, 4410.977945110254, 4439.467263928349, 4443.37792709021, 4450.977745111286, 4453.866384008485, 4501.347304640809, 4192.538820729717, 4297.892552686177, 4423.424954755893, 4439.933400998988, 4465.732056076646, 4616.192166370872, 4651.348811166439, 4665.486796452387, 4713.316569097496, 4717.268823332389, 5132.486751324875, 5149.588032957355, 5151.407588127376, 5155.71643559604, 5158.871028224287, 4702.153612349775, 4915.311856340079, 4927.0, 5172.32759741235, 5237.816676416307, 4663.626909847204, 4733.810647574127, 4745.596624286905, 4762.809487620457, 4787.616990640775, 5240.3973543042275, 5242.135047717084, 5245.763940622681, 5248.790048398021, 5284.841454756363, 4847.927281090787, 4930.9013819723405, 4935.802567897315, 5022.6233032522705, 5023.899522009539, 5095.159298715745, 5095.719735414514, 5118.181091025418, 5121.8463446096675, 5174.922376164361, 5047.192449208183, 5057.342545469065, 5060.443351231362, 5063.949360506348, 5097.235414687752, 4803.951960480351, 4890.779914903838, 4958.528939750718, 5036.370453693288, 5072.137736584789, 4296.419983302214, 4300.182965236595, 4302.075053863435, 4316.072044510445, 4339.045410009793, 3782.962170378316, 3785.7917814519915, 3799.2781371539318, 3813.923721525554, 3820.522434695663, 4218.198542276958, 4296.914061718748, 4345.435093437896, 4407.933880991788, 4440.933385999213, 5150.639455238173, 5164.302819119371, 5194.376674798973, 5201.973990130101, 5234.7906083756225, 4242.85150019754, 4394.560543945579, 4428.202923473741, 4450.043240703199, 4479.148961697267, 4464.4865840428765, 4493.326001099861, 4506.6169375602785, 4517.11916176349, 4517.390152329459, 4792.95207047925, 4850.442199147144, 4860.173770459101, 4861.51384861511, 4861.708297502161, 4913.582345500672, 5140.0, 5143.254228136974, 5149.922751158811, 5202.609804264771, 4764.285357196448, 4777.522247775195, 4809.398825146856, 4824.252240902666, 4866.756662166948, 5022.096022715946, 5035.370578677665, 5040.924386134284, 5070.188769796815, 5080.796768129381, 4879.829205977774, 4973.0, 5123.38519377677, 5125.948740512547, 5163.044836705221, 4921.237208232729, 4952.925706114339, 4956.405231372259, 4969.254611808257, 5008.69947803133, 4917.655764096622, 5067.391912970467, 5068.493150684902, 5069.264956581349, 5124.052050370693, 4646.8141274348645, 4722.5513576210205, 4745.691530050535, 4950.6782059166035, 5013.974930125326, 5001.949980500149, 5005.749712514433, 5014.4484106747495, 5030.974845125751, 5048.873778155576, 4885.975570122127, 4904.043711476371, 4911.63162762787, 4934.18585933317, 4974.054929563516], "unit": "ms", "name": "dojo.html", "value": 4673.835109486612}, {"lowerIsBetter": false, "replicates": [509.3404041765913, 533.410581307655, 537.8252068077875, 539.4443722965345, 579.5913880714091, 26913.865430672842, 36059.81970090149, 36549.634503654954, 36595.81702091486, 36635.45046824296, 39404.80297598515, 40050.0, 40053.0, 40073.398899016465, 40106.19787604246, 7833.412494062954, 7897.763067107996, 7949.880751788728, 7963.60181990901, 8010.719624813133, 7672.3478504327195, 7852.960735196316, 7853.685852565891, 7873.685052597889, 7917.287444130027, 7798.532088074734, 7818.14000459949, 7845.372370210398, 7896.60516974149, 7905.960470197641, 7815.452918295721, 7815.765527034198, 7870.449068565203, 7897.6840926362875, 7915.525068495908, 7656.61716914152, 7779.805504862367, 7792.259735325135, 7803.726869559595, 7808.921910780877, 36766.632333676585, 37266.254674906624, 37352.813235933645, 37367.0, 37401.43897841507, 2686.1404350607813, 2916.7083291670874, 3020.0486846643457, 3514.4728290756593, 3526.2418580005165, 28007.29981750452, 28155.43689126206, 28391.858040709663, 28430.573541396894, 28758.0, 3156.6685498022607, 3292.818894960776, 3303.5540202072893, 3344.185699729095, 3378.8986330410125, 210916.0, 211049.0, 211953.0, 211958.0, 286444.9999999979, 43660.78169609132, 54939.725301374034, 56535.15197272044, 56624.433755661914, 56713.0, 55087.0, 55139.724301378235, 55509.72245138748, 55604.72197639067, 55648.44351556433, 14107.435702571987, 14119.647008824657, 14155.433782648784, 14220.502282420273, 14300.570982870531, 10914.236003479838, 11095.50070246841, 11161.497732602053, 11176.329420234812, 11203.383813890152, 18751.90624046871, 18896.811031889505, 18929.621407571773, 18972.430827075208, 18980.905095474434, 6955.756548520778, 7214.206437291894, 7224.747133850396, 7247.094113235846, 7398.926010739931, 807.5356669914822, 909.8316811389914, 953.5041778275258, 965.35803690545, 1003.3528374198747, 25957.610635840476, 26278.73721262801, 26287.868560657458, 26291.342716432242, 26324.868375658, 917.7659696777279, 967.7403263380087, 968.3028219681959, 968.4286271100085, 1039.443897514841, 13908.304584770722, 13921.582352529238, 13957.0, 14111.858881411259, 14690.0, 253949.0, 259422.0, 260036.0, 260424.0, 260607.0, 45002.77498612486, 45310.54689453129, 45324.0, 45497.772511137235, 45532.77233613877, 1238.6655602987144, 1244.3156264054733, 1247.014858261981, 1254.943527541263, 1257.9811302830465, 26090.86954565291, 26264.73735262623, 26865.865670672305, 26884.731152689004, 26926.326841828326, 39466.802665986484, 40005.0, 40293.39559906662, 40318.59681403266, 40381.394279086424, 247426.0, 247561.0, 249512.0, 250067.0, 250493.0, 27980.160595182177, 29020.0, 29378.796590255388, 29596.704032959395, 29630.0, 33582.832085839415, 33638.47711421702, 33670.49494257539, 34350.31299374049, 34406.311873761886, 30023.69976300209, 31378.686213137575, 32020.83989580037, 32400.675993239765, 32682.509762353107, 31705.36589268248, 31737.365252694355, 31765.20586985344, 31798.205044874063, 31896.36207275888, 28558.286042849097, 29145.271368215963, 29462.852685736434, 29546.409071818012, 29702.851485742434, 25948.0, 26290.605640915783, 26910.730892690823, 27325.0, 27539.862300688368, 23289.650655239846, 23681.881590591936, 24037.399065022815, 24309.0, 24853.25440236796], "unit": "ms", "name": "ext.html", "value": 16610.4891055352}, {"lowerIsBetter": false, "replicates": [281.66481886555, 281.9168345338126, 282.313977035803, 282.8797760951595, 285.83707286846504, 13053.216806991588, 13324.40040198191, 15198.848011519882, 15620.843791562094, 15691.293891774883, 10337.689869303915, 10398.740031499216, 10494.737631559216, 14969.7006059879, 16273.698104151668, 4516.412866327373, 4546.47715512717, 4594.839180628679, 4604.286335617984, 4624.676272660915, 4486.551344865504, 4841.741147301709, 5037.773300201499, 5041.546260836524, 5041.991601679661, 4954.984228233204, 5007.073691367091, 5015.7492125393765, 5032.974835125838, 5186.325777648919, 5174.560162386202, 5194.298769666103, 5215.895682086356, 5230.241614965847, 5241.266222728783, 5021.271915572258, 5032.84901452957, 5039.748012599392, 5046.293518907356, 5050.191969284897, 18282.177302021442, 18388.724169137473, 18850.71723924142, 18883.81116188834, 18897.62204755911, 1705.2156008236102, 1796.2276221225, 1810.167323031407, 1814.609858880347, 1846.704527275643, 9122.407043542149, 9245.72262832116, 11452.312861228353, 12779.0, 13099.934500327437, 1739.1304347826087, 1748.2657283940775, 1794.1388133695768, 1795.2998330651058, 1798.505411011969, 56026.43973560294, 57981.0, 58366.12450813241, 58460.70769646167, 59006.0, 9463.817022872141, 9679.70960871175, 9740.707778766648, 9748.171405430476, 9752.609895604097, 12338.0, 12355.444005019795, 12412.503499860086, 12418.192817467016, 12455.314957677414, 6802.0, 6845.075914751545, 6853.691583878737, 6873.243943166248, 6875.140607424072, 6288.339724328971, 6337.2395312562785, 6356.396142366468, 6367.681615919186, 6377.808665740035, 3971.126352202511, 4044.5348784890116, 4099.323611604052, 4105.876823695294, 4126.051008268115, 1692.33152904602, 1743.128435782109, 1751.9649607008043, 1757.674830156425, 1765.496833402474, 819.3035919468405, 841.3647695989489, 853.2406158518924, 929.9023602521773, 989.6387818446216, 15363.23183840826, 15654.13902235388, 16194.170497492069, 16305.918470407572, 17485.213165407586, 837.9790505237296, 843.0894633795486, 848.3128665780614, 851.9829603408022, 855.3242938078972, 9312.90687093134, 9343.299252556086, 9374.437533747998, 9448.244140468745, 9574.234061275081, 462327.0, 487266.0, 489763.0, 500031.0, 504183.0, 69745.65127174332, 73668.0, 74920.0, 75547.0, 78190.0, 1055.3193190392153, 1062.9043386095288, 1068.0667990936429, 1102.509383324413, 1104.9668509944715, 14092.859071409155, 14098.436062557383, 14112.717745645235, 14135.222562759147, 14288.499902503363, 33937.0, 34564.48153277753, 34805.0, 35155.824220878734, 35443.468347975315, 44408.333874992546, 45232.0, 46398.0, 46894.53105468902, 47087.293690593986, 8380.832383352177, 8474.61864216124, 8476.36427267945, 8532.402731808963, 8595.09751476086, 12742.745145097231, 15100.924495377452, 15449.0, 15559.377624894878, 15670.216489175724, 13544.255065971467, 13694.315284235548, 13961.790573141208, 13970.441182352592, 14047.719045619235, 12962.481500739865, 13149.671258218621, 13477.797833032708, 13877.028607997343, 13908.678675525809, 13266.403011864297, 13848.930755346562, 14049.789253161414, 14274.571762847132, 14446.061006034573, 8288.83422331562, 8804.691835785718, 8829.60266788009, 8887.066857979818, 8915.242204412698, 12873.485060597472, 13708.65728356799, 14078.577642670736, 14210.0, 14816.481423150139], "unit": "ms", "name": "jquery.html", "value": 8227.912071885283}, {"lowerIsBetter": false, "replicates": [1487.7247709173796, 1623.448027670592, 1645.6461860699956, 1650.64511130107, 1695.508302592248, 6945.374916257536, 7046.365827075562, 7209.927900721004, 7231.059962204906, 7271.163816161136, 7195.784126476201, 7213.783586492401, 7259.60072196029, 7289.599072051035, 7291.927080729191, 2038.2662241593052, 2095.6227878981776, 2095.947601309972, 2096.088201632287, 2097.832173426122, 2052.907619157134, 2080.1991233375106, 2082.3232449453913, 2088.3734879536155, 2099.5590925905576, 1986.3643634037114, 2052.445839623301, 2065.2771529964466, 2065.297798748425, 2083.802038806311, 1950.2783969931074, 2023.2918478532542, 2024.0992758222596, 2027.908744106504, 2031.3702752146883, 2035.3588619584784, 2083.749950005994, 2087.551176497045, 2089.6238677038127, 2095.98952005239, 6980.476464265201, 7020.964895175492, 7048.823779405505, 7053.188883278437, 7086.043384143178, 4153.958460415418, 4194.916101677949, 4209.915801683949, 4212.304969679999, 4235.639970602502, 2737.7262273772462, 2752.270648278208, 2810.8313501189996, 2820.0, 2830.037787152378, 842.9578521073922, 850.4132148817296, 857.5412154497315, 861.2464093917822, 901.0, 9573.760655983586, 9689.660861869801, 9690.90309096907, 9715.07706767856, 9743.561539730728, 3549.5385599872366, 3656.104254457675, 3694.9261014779554, 3700.833462494194, 3730.403135498307, 7674.040744906887, 7681.731139410093, 7688.423368247404, 7696.422768292288, 7698.884516732253, 4186.665066794649, 4193.496780386373, 4201.390798334224, 4208.431861698693, 4225.471816022997, 3851.30676478231, 3852.210296889131, 3854.5759966403675, 3858.1704933439446, 3870.3613903706137, 2987.05907639093, 3013.839671726357, 3015.502442097073, 3018.59249001382, 3027.409655117231, 848.5629900601195, 850.9914900851036, 851.6976473351995, 852.8464876322197, 853.8206976534873, 743.1639405668623, 747.5141158247075, 843.717354686187, 920.4523308631353, 937.704623043739, 6437.678116094176, 6489.837754056092, 6499.837504062436, 6501.902471462932, 6522.282548919615, 563.5773170122408, 567.7814041594016, 574.133059080791, 580.3007376111775, 720.4488566246825, 5015.172496538104, 5090.160123579642, 5095.15929871567, 5114.3095682083185, 5117.078925793393, 8197.262246397853, 8597.18326758957, 8652.0, 8676.0, 8683.826323473495, 8490.811286419907, 8529.317654587618, 8530.402871798915, 8544.273736732448, 8556.529390883437, 6198.535109866778, 6303.842403939938, 6305.527085468608, 6776.627285499345, 6793.45652347811, 6619.271880093283, 6664.50016248793, 6691.866162676816, 6696.296888826603, 6725.461963042847, 7430.925690743024, 7715.305622494003, 7727.150013498398, 7754.108277548155, 7784.6886124554385, 7620.618969051636, 7871.291583757489, 7883.408744344312, 7899.68401263966, 7991.320737737357, 6191.752329906753, 6229.906551401642, 6244.313125556276, 6248.812535623939, 6291.0, 6893.0, 6903.0680858083515, 6961.164660240804, 6971.51199416036, 6987.650617469005, 6191.597546159665, 6372.171617689671, 6418.0, 6480.805575832733, 6611.537192396679, 5345.679259244458, 6111.266648002268, 6120.908186377119, 6138.723757430837, 6291.874162516816, 6395.552311338161, 6408.487321014214, 6454.935450645621, 6465.450436712932, 6475.773347932988, 5814.534837212928, 5832.94167058324, 5842.795502157404, 5847.356790752929, 5868.677222752619, 5811.738471768866, 6008.068749343859, 6010.939890601213, 6029.78895738647, 6033.064874944391], "unit": "ms", "name": "mootools.html", "value": 3950.3044539623606}, {"lowerIsBetter": false, "replicates": [261.6546159070028, 263.8232384302517, 266.68797506916906, 266.68930695739465, 270.7103399362682, 5646.943530564693, 5656.2929633795775, 5657.519110875575, 5705.115707065401, 5822.184894114816, 5642.7178641067985, 5657.20799088128, 5659.51894089003, 5672.092465205568, 5696.515796157331, 4040.2323558523935, 4119.773412462313, 4120.072983578701, 4169.937450938239, 4170.436991006206, 4127.050778320988, 4130.442390277304, 4134.689898257628, 4137.1518838638, 4147.0, 4072.9389059164137, 4076.388541718736, 4082.530508991474, 4093.2018256440006, 4114.526829414611, 4057.2494088593703, 4091.6931230157707, 4093.140440507497, 4094.5700701426217, 4104.569020252875, 3443.466262729281, 3446.172918499542, 3470.889315419067, 3476.89569312921, 3496.650334966483, 5353.544948679328, 5376.489233522809, 5410.567154627621, 5425.37608175061, 5430.131179011379, 4732.905341893177, 4753.191957367221, 4755.595774359183, 4757.643176761757, 4764.95235047652, 5847.649141051551, 5878.559108066869, 5885.323187833368, 5906.704664766745, 5913.615614985012, 3762.9059273518105, 3822.5986271441375, 3868.458415821787, 3894.0654242981764, 3902.0635047588657, 6196.473299769525, 6256.749730010794, 6312.968435157841, 6318.684065796738, 6334.081558174085, 3967.2462232175794, 3969.325214713506, 3969.4839670842607, 3970.463987361727, 3983.382575700771, 4024.75851448914, 4029.5567487576345, 4033.515978082649, 4043.0498832774274, 4049.4735684360844, 4594.379758732595, 4597.103564804831, 4739.928901066487, 4746.406699162605, 4758.95241047592, 5940.6435613863305, 5956.434138756811, 5956.791512297049, 5959.255093113361, 5967.0, 1409.189715913354, 1417.496788640018, 1424.8361438434506, 1425.950091746784, 1429.5139652517985, 900.0999000999001, 909.8999110097884, 923.690563661181, 928.6563971330651, 932.8693982842408, 5131.358580177478, 5132.538071573576, 5139.948600514022, 5145.871353216199, 5162.92255616166, 6200.782972596027, 6212.347703491158, 6219.129321894939, 6227.688615569294, 6239.532035097386, 5165.457626949192, 5168.2764412982215, 5168.8449346519665, 5170.689758614495, 5173.456787037307, 3259.625143108573, 3328.500724891237, 3370.1574606348413, 3372.0895358253133, 3379.9155021124175, 5845.152452894392, 5846.327672317738, 5849.853753656107, 5877.324107727581, 5907.232059832194, 6478.838029049217, 6480.4815614750705, 6484.578502397329, 6494.902576461357, 6513.316101809241, 5739.110437882052, 5841.766329346779, 5905.379935106752, 5908.113782932594, 5918.7928422505, 6300.117983482224, 6307.180066591313, 6308.959021761541, 6312.14786003902, 6312.873742525216, 6069.0, 6114.57197996136, 6131.509479241561, 6134.539909506716, 6137.048757442603, 5737.254156959569, 5870.26621672291, 5878.588498805043, 5884.823455296348, 5903.380145084704, 3991.6207960243732, 4020.0552870076094, 4036.959630403776, 4045.271851066836, 4045.3931910213705, 5950.434708702666, 6058.939410605837, 6227.252729672468, 6281.874362512815, 6316.431521163117, 5887.852803679943, 5958.523318134452, 6042.123892035718, 6055.878882422415, 6057.454829065229, 5939.940600593939, 6019.217501724747, 6031.276246850406, 6033.637981721111, 6041.214642096499, 5696.658200507983, 5886.057600991577, 5887.735051922588, 5898.852528686817, 5911.704414779329, 6020.096985452217, 6020.939790602038, 6053.848653783514, 6068.4841788448475, 6085.6348619083, 5936.881262374642, 5937.7921772737745, 5940.287165540163, 5941.792037278848, 5948.702564871825], "unit": "ms", "name": "prototype.html", "value": 4348.591864290827}, {"lowerIsBetter": false, "replicates": [614.9938500614993, 655.5837043477393, 665.7936039827654, 734.562935053643, 735.2904447208444, 11279.32324060556, 11565.884341156587, 11584.13119016074, 11592.42037898106, 11636.360000199986, 13720.58838234852, 13965.16209027459, 13968.790468142986, 13971.510997115103, 13985.0, 780.6487080813628, 787.6967367563486, 797.2744802229972, 800.6997375984006, 801.5911884938694, 799.0291795468505, 800.1438460846896, 805.046020465747, 806.2622700229283, 806.4516129032256, 820.1306614988132, 823.4112609484217, 832.068083746205, 832.2717622080679, 832.2883934236231, 818.97133600324, 821.0188824354868, 824.5671022713094, 827.0241115483727, 828.5401602110826, 606.8270542895253, 611.425260255363, 613.5153228949125, 614.0942110387188, 614.8155553333982, 11619.883801161965, 11653.242539235007, 11715.355655439032, 11737.765244695143, 11742.708302086763, 10836.512356943957, 10949.0, 11178.27341222818, 11223.943880280627, 11273.830892536618, 9133.543322833899, 9160.404573702688, 9384.577694003787, 9515.762105947337, 9526.571304291323, 3185.649578546358, 3218.4689526228144, 3225.645179030305, 3275.3285576457006, 3280.4423248047888, 39552.40671389931, 39721.96911985096, 40033.79983100095, 40148.59851401507, 40194.19611607781, 8547.102554231717, 8671.826563468696, 8730.476171429607, 8981.640734370552, 9001.909980900107, 15416.0, 15522.0, 15593.844061559239, 15611.0, 15646.843531564766, 5966.552508561876, 6300.495960323255, 6340.587861789061, 6520.380563846427, 6587.077809106729, 3525.4183059794846, 3571.8035508047305, 3595.496630471736, 3689.409694448875, 3700.2229531798625, 2572.3954870605394, 2592.7666510014187, 2616.0974463810335, 2618.2407101940603, 2620.0305886822, 464.428752634255, 467.87601285659326, 469.08762457020765, 481.3285466773901, 481.99759001205473, 454.8180727708877, 514.3750343332869, 552.4751883890582, 578.0721941284178, 581.7492391358613, 7551.509151905108, 7752.920213818957, 7961.761147165595, 7984.281414672707, 7991.721324588154, 439.68123110744455, 516.3468212710924, 555.9444055594489, 609.9146119543268, 625.6308777821016, 3636.7636103653176, 3663.99864185385, 3712.406015037581, 3759.135398858223, 3782.981085094612, 48332.75833620809, 48812.0, 48909.51090489049, 49041.0, 49100.75449622729, 44415.33376999348, 44475.332870006976, 44959.55040449554, 45064.54935450669, 45325.54674453279, 39990.40014399786, 40226.19547609032, 40409.39385909214, 40441.0, 40683.98290042713, 7547.207543208104, 7586.848263034598, 8179.877301840358, 8301.46040507365, 8412.747617571482, 29814.552781708724, 30466.543001854545, 30533.08400747981, 30636.234094147825, 32162.0, 38941.41587876241, 39341.6065839338, 39507.802460987514, 40097.39853902136, 40402.1919561613, 9943.453110079015, 10054.29619926598, 10055.69832905014, 10113.089821915768, 10323.174146068146, 11217.55129794799, 11268.492917818554, 11271.718207044889, 11585.420728963349, 11628.302301861577, 9981.401115932777, 9982.401055936667, 10199.065499451151, 10296.07335339823, 10631.415272160106, 10077.69766906994, 10166.491675416348, 10365.585376584851, 10610.0, 10794.56821727122, 8936.508492033001, 9594.232461402931, 9766.609335626496, 10170.288079834341, 11005.61480348184, 9056.320775941698, 9093.590788414405, 9175.816483670156, 9228.95385523068, 9325.207357374698, 8557.44376615518, 8922.55387230649, 9092.499912504876, 9133.908660913306, 9235.07649235071], "unit": "ms", "name": "yui.html", "value": 5666.373368678901}], "name": "dromaeo_css", "value": 6294.274693191298}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 115.0, 115.0, 124.0, 114.0, 112.0, 115.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [165.0, 132.0, 152.0, 165.0, 131.0, 150.0, 156.0, 130.0, 182.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 163.0, 161.0, 165.0, 166.0, 165.0, 164.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 72.0, 72.0, 73.0, 136.0, 72.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [96.0, 93.0, 128.0, 94.0, 94.0, 94.0, 130.0, 95.0, 95.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 150.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 80.0, 76.0, 77.0, 77.0, 78.0, 78.0, 78.0, 76.0], "unit": "ms", "name": "json-parse-financial", "value": 77.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 85.0, 84.0, 84.0, 92.0, 86.0, 86.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [121.0, 131.0, 120.0, 136.0, 129.0, 136.0, 129.0, 123.0, 122.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [144.0, 153.0, 155.0, 148.0, 150.0, 151.0, 151.0, 153.0, 156.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 71.0, 74.0, 69.0, 71.0, 69.0, 71.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1546.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0437365901964], "unit": "score", "name": "Richards", "value": 213.894818}, {"lowerIsBetter": false, "replicates": [184.84288354898337], "unit": "score", "name": "DeltaBlue", "value": 357.6983799999999}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [715.8196134574088], "unit": "score", "name": "Earley", "value": 931.0488110000001}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [595.7446808510638], "unit": "score", "name": "Splay", "value": 136.78846428571433}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21340.73689187053}]} 03:20:55 INFO - RETURN: dromaeo_css: 6294.27 03:20:55 INFO - RETURN: kraken: 1546.20 03:20:55 INFO - RETURN: v8_7: 21340.74 03:20:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21340.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1546.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6294.27"}}} 03:20:55 INFO - Return code: 0 03:20:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:20:55 INFO - # TBPL SUCCESS # 03:20:55 INFO - Running post-action listener: _resource_record_post_action 03:20:55 INFO - Running post-run listener: _resource_record_post_run 03:20:56 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10686464; Write bytes: 400678912; Read time: 4036; Write time: 271016 03:20:56 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 602112; Read time: 0; Write time: 56 03:20:56 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8818688; Write bytes: 400076800; Read time: 3760; Write time: 270960 03:20:56 INFO - Running post-run listener: _upload_blobber_files 03:20:56 INFO - Blob upload gear active. 03:20:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:20:56 INFO - Copying logs to upload dir... 03:20:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.212672 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-08 03:20:56.383777) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 03:20:56.387615) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009860 build_url: 'https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 03:20:56.439815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 03:20:56.440224) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1449560263.749564-173256992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 03:20:56.490553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 03:20:56.490920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 03:20:56.491311) ========= ========= Total master_lag: 0.21 =========