builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1449860673.54 results: success (0) buildid: 20151211105431 builduid: 0e2dbc2b50774a848051026934dff00c revision: ecc7c0857c39406156c038c226d3a6830a2ece0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.540363) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.541178) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.541471) ========= 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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004407 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.576712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.577118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.651924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.652205) ========= 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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.701794) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.702081) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.702462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.702744) ========= 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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 11:04:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2015-12-11 11:04:33 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.825711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.826036) ========= 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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.876043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:33.876392) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ecc7c0857c39406156c038c226d3a6830a2ece0c --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 ecc7c0857c39406156c038c226d3a6830a2ece0c --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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 11:04:33,914 truncating revision to first 12 chars 2015-12-11 11:04:33,914 Setting DEBUG logging. 2015-12-11 11:04:33,914 attempt 1/10 2015-12-11 11:04:33,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ecc7c0857c39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 11:04:34,142 unpacking tar archive at: fx-team-ecc7c0857c39/testing/mozharness/ program finished with exit code 0 elapsedTime=0.502289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:34.391086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:34.391378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:34.401271) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:34.401530) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 11:04:34.401903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-11 11:04:34.402196) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:04:34 INFO - MultiFileLogger online at 20151211 11:04:34 in /builds/slave/test 11:04:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 11:04:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:04:34 INFO - {'append_to_log': False, 11:04:34 INFO - 'base_work_dir': '/builds/slave/test', 11:04:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:04:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:04:34 INFO - 'branch': 'Fx-Team-Non-PGO', 11:04:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:04:34 INFO - 'config_files': ('talos/linux_config.py',), 11:04:34 INFO - 'default_actions': ('clobber', 11:04:34 INFO - 'read-buildbot-config', 11:04:34 INFO - 'download-and-extract', 11:04:34 INFO - 'populate-webroot', 11:04:34 INFO - 'create-virtualenv', 11:04:34 INFO - 'install', 11:04:34 INFO - 'run-tests'), 11:04:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:04:34 INFO - 'download_minidump_stackwalk': True, 11:04:34 INFO - 'download_symbols': 'ondemand', 11:04:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:04:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:04:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:04:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:04:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:04:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:04:34 INFO - 'installer_path': 'installer.exe', 11:04:34 INFO - 'log_level': 'info', 11:04:34 INFO - 'log_name': 'talos', 11:04:34 INFO - 'log_to_console': True, 11:04:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:04:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:04:34 INFO - 'opt_config_files': (), 11:04:34 INFO - 'pip_index': False, 11:04:34 INFO - 'sps_profile': False, 11:04:34 INFO - 'sps_profile_interval': 0, 11:04:34 INFO - 'suite': 'dromaeojs', 11:04:34 INFO - 'system_bits': '64', 11:04:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:04:34 INFO - 'title': 'talos-linux64-ix-018', 11:04:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:04:34 INFO - 'use_talos_json': True, 11:04:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:04:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:04:34 INFO - 'work_dir': 'build'} 11:04:34 INFO - ##### 11:04:34 INFO - ##### Running clobber step. 11:04:34 INFO - ##### 11:04:34 INFO - Running pre-action listener: _resource_record_pre_action 11:04:34 INFO - Running main action method: clobber 11:04:34 INFO - rmtree: /builds/slave/test/build 11:04:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:04:35 INFO - Running post-action listener: _resource_record_post_action 11:04:35 INFO - ##### 11:04:35 INFO - ##### Running read-buildbot-config step. 11:04:35 INFO - ##### 11:04:35 INFO - Running pre-action listener: _resource_record_pre_action 11:04:35 INFO - Running main action method: read_buildbot_config 11:04:35 INFO - Using buildbot properties: 11:04:35 INFO - { 11:04:35 INFO - "properties": { 11:04:35 INFO - "buildnumber": 1006, 11:04:35 INFO - "product": "firefox", 11:04:35 INFO - "script_repo_revision": "production", 11:04:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:04:35 INFO - "repository": "", 11:04:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:04:35 INFO - "buildid": "20151211105431", 11:04:35 INFO - "slavename": "talos-linux64-ix-018", 11:04:35 INFO - "pgo_build": "False", 11:04:35 INFO - "basedir": "/builds/slave/test", 11:04:35 INFO - "project": "", 11:04:35 INFO - "platform": "ubuntu64_hw", 11:04:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:04:35 INFO - "slavebuilddir": "test", 11:04:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:04:35 INFO - "branch": "fx-team", 11:04:35 INFO - "repo_path": "integration/fx-team", 11:04:35 INFO - "stage_platform": "linux64", 11:04:35 INFO - "builduid": "0e2dbc2b50774a848051026934dff00c", 11:04:35 INFO - "revision": "ecc7c0857c39406156c038c226d3a6830a2ece0c" 11:04:35 INFO - }, 11:04:35 INFO - "sourcestamp": { 11:04:35 INFO - "repository": "", 11:04:35 INFO - "hasPatch": false, 11:04:35 INFO - "project": "", 11:04:35 INFO - "branch": "fx-team-linux64-talos", 11:04:35 INFO - "changes": [ 11:04:35 INFO - { 11:04:35 INFO - "category": null, 11:04:35 INFO - "files": [ 11:04:35 INFO - { 11:04:35 INFO - "url": null, 11:04:35 INFO - "name": "https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:04:35 INFO - } 11:04:35 INFO - ], 11:04:35 INFO - "repository": "", 11:04:35 INFO - "rev": "ecc7c0857c39406156c038c226d3a6830a2ece0c", 11:04:35 INFO - "who": "jsantell@mozilla.com", 11:04:35 INFO - "when": 1449860650, 11:04:35 INFO - "number": 7353895, 11:04:35 INFO - "comments": "Bug 1222958 - Fix sidebar disappearing in memory tool. r=fitzgen\n", 11:04:35 INFO - "project": "", 11:04:35 INFO - "at": "Fri 11 Dec 2015 11:04:10", 11:04:35 INFO - "branch": "fx-team-linux64-talos", 11:04:35 INFO - "revlink": "", 11:04:35 INFO - "properties": [ 11:04:35 INFO - [ 11:04:35 INFO - "buildid", 11:04:35 INFO - "20151211105431", 11:04:35 INFO - "Change" 11:04:35 INFO - ], 11:04:35 INFO - [ 11:04:35 INFO - "builduid", 11:04:35 INFO - "0e2dbc2b50774a848051026934dff00c", 11:04:35 INFO - "Change" 11:04:35 INFO - ], 11:04:35 INFO - [ 11:04:35 INFO - "pgo_build", 11:04:35 INFO - "False", 11:04:35 INFO - "Change" 11:04:35 INFO - ] 11:04:35 INFO - ], 11:04:35 INFO - "revision": "ecc7c0857c39406156c038c226d3a6830a2ece0c" 11:04:35 INFO - } 11:04:35 INFO - ], 11:04:35 INFO - "revision": "ecc7c0857c39406156c038c226d3a6830a2ece0c" 11:04:35 INFO - } 11:04:35 INFO - } 11:04:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:04:35 INFO - Running post-action listener: _resource_record_post_action 11:04:35 INFO - ##### 11:04:35 INFO - ##### Running download-and-extract step. 11:04:35 INFO - ##### 11:04:35 INFO - Running pre-action listener: _resource_record_pre_action 11:04:35 INFO - Running main action method: download_and_extract 11:04:35 INFO - mkdir: /builds/slave/test/build/tests 11:04: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')]} 11:04:35 INFO - https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/test_packages.json 11:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/test_packages.json 11:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:04:42 INFO - Downloaded 1302 bytes. 11:04:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:04:42 INFO - Using the following test package requirements: 11:04:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:04:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:42 INFO - u'jsshell-linux-x86_64.zip'], 11:04:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:04:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:04:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:04:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:04:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:04:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:04:42 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')]} 11:04:42 INFO - https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:46 INFO - Downloaded 21874749 bytes. 11:04:46 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 11:04:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:46 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 11:04:47 INFO - Return code: 0 11:04:47 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 11:04:47 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')]} 11:04:47 INFO - https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:50 INFO - Downloaded 21874749 bytes. 11:04: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 11:04:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04: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 11:04:51 INFO - Return code: 0 11:04:51 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')]} 11:04:51 INFO - https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:52 INFO - Downloaded 11132038 bytes. 11:04:52 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 11:04:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:52 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 11:04:53 INFO - Return code: 0 11:04: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')]} 11:04:53 INFO - https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/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 11:04:54 INFO - Downloaded 57728348 bytes. 11:04:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:54 INFO - mkdir: /builds/slave/test/properties 11:04:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:04:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:04:54 INFO - Contents: 11:04:54 INFO - build_url:https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:54 INFO - Running post-action listener: _resource_record_post_action 11:04:54 INFO - Running post-action listener: set_extra_try_arguments 11:04:54 INFO - ##### 11:04:54 INFO - ##### Running populate-webroot step. 11:04:54 INFO - ##### 11:04:54 INFO - Running pre-action listener: _resource_record_pre_action 11:04:54 INFO - Running main action method: populate_webroot 11:04:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:04:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:04:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:04:54 INFO - '--tppagecycles', 11:04:54 INFO - '7'], 11:04:54 INFO - 'tests': ['tsvgm']}}, 11:04:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:04:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:04:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:04:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:04:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'tests': ['damp', 'tps']}, 11:04:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['damp', 'tps']}, 11:04:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:04:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:54 INFO - 'other': {'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other_l64': {'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other_nol64': {'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'svgr': {'tests': ['tsvgx', 11:04:54 INFO - 'tsvgr_opacity', 11:04:54 INFO - 'tart', 11:04:54 INFO - 'tscrollx', 11:04:54 INFO - 'cart']}, 11:04:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tsvgx', 11:04:54 INFO - 'tsvgr_opacity', 11:04:54 INFO - 'tart', 11:04:54 INFO - 'tscrollx', 11:04:54 INFO - 'cart']}, 11:04:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'tests': ['tp5o']}, 11:04:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tp5o']}, 11:04:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--xperf_path', 11:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:54 INFO - 'tests': ['tp5n']}, 11:04:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s', 11:04:54 INFO - '--xperf_path', 11:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:54 INFO - 'tests': ['tp5n']}}, 11:04:54 INFO - 'talos.zip': {'path': '', 11:04:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:04:54 INFO - Running post-action listener: _resource_record_post_action 11:04:54 INFO - ##### 11:04:54 INFO - ##### Running create-virtualenv step. 11:04:54 INFO - ##### 11:04:54 INFO - Running pre-action listener: _resource_record_pre_action 11:04:54 INFO - Running main action method: create_virtualenv 11:04:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:04:54 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 11:04:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:04:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:54 INFO - Using real prefix '/usr' 11:04:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:04:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:56 INFO - Installing pip.................done. 11:04:56 INFO - Return code: 0 11:04:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 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')]} 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:04:57 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 11:04:57 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 11:04:57 INFO - Using env: {'DISPLAY': ':0', 11:04:57 INFO - 'HOME': '/home/cltbld', 11:04:57 INFO - 'LANG': 'en_US.UTF-8', 11:04:57 INFO - 'LANGUAGE': 'en_US:en', 11:04:57 INFO - 'LOGNAME': 'cltbld', 11:04:57 INFO - 'MAIL': '/var/mail/cltbld', 11:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:57 INFO - 'MOZ_NO_REMOTE': '1', 11:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:57 INFO - 'NO_EM_RESTART': '1', 11:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:57 INFO - 'PWD': '/builds/slave/test', 11:04:57 INFO - 'SHELL': '/bin/bash', 11:04:57 INFO - 'SHLVL': '1', 11:04:57 INFO - 'TERM': 'linux', 11:04:57 INFO - 'TMOUT': '86400', 11:04:57 INFO - 'USER': 'cltbld', 11:04:57 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:57 INFO - '_': '/tools/buildbot/bin/python'} 11:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:57 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 11:04:57 INFO - Cleaning up... 11:04:57 INFO - Return code: 0 11:04:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:04:57 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')]} 11:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 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')]} 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:04:57 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 11:04:57 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 11:04:57 INFO - Using env: {'DISPLAY': ':0', 11:04:57 INFO - 'HOME': '/home/cltbld', 11:04:57 INFO - 'LANG': 'en_US.UTF-8', 11:04:57 INFO - 'LANGUAGE': 'en_US:en', 11:04:57 INFO - 'LOGNAME': 'cltbld', 11:04:57 INFO - 'MAIL': '/var/mail/cltbld', 11:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:57 INFO - 'MOZ_NO_REMOTE': '1', 11:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:57 INFO - 'NO_EM_RESTART': '1', 11:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:57 INFO - 'PWD': '/builds/slave/test', 11:04:57 INFO - 'SHELL': '/bin/bash', 11:04:57 INFO - 'SHLVL': '1', 11:04:57 INFO - 'TERM': 'linux', 11:04:57 INFO - 'TMOUT': '86400', 11:04:57 INFO - 'USER': 'cltbld', 11:04:57 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:57 INFO - '_': '/tools/buildbot/bin/python'} 11:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:57 INFO - Downloading/unpacking psutil>=0.7.1 11:04:57 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 11:04:57 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 11:04:57 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 11:04:57 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 11:04:57 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 11:04:57 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 11:04:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:04:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:59 INFO - Installing collected packages: psutil 11:04:59 INFO - Running setup.py install for psutil 11:04:59 INFO - building 'psutil._psutil_linux' extension 11:04:59 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 11:04:59 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 11:04:59 INFO - building 'psutil._psutil_posix' extension 11:04:59 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 11:04:59 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 11:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:59 INFO - Successfully installed psutil 11:04:59 INFO - Cleaning up... 11:04:59 INFO - Return code: 0 11:04:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:04:59 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')]} 11:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:59 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')]} 11:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:59 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:04:59 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 11:04:59 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 11:04:59 INFO - Using env: {'DISPLAY': ':0', 11:04:59 INFO - 'HOME': '/home/cltbld', 11:04:59 INFO - 'LANG': 'en_US.UTF-8', 11:04:59 INFO - 'LANGUAGE': 'en_US:en', 11:04:59 INFO - 'LOGNAME': 'cltbld', 11:04:59 INFO - 'MAIL': '/var/mail/cltbld', 11:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:59 INFO - 'MOZ_NO_REMOTE': '1', 11:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:59 INFO - 'NO_EM_RESTART': '1', 11:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:59 INFO - 'PWD': '/builds/slave/test', 11:04:59 INFO - 'SHELL': '/bin/bash', 11:04:59 INFO - 'SHLVL': '1', 11:04:59 INFO - 'TERM': 'linux', 11:04:59 INFO - 'TMOUT': '86400', 11:04:59 INFO - 'USER': 'cltbld', 11:04:59 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:59 INFO - '_': '/tools/buildbot/bin/python'} 11:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:04: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 11:04: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 11:04: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 11:04: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 11:04: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 11:04: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 11:05:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:05:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:05:01 INFO - Installing collected packages: mozsystemmonitor 11:05:01 INFO - Running setup.py install for mozsystemmonitor 11:05:01 INFO - Successfully installed mozsystemmonitor 11:05:01 INFO - Cleaning up... 11:05:01 INFO - Return code: 0 11:05:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05:01 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')]} 11:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:01 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')]} 11:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:01 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:05:01 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 11:05:01 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 11:05:01 INFO - Using env: {'DISPLAY': ':0', 11:05:01 INFO - 'HOME': '/home/cltbld', 11:05:01 INFO - 'LANG': 'en_US.UTF-8', 11:05:01 INFO - 'LANGUAGE': 'en_US:en', 11:05:01 INFO - 'LOGNAME': 'cltbld', 11:05:01 INFO - 'MAIL': '/var/mail/cltbld', 11:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:01 INFO - 'MOZ_NO_REMOTE': '1', 11:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:01 INFO - 'NO_EM_RESTART': '1', 11:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:01 INFO - 'PWD': '/builds/slave/test', 11:05:01 INFO - 'SHELL': '/bin/bash', 11:05:01 INFO - 'SHLVL': '1', 11:05:01 INFO - 'TERM': 'linux', 11:05:01 INFO - 'TMOUT': '86400', 11:05:01 INFO - 'USER': 'cltbld', 11:05:01 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:01 INFO - '_': '/tools/buildbot/bin/python'} 11:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:04 INFO - Downloading docopt-0.6.1.tar.gz 11:05:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:04 INFO - Running setup.py install for blobuploader 11:05:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:04 INFO - Running setup.py install for requests 11:05:04 INFO - Running setup.py install for docopt 11:05:04 INFO - Successfully installed blobuploader requests docopt 11:05:04 INFO - Cleaning up... 11:05:05 INFO - Return code: 0 11:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:05 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')]} 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 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')]} 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:05:05 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 11:05:05 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 11:05:05 INFO - Using env: {'DISPLAY': ':0', 11:05:05 INFO - 'HOME': '/home/cltbld', 11:05:05 INFO - 'LANG': 'en_US.UTF-8', 11:05:05 INFO - 'LANGUAGE': 'en_US:en', 11:05:05 INFO - 'LOGNAME': 'cltbld', 11:05:05 INFO - 'MAIL': '/var/mail/cltbld', 11:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:05 INFO - 'MOZ_NO_REMOTE': '1', 11:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:05 INFO - 'NO_EM_RESTART': '1', 11:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:05 INFO - 'PWD': '/builds/slave/test', 11:05:05 INFO - 'SHELL': '/bin/bash', 11:05:05 INFO - 'SHLVL': '1', 11:05:05 INFO - 'TERM': 'linux', 11:05:05 INFO - 'TMOUT': '86400', 11:05:05 INFO - 'USER': 'cltbld', 11:05:05 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:05 INFO - '_': '/tools/buildbot/bin/python'} 11:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:05 INFO - Running setup.py (path:/tmp/pip-ZTRRiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:05 INFO - Running setup.py (path:/tmp/pip-mQjClQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:05 INFO - Running setup.py (path:/tmp/pip-rQGbyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:05 INFO - Running setup.py (path:/tmp/pip-bFY0P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:05 INFO - Running setup.py (path:/tmp/pip-8adchj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:05 INFO - Running setup.py (path:/tmp/pip-8s7Z_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:05 INFO - Running setup.py (path:/tmp/pip-dBaqDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:05 INFO - Running setup.py (path:/tmp/pip-kaLAB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:05 INFO - Running setup.py (path:/tmp/pip-w3vOMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:05 INFO - Running setup.py (path:/tmp/pip-p_XRuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:05 INFO - Running setup.py (path:/tmp/pip-vpyHV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:06 INFO - Running setup.py (path:/tmp/pip-gu325y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:06 INFO - Running setup.py (path:/tmp/pip-ZTgbgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:06 INFO - Running setup.py (path:/tmp/pip-uVLNj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:06 INFO - Running setup.py (path:/tmp/pip-vq00nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:06 INFO - Running setup.py (path:/tmp/pip-ycnNLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:06 INFO - Running setup.py (path:/tmp/pip-dtvGb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:06 INFO - Running setup.py install for manifestparser 11:05:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:06 INFO - Running setup.py install for mozcrash 11:05:07 INFO - Running setup.py install for mozdebug 11:05:07 INFO - Running setup.py install for mozdevice 11:05:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozfile 11:05:07 INFO - Running setup.py install for mozhttpd 11:05:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozinfo 11:05:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozInstall 11:05:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozleak 11:05:07 INFO - Running setup.py install for mozlog 11:05:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for moznetwork 11:05:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozprocess 11:05:08 INFO - Running setup.py install for mozprofile 11:05:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Running setup.py install for mozrunner 11:05:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Running setup.py install for mozscreenshot 11:05:08 INFO - Running setup.py install for moztest 11:05:08 INFO - Running setup.py install for mozversion 11:05:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:08 INFO - Cleaning up... 11:05:08 INFO - Return code: 0 11:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:05:08 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 11:05:08 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 11:05:08 INFO - Using env: {'DISPLAY': ':0', 11:05:08 INFO - 'HOME': '/home/cltbld', 11:05:08 INFO - 'LANG': 'en_US.UTF-8', 11:05:08 INFO - 'LANGUAGE': 'en_US:en', 11:05:08 INFO - 'LOGNAME': 'cltbld', 11:05:08 INFO - 'MAIL': '/var/mail/cltbld', 11:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:08 INFO - 'MOZ_NO_REMOTE': '1', 11:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:08 INFO - 'NO_EM_RESTART': '1', 11:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:08 INFO - 'PWD': '/builds/slave/test', 11:05:08 INFO - 'SHELL': '/bin/bash', 11:05:08 INFO - 'SHLVL': '1', 11:05:08 INFO - 'TERM': 'linux', 11:05:08 INFO - 'TMOUT': '86400', 11:05:08 INFO - 'USER': 'cltbld', 11:05:08 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:08 INFO - '_': '/tools/buildbot/bin/python'} 11:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:08 INFO - Running setup.py (path:/tmp/pip-TumjuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:08 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)) 11:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:08 INFO - Running setup.py (path:/tmp/pip-_MFsmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:08 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)) 11:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:08 INFO - Running setup.py (path:/tmp/pip-3cXG0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:09 INFO - Running setup.py (path:/tmp/pip-ch7FWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:09 INFO - Running setup.py (path:/tmp/pip-YX9hdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:09 INFO - Running setup.py (path:/tmp/pip-kmxmYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:09 INFO - Running setup.py (path:/tmp/pip-iy0U36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:09 INFO - Running setup.py (path:/tmp/pip-uISi9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:09 INFO - Running setup.py (path:/tmp/pip-3EbQB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:09 INFO - Running setup.py (path:/tmp/pip-QgI_8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:09 INFO - Running setup.py (path:/tmp/pip-tXpG0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:09 INFO - Running setup.py (path:/tmp/pip-bE9EaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:09 INFO - Running setup.py (path:/tmp/pip-crKMiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:09 INFO - Running setup.py (path:/tmp/pip-79fnIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:09 INFO - Running setup.py (path:/tmp/pip-LJqEsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:09 INFO - Running setup.py (path:/tmp/pip-iWWKJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:09 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)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:09 INFO - Running setup.py (path:/tmp/pip-7B7nhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:10 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)) 11:05:10 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)) 11:05:10 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)) 11:05:10 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)) 11:05:10 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)) 11:05:10 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)) 11:05:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:10 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 11:05:10 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 11:05:10 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 11:05:10 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 11:05:10 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 11:05:10 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 11:05:11 INFO - Downloading blessings-1.5.1.tar.gz 11:05:11 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 11:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:11 INFO - Installing collected packages: blessings 11:05:11 INFO - Running setup.py install for blessings 11:05:11 INFO - Successfully installed blessings 11:05:11 INFO - Cleaning up... 11:05:11 INFO - Return code: 0 11:05:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:12 INFO - Reading from file tmpfile_stdout 11:05:12 INFO - Current package versions: 11:05:12 INFO - argparse == 1.2.1 11:05:12 INFO - blessings == 1.5.1 11:05:12 INFO - blobuploader == 1.2.4 11:05:12 INFO - docopt == 0.6.1 11:05:12 INFO - manifestparser == 1.1 11:05:12 INFO - mozInstall == 1.12 11:05:12 INFO - mozcrash == 0.16 11:05:12 INFO - mozdebug == 0.1 11:05:12 INFO - mozdevice == 0.47 11:05:12 INFO - mozfile == 1.2 11:05:12 INFO - mozhttpd == 0.7 11:05:12 INFO - mozinfo == 0.9 11:05:12 INFO - mozleak == 0.1 11:05:12 INFO - mozlog == 3.1 11:05:12 INFO - moznetwork == 0.27 11:05:12 INFO - mozprocess == 0.22 11:05:12 INFO - mozprofile == 0.27 11:05:12 INFO - mozrunner == 6.11 11:05:12 INFO - mozscreenshot == 0.1 11:05:12 INFO - mozsystemmonitor == 0.0 11:05:12 INFO - moztest == 0.7 11:05:12 INFO - mozversion == 1.4 11:05:12 INFO - psutil == 3.1.1 11:05:12 INFO - requests == 1.2.3 11:05:12 INFO - wsgiref == 0.1.2 11:05:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:12 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')]} 11:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 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')]} 11:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:05:12 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 11:05:12 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 11:05:12 INFO - Using env: {'DISPLAY': ':0', 11:05:12 INFO - 'HOME': '/home/cltbld', 11:05:12 INFO - 'LANG': 'en_US.UTF-8', 11:05:12 INFO - 'LANGUAGE': 'en_US:en', 11:05:12 INFO - 'LOGNAME': 'cltbld', 11:05:12 INFO - 'MAIL': '/var/mail/cltbld', 11:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:12 INFO - 'MOZ_NO_REMOTE': '1', 11:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:12 INFO - 'NO_EM_RESTART': '1', 11:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:12 INFO - 'PWD': '/builds/slave/test', 11:05:12 INFO - 'SHELL': '/bin/bash', 11:05:12 INFO - 'SHLVL': '1', 11:05:12 INFO - 'TERM': 'linux', 11:05:12 INFO - 'TMOUT': '86400', 11:05:12 INFO - 'USER': 'cltbld', 11:05:12 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:12 INFO - '_': '/tools/buildbot/bin/python'} 11:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:12 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)) 11:05:12 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)) 11:05:12 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)) 11:05:12 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)) 11:05:12 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)) 11:05:12 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)) 11:05:12 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)) 11:05:12 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)) 11:05: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:12 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)) 11:05:12 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)) 11:05:12 INFO - Cleaning up... 11:05:12 INFO - Return code: 0 11:05:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05:12 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')]} 11:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 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')]} 11:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:05:12 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 11:05:12 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 11:05:12 INFO - Using env: {'DISPLAY': ':0', 11:05:12 INFO - 'HOME': '/home/cltbld', 11:05:12 INFO - 'LANG': 'en_US.UTF-8', 11:05:12 INFO - 'LANGUAGE': 'en_US:en', 11:05:12 INFO - 'LOGNAME': 'cltbld', 11:05:12 INFO - 'MAIL': '/var/mail/cltbld', 11:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:12 INFO - 'MOZ_NO_REMOTE': '1', 11:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:12 INFO - 'NO_EM_RESTART': '1', 11:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:12 INFO - 'PWD': '/builds/slave/test', 11:05:12 INFO - 'SHELL': '/bin/bash', 11:05:12 INFO - 'SHLVL': '1', 11:05:12 INFO - 'TERM': 'linux', 11:05:12 INFO - 'TMOUT': '86400', 11:05:12 INFO - 'USER': 'cltbld', 11:05:12 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:12 INFO - '_': '/tools/buildbot/bin/python'} 11:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:12 INFO - Downloading/unpacking jsonschema 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:14 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 11:05:14 INFO - Downloading/unpacking functools32 (from jsonschema) 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 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 11:05:14 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:14 INFO - warning: no files found matching '*.txt' 11:05:14 INFO - no previously-included directories found matching 'build' 11:05:14 INFO - no previously-included directories found matching 'dist' 11:05:14 INFO - no previously-included directories found matching '.git*' 11:05:14 INFO - Installing collected packages: jsonschema, functools32 11:05:14 INFO - Running setup.py install for functools32 11:05:14 INFO - warning: no files found matching '*.txt' 11:05:14 INFO - no previously-included directories found matching 'build' 11:05:14 INFO - no previously-included directories found matching 'dist' 11:05:14 INFO - no previously-included directories found matching '.git*' 11:05:14 INFO - Successfully installed jsonschema functools32 11:05:14 INFO - Cleaning up... 11:05:14 INFO - Return code: 0 11:05:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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', '--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 0x7f054bb84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2460240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, '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': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', '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 11:05:14 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 11:05:14 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 11:05:14 INFO - Using env: {'DISPLAY': ':0', 11:05:14 INFO - 'HOME': '/home/cltbld', 11:05:14 INFO - 'LANG': 'en_US.UTF-8', 11:05:14 INFO - 'LANGUAGE': 'en_US:en', 11:05:14 INFO - 'LOGNAME': 'cltbld', 11:05:14 INFO - 'MAIL': '/var/mail/cltbld', 11:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:14 INFO - 'MOZ_NO_REMOTE': '1', 11:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:14 INFO - 'NO_EM_RESTART': '1', 11:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:14 INFO - 'PWD': '/builds/slave/test', 11:05:14 INFO - 'SHELL': '/bin/bash', 11:05:14 INFO - 'SHLVL': '1', 11:05:14 INFO - 'TERM': 'linux', 11:05:14 INFO - 'TMOUT': '86400', 11:05:14 INFO - 'USER': 'cltbld', 11:05:14 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:14 INFO - '_': '/tools/buildbot/bin/python'} 11:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:15 INFO - Downloading/unpacking flake8 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:05:16 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 11:05:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:05:16 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 11:05:16 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 11:05:16 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 11:05:16 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 11:05:16 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 11:05:16 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 11:05:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:05:16 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 11:05:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:05:16 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 11:05:16 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 11:05:16 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 11:05:16 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 11:05:16 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 11:05:16 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 11:05:17 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 11:05:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:17 INFO - no previously-included directories found matching 'docs/_build' 11:05:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:05:17 INFO - Running setup.py install for pep8 11:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:17 INFO - no previously-included directories found matching 'docs/_build' 11:05:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:05:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:05:17 INFO - Cleaning up... 11:05:17 INFO - Return code: 0 11:05:17 INFO - Running post-action listener: _resource_record_post_action 11:05:17 INFO - Running post-action listener: _start_resource_monitoring 11:05:17 INFO - Starting resource monitoring. 11:05:17 INFO - ##### 11:05:17 INFO - ##### Running install step. 11:05:17 INFO - ##### 11:05:17 INFO - Running pre-action listener: _resource_record_pre_action 11:05:17 INFO - Running main action method: install 11:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:17 INFO - Reading from file tmpfile_stdout 11:05:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:05:17 INFO - Reading from file tmpfile_stdout 11:05:17 INFO - Output received: 11:05:17 INFO - Usage: mozinstall [options] installer 11:05:17 INFO - Options: 11:05:17 INFO - -h, --help show this help message and exit 11:05:17 INFO - -d DEST, --destination=DEST 11:05:17 INFO - Directory to install application into. [default: 11:05:17 INFO - "/builds/slave/test"] 11:05:17 INFO - --app=APP Application being installed. [default: firefox] 11:05:17 INFO - mkdir: /builds/slave/test/build/application 11:05:17 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'] 11:05:17 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 11:05:32 INFO - Reading from file tmpfile_stdout 11:05:32 INFO - Output received: 11:05:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:05:32 INFO - Running post-action listener: _resource_record_post_action 11:05:32 INFO - ##### 11:05:32 INFO - ##### Running run-tests step. 11:05:32 INFO - ##### 11:05:32 INFO - Running pre-action listener: _resource_record_pre_action 11:05:32 INFO - Running main action method: run_tests 11:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:05:32 INFO - Python 2.7.3 11:05:32 INFO - Return code: 0 11:05:32 INFO - grabbing minidump binary from tooltool 11:05:32 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')]} 11:05:32 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 0x24ef0b0>, '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 0x24effb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:05:32 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 11:05:32 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 11:05:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:05:32 INFO - Return code: 0 11:05:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:05:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:05:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:05:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:05:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:05:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:05:33 INFO - Return code: 0 11:05:33 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 11:05:33 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 11:05:33 INFO - Using env: {'DISPLAY': ':0', 11:05:33 INFO - 'HOME': '/home/cltbld', 11:05:33 INFO - 'LANG': 'en_US.UTF-8', 11:05:33 INFO - 'LANGUAGE': 'en_US:en', 11:05:33 INFO - 'LOGNAME': 'cltbld', 11:05:33 INFO - 'MAIL': '/var/mail/cltbld', 11:05:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:33 INFO - 'MOZ_NO_REMOTE': '1', 11:05:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:33 INFO - 'NO_EM_RESTART': '1', 11:05:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:33 INFO - 'PWD': '/builds/slave/test', 11:05:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:33 INFO - 'SHELL': '/bin/bash', 11:05:33 INFO - 'SHLVL': '1', 11:05:33 INFO - 'TERM': 'linux', 11:05:33 INFO - 'TMOUT': '86400', 11:05:33 INFO - 'USER': 'cltbld', 11:05:33 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374', 11:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:33 INFO - '_': '/tools/buildbot/bin/python'} 11:05:33 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 11:05:33 INFO - mozversion INFO | application_buildid: 20151211105431 11:05:33 INFO - mozversion INFO | application_changeset: ecc7c0857c39406156c038c226d3a6830a2ece0c 11:05:33 INFO - mozversion INFO | application_display_name: Nightly 11:05:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:05:33 INFO - mozversion INFO | application_name: Firefox 11:05:33 INFO - mozversion INFO | application_remotingname: firefox 11:05:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:05:33 INFO - mozversion INFO | application_vendor: Mozilla 11:05:33 INFO - mozversion INFO | application_version: 45.0a1 11:05:33 INFO - mozversion INFO | platform_buildid: 20151211105431 11:05:33 INFO - mozversion INFO | platform_changeset: ecc7c0857c39406156c038c226d3a6830a2ece0c 11:05:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:05:33 INFO - mozversion INFO | platform_version: 45.0a1 11:05:33 INFO - 2015-12-11 11:05:33,652 DEBUG : using testdate: 1449860733 11:05:33 INFO - 2015-12-11 11:05:33,652 DEBUG : actual date: 1449860733 11:05:33 INFO - 2015-12-11 11:05:33,663 INFO : starting webserver on 'localhost:40478' 11:05:33 INFO - 2015-12-11 11:05:33,664 INFO : Starting test suite talos-linux64-ix-018 11:05:33 INFO - 2015-12-11 11:05:33,664 INFO : Starting test dromaeo_css 11:05:33 INFO - 2015-12-11 11:05:33,664 DEBUG : operating with platform_type : linux_ 11:05:33 INFO - 2015-12-11 11:05:33,665 INFO : Initialising browser for dromaeo_css test... 11:05:33 INFO - 2015-12-11 11:05:33,679 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvsZzh/profile http://localhost:40478/getInfo.html 11:05:37 INFO - 2015-12-11 11:05:37,599 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:05:37 INFO - 2015-12-11 11:05:37,599 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:05:37 INFO - 2015-12-11 11:05:37,599 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:05:37 INFO - 2015-12-11 11:05:37,599 DEBUG : BROWSER_OUTPUT: __metrics 11:05:37 INFO - 2015-12-11 11:05:37,721 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] 11:05:37 INFO - 2015-12-11 11:05:37,817 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:05:39 INFO - 2015-12-11 11:05:39,098 INFO : Browser initialized. 11:05:39 INFO - 2015-12-11 11:05:39,099 INFO : Running cycle 1/1 for dromaeo_css test... 11:05:39 INFO - 2015-12-11 11:05:39,099 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvsZzh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:05:51 INFO - 2015-12-11 11:05:51,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 142917632 11:05:51 INFO - 2015-12-11 11:05:51,099 DEBUG : BROWSER_OUTPUT: 11:06:42 INFO - 2015-12-11 11:06:42,439 DEBUG : BROWSER_OUTPUT: 1449860802438 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] 11:08:54 INFO - 2015-12-11 11:08:54,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40478/tests/dromaeo/cssquery-ext.html) 11:08:55 INFO - 2015-12-11 11:08:55,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 243998720 11:08:55 INFO - 2015-12-11 11:08:55,432 DEBUG : BROWSER_OUTPUT: 11:11:58 INFO - 2015-12-11 11:11:58,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-ext.html (next: http://localhost:40478/tests/dromaeo/cssquery-jquery.html) 11:11:58 INFO - 2015-12-11 11:11:58,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 220852224 11:11:58 INFO - 2015-12-11 11:11:58,616 DEBUG : BROWSER_OUTPUT: 11:15:00 INFO - 2015-12-11 11:15:00,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40478/tests/dromaeo/cssquery-mootools.html) 11:15:01 INFO - 2015-12-11 11:15:01,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 222433280 11:15:01 INFO - 2015-12-11 11:15:01,216 DEBUG : BROWSER_OUTPUT: 11:18:03 INFO - 2015-12-11 11:18:03,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40478/tests/dromaeo/cssquery-prototype.html) 11:18:03 INFO - 2015-12-11 11:18:03,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 203464704 11:18:03 INFO - 2015-12-11 11:18:03,691 DEBUG : BROWSER_OUTPUT: 11:21:06 INFO - 2015-12-11 11:21:06,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40478/tests/dromaeo/cssquery-yui.html) 11:21:06 INFO - 2015-12-11 11:21:06,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 209137664 11:21:06 INFO - 2015-12-11 11:21:06,954 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/dromaeo/cssquery-yui.html (next: http://localhost:40478/tests/dromaeo/cssquery-dojo.html) 11:24:09 INFO - 2015-12-11 11:24:09,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 255758336 11:24:09 INFO - 2015-12-11 11:24:09,759 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,759 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:24:09 INFO - 2015-12-11 11:24:09,759 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:24:09 INFO - 2015-12-11 11:24:09,760 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:24:09 INFO - 2015-12-11 11:24:09,760 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:24:09 INFO - 2015-12-11 11:24:09,760 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2646.3913299941014;2747.093459158478;2754.063618369754;2755.4626847764694;2758.048473276719;4510.210713125206;4656.1153380857695;4693.413323334583;4695.107929493398;4717.056588682261;4640.4431468223775;4656.650751193657;4705.835295764649;4711.128441238373;4713.552212539812;4301.096769678371;4352.825886964518;4372.759498227604;4396.098799746061;4441.844535441261;4139.337705967046;4333.285007973681;4361.171377438292;4396.956030439686;4425.380446737459;4246.91506169878;4298.097399546084;4337.110892267077;4346.8043938022865;4371.650267978554;4292.1415716856445;4350.782460876943;4361.105973275471;4394.758288294142;4401.625861801751;4140.855070072533;4353.998580326511;4360.127974405132;4365;4418.5581441855875;4487.753173575452;4556.066006468666;4565.086982603492;4581.496035436099;4626.514216007338;5025.3718285214345;5033.905065815701;5046.621503387224;5054.1407960646775;5090;4865.270209468573;5068.4424713281505;5072.036313100499;5077.517635824591;5081.695098294077;4608.5621865922685;4629.467611224685;4636.559526844978;4765.499622539653;4769.427668679711;5089.160288552422;5095.235714642833;5099.56653684441;5122.948770512322;5193;4903.754812259373;4932.408111026628;4933.975330123327;4979.128652485801;4986.576141028053;4800.855974320776;4891.951080489221;4917.483664215278;4920.138975679241;5022.824201152942;4957.603391728725;4989.55094041538;5001.374828146481;5019.598432125421;5024.171011783088;4955.40535135786;4955.876103097451;4958.752062396866;4960.677555958923;5001.599872010231;4068.877933661995;4184.372344148342;4210.073783767566;4211.663066954637;4218.388333691598;3606.621304762962;3682.1715114099115;3684.097396137963;3709.647583479565;3719.1817800083936;4319.719218250803;4336.718113322624;4339.500957389941;4349.151915376535;4377.474703035592;4830.3479030331155;4957.157283261854;5009.148444764399;5050.3434553507805;5097.46476619957;4170.436991006236;4252.87241382759;4253.574642535784;4255.957440425618;4290.249206388869;4464.352668863062;4510.120526497367;4512.661550383735;4513.480949690827;4549.385832912581;4610.469795973506;4762.642801789949;4781.521847815191;4791.4729379767505;4803.615710743202;4966.826161084345;4992.926520798046;5000.649954503296;5005.424376196784;5033.697978121324;4773.260144677581;4827.806887724592;4845.709257444564;4852.223644216909;4872.3909511311085;4685.390899183084;4816.735079570657;5044.571211447068;5063;5107.029664363759;4896.853094407174;4938.580220681139;4954.950450495449;4967.975160124176;4975.57707594844;4880.829170978998;4931.852044438672;4946.727929963887;4948.455669876239;4984.028114517634;4648;4931.679440836334;4944.728039957693;4947.257911313188;4993.5755460784785;4783.115123702126;4792.209285467999;4819.927701084416;4848.7090774553635;4908.9754551227015;4910.7544622768;4910.901781964412;4915.139850526072;4915.680480768739;4964.627652925973;4591.966807468293;4808.206645903527;4812.398450193726;4818.060478206856;4855.1260773061185 11:24:09 INFO - 2015-12-11 11:24:09,760 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.628858097946;570.9771609135635;572.7909313100719;575.499315595432;579.2035950567969;27100.864495677517;27578.448431031367;27619.5857062144;35018.29963400731;35843.64156358436;40241.19517609646;40810.183796324054;40938.385924211085;40958.18083638325;40975.38536921948;7873.724419645314;8045.597720113971;8049.436539442241;8052.3558115350925;8054.758357249292;7226.710931562731;7409.777706668781;9911.405315681046;10112.292139550234;10162.59349626014;10027;10153.340032897839;10153.746156346113;10158.238132140083;10163.6950891473;7242.384397326234;7428.591427471487;9988.700338989805;10092.495375231245;10105.595776168944;7124.5012849100585;7237.203907570163;10225.897741022569;10448.843267350996;10474.26680132391;36959.815200924095;37481.81259093687;37487.43768843469;37532.62467375346;37650.24699506022;2849.216465472012;2867.1111955293927;2935.5156399194107;3007.7142671446177;3409.7613167078316;28181.71818281832;28309;28334.29164270889;28430.857845710845;28939.710602893912;3263.640999490054;3291.8518666660057;3300.9174770630925;3308.123347312964;3399.2521645238007;217847;218586;218747;219043;219455.9999999984;49928;55265;56141;56213.15680264717;56213.718931405085;46044.769776150904;66694.66652666706;68173.27306907668;68219;68376.6581167101;12890.67773305675;13089.803652945213;13091.083624146218;13093.345332733325;13100.934495327463;9693.563789629483;9719.46542940145;9778.044391121804;9781.706548803548;9785.0214978503;19059.80940190608;19288;19367.612647746966;19380.449564034843;19464.124114414884;7477.252274772588;7746.883796743054;7830.334421574116;7839.568823714636;7846.960765196138;847.2120927537326;856.4604299291531;879.5382424227332;928.5682157796657;1035.803197392508;26361;26587.46825063488;26599.468010640066;29881.402371952438;31494.842525787226;851.4167795060404;919.8620206968874;936.8079543693526;954.708813811794;1035.5650626736788;13564.864351356557;14011.08927919682;14180.220087895264;14200.786988195185;14247.857521424861;324530;330676;331343;331920;332651;46800;46839;46851.29723054157;47440.7627961858;47508;1241.6771639373646;1244.6328333141746;1249.6376050945305;1255.9434825432877;1257.936983347311;24694.876525617976;25578.616320755576;26384.604230936937;30137.397252055274;31096.378072437972;43537.346939795294;44227;44244.778776105915;44261.77869110634;44286;249168;251277;251702;252837;253063;24112;24330.87834560816;24831.62752558677;29084;29549.409011820073;34735.30529389348;37064;37398;37435.43846842245;37498;31078.22304442407;31517.369652607278;31720.206994825316;32554.674453255164;32635.18412039718;25236.24291271265;30338.84830575833;31571.21071973219;31785.682143178274;32326.35347293088;28956.131316060553;29118;29449.705502944696;29704.851475743348;29722.10833674993;24832.50334993254;25751.484970300113;28673.42653146967;29026.709732903244;29267.414651707273;22205.462799870867;22387.216447424264;22540.436489087904;22542.436439089153;22781.430464238525 11:24:09 INFO - 2015-12-11 11:24:09,760 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.3659501839033;336.8753561182363;337.0831338758576;340.99829500852496;341.99487007694887;12454.564090256843;12876.42056107475;15099.547013589583;15159.62100947477;15978.520644380658;12864.163829351086;14283.428662853474;14516.637084072903;14570.708585828277;15152.772708409382;4204.810783514749;4946.901061978767;5083.415407228179;5114.23286507025;5123.436421993578;5079.390473143228;5115.514026167527;5120.359955005624;5122.769475373599;5122.974385128069;4955.950440495603;5025.145725226702;5042.243663450475;5071.594272458195;5075.568576670988;5016.648834581581;5021.673591216578;5032.069067222539;5041.59667226621;5064.82273120439;4472.418585583886;4480.686351955364;4481.775911204427;4483.327500874862;4537.546245375469;18775.436736897915;19024.239030438766;19034.61930761377;19272.132754025963;19567.315143969892;1832.3220408448826;1861.4415675297357;1878.4552479780848;1895.895725735084;1923.7595300587427;9082.86375704365;9241.6303347866;9411.10594493522;9985.101340879355;12684.112112152154;1685.8819882608223;1730.2646375290576;1739.8956062636155;1762.1981998190793;1820.8270214329618;54564;57934.42065579374;58237.126443103814;58915.41084589142;59704.70147649277;9545;9637.469939153274;9774.951125244328;9891.653792117386;9966.750831229278;10829.566817327219;11163.665090047312;11334.886651133547;12529.31088790107;12532.621411644712;5436.293281873332;5527.806526771624;5824.271966004249;6617.8014659560295;6638.369354911276;6329.145565348711;6387.648679322682;6430.582012169194;6454.741810327534;6472.838179045561;4076.2255171517318;4090.509138903291;4094.4472496213225;4142;4169.228692691801;1619.9271032803551;1623.3863479797517;1707.2488105233658;1715.305301352954;1734.6877562038953;801.9478733882279;817.3910436724678;827.3753316246195;829.5478963964654;931.0456781798711;15199.924000379928;15405.845941540665;15640.374385024472;15942.840571594135;16167.919160404357;760.3195140349357;795.367682692261;798.6885114805231;808.0424696734389;837.937154713399;7809.3752499799875;8932.553372331487;9005.954970225106;9254.565542340948;9436;484719.9022711932;488484;499520;505794;511413;74221.62889185628;75260.62369688226;76478.61760691273;77127;77907;1068.738159151013;1070.4219721350385;1086.5002099034532;1091.2088735666578;1093.5625749700184;14444.205568693822;14597.398197372238;14651.853481465476;14750.918691444276;15007.549773506813;25396;26316.947322106902;26555.867220663775;30004.399912002074;30107;34925.82537087298;37447.2510549782;38320.80839595784;40025;43648.345274821535;8565.400421970402;8780.341474389574;8900.332475064266;8901.821963560564;8910.287177025952;10573.154147668014;10605.734856628646;12587.811182832082;16101.516954491384;16600.169991500617;12710.110292279453;12820.294883781482;12964.481420743065;13284.335783210994;13335.799963000369;12427.93786031064;12880.42038108306;13108.279044652254;13352.799708004582;13565;12851.871481285067;12892.097553171188;13579.796303055264;13885.791713124108;14025.5091071812;8764.123587641185;8848.1151884811;8919.955400222958;8923.286137108886;8932.86600700977;11928.821067684165;13298.601041968757;13385.933070334586;13820.308984550531;13980.58058258254 11:24:09 INFO - 2015-12-11 11:24:09,761 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1195.0917302849832;1614.8062232532097;1660.6263590692088;1697.5077227603988;1722.9741553876686;6041.879162416754;7034.437245020399;7191.2808719128125;7196.676149573269;7220;7146.142462904446;7274.636268186596;7288.198298187195;7311.817204569875;7323.633818309077;1798.8650851186214;1829.8170182981662;2053.435305291042;2092.288621868568;2136.7970042845905;2120.54408302215;2125.872447653138;2128.1912873108276;2129.5421484380854;2130.0095455613136;2026.3718247343297;2106.4733816545863;2115.0587988345114;2115.3548167808813;2120.0035983087923;2057.5987682401937;2062.3709768520594;2084.4684605425596;2085.624587574236;2105.0422057963588;2080.2823026055985;2099.4331530486684;2101.747790265178;2102.4008157675144;2104.4633618427356;7053.612051337174;7110.786676399716;7117.964410177916;7121.928780712178;7143.785686429415;4089.5501494835544;4198.454200953856;4216.978915105405;4221.409002739619;4225.04936389313;2674.8930042798265;2685.0736495909077;2706.8375897446217;2745.5058089543872;2747.2994386431333;822.2558584481054;826.3430572694662;831.7920519870032;836.3225787112458;854.6282367170301;9416.62333506659;9424.811503769886;9425.2931030173;9427.387219830689;9448.811023779555;3961.485006949078;3965.8017099144927;4018.07584255617;4019.2966230909474;4022.215667944781;8019.077806052262;8105.878411823827;8110.026796784306;8130.918690813134;8147.470414423044;4279.507856596469;4333.15503476819;4333.306670932636;4336.219480493542;4339.674524410681;3885.5337359516475;3911.882643520699;3918.0792513759243;3925.3326934421216;3926.450296958428;2979.1807253005595;3015.7888947773886;3278.9836050819595;3285.3593549257666;3370.224848284908;1064.957401703923;1066.520065970301;1072.0274694562042;1087.1628845788698;1090.8800031996475;852.0584753847033;852.9061803201643;926.1757036237753;1034.8447732839984;1149.988500114988;6520.934790652128;6531.314212007671;6557.967210163919;6568.737250510022;6589.604623722592;1036.186673321687;1040.921930855189;1044.7283706236433;1055.8469021991768;1079.2876701377054;5204.76578553966;5279.841604751864;5296.152615581565;5301.920471192935;5302.628815982921;8127.552984585786;8182.345412366996;8342.249197572248;8380.664773409117;8402.11777763326;8268.2558569729;8317.376196785266;8324;8405.033421156522;8431.662733490715;6426.196725409324;6538.640374779433;6557.639329836905;6578.63817490033;6632.1709786276715;6373.968130159319;6381.617102973836;6385.8722825544155;6391.744330226739;6397.488200944006;7377.483576149618;7492.363149132385;7512.32389084985;7524.962375188089;7547.132079810673;7373.77878663641;7573.46985710995;7660;7694.384449244159;7750.573718445539;6253.624782513064;6282.2147231596055;6300.306966233802;6311.084892690443;6325.240971083499;6181.505479561714;6566.277709451861;6576.079348891255;6579.078928950046;6636.2368327642935;6228.691974685366;6279.874402512016;6330.746770129143;6376.776812811529;6404.71178796946;5862.355140934579;6175.5677102602385;6232.220972378453;6280.623162610258;6306.211723534559;6330.778422755181;6364.172657554488;6380.776672816429;6404.359564043559;6422.165118534747;5964.343922168471;5990.191324171181;5992.610480318765;5997.520198384206;5999.040153575407;5669.54643628517;6060.484858787053;6098.512119030555;6100.298465676504;6109.694515274307 11:24:09 INFO - 2015-12-11 11:24:09,762 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.23035643929757;302.9560713696514;306.8573113502222;307.58783230471164;310.1873092497655;5323;5335.33308336458;5348.625596208267;5367.355917289921;5376.059189641816;5024.070546948817;5131.102057139995;5198.740062996854;5286.524212820846;5322.654027488211;4127.463429754142;4137.6482998944975;4140.399642051901;4141.316682747343;4153.937690934638;3916.823742931575;4141.482314710661;4141.482314710661;4145.0880806222585;4152.792360381969;3961.1285517186175;3999.620036096581;4094.877153685394;4107.424960505532;4134.29716948118;4133.04939863833;4135.60711732385;4137.813798379065;4142.565030671796;4144.12973275611;3645.6901163401144;3647.1793846384617;3654.853805847763;3656.433252845813;3657.4696668983115;5084.161113416282;5092.668976516515;5096.949030509684;5106.131957567222;5116.053530096944;4557.886052848672;4673.042026384583;4682.531746825324;4739;4779.784909679072;5632.239647647556;5634.577406694514;5635.408282130358;5638.718064096779;5642.04085305499;3863.285292220948;3867.1298957734566;3873.845046198149;3876.8836934891997;3878.8448462061483;5850.327212370589;5943;5944.881102377972;5948;5952.047672372443;3920.1571662092215;4014.638682518529;4015.6988225883174;4016.0562267867613;4033.858814941522;4077.673786097105;4079.204555111784;4080.143169934347;4083.305838007546;4085.22380747657;4683.812647494062;4684.039771846763;4684.344191813149;4689.859304220879;4696.178168820511;5622.57830662702;5632.5775566831835;5640.605157639008;5642.463965923231;5643.633163844337;1413.6819215676392;1424.7293014327245;1446.4720377062297;1451.608065822222;1452.194032312056;961.6009356117133;972.9221662267001;974.6004138303404;983.041534503853;984.6652138272879;4944.1100601891285;4945.67853089548;4951.158303088484;4953.157963146274;4954.8761280968265;5862;5863.824085277449;5876.206712093813;5877.147813567009;5878.441548052928;4780.235162374073;4840.515948405202;4899.338589290472;4899.946511500045;4983.775730092155;3137.51368537877;3149.9685003150134;3159.020703581897;3166;3175.380800743833;5542.667439953535;5549.889002220014;5552.333719953632;5553.944460555424;5557.694326811983;5927.407259274038;6044.576879618472;6059.7273122709585;6061.908856405889;6066.545009124245;5545.805896793593;5551.139573366135;5551.639143455663;5552.666839989613;5553.805616803393;5890.941090589039;5892.852678683067;5909.586328957103;5911.379305172895;5913.113033045078;5741.655500669973;5743.540516758733;5746.592084939217;5747.051736463437;5748.425157484218;5397.3523177218985;5546.140348246028;5562.666240025612;5571.4428557143965;5586.664800112007;4027.234825383168;4055.2903241931954;4057.756534607933;4064.085580744309;4065.4511640928094;5916.822495325147;5919.082542205965;5923.08192230205;5924.437178468039;5927.733252003756;5584.609077364708;5674.517665998271;5691.089425691869;5697.800576979786;5706.514946229451;5679.858003549944;5696.316442026983;5699.487046165865;5699.5725320600295;5701.743421545957;5574.219609254626;5574.470425309589;5576.414476479911;5579.274694289878;5582.078956972054;5727.8568035799435;5729.169270455844;5729.312482502127;5732.914006289992;5734.426557344233;5415.891682166413;5614.52276556481;5619;5620.1288800236025;5621.072523033654 11:24:09 INFO - 2015-12-11 11:24:09,762 DEBUG : BROWSER_OUTPUT: |5;yui.html;774.4810976645647;776.8019155115445;782.1552723059095;795.1889073145392;816.8897198878157;12667.873321266785;12972.740545189103;12980.350982450887;12985.220886746802;12996.74006519869;13484;13828.723425531483;13833.17000979942;13857;13858.307084645752;636.5544119116637;644.9097126402307;807.7092246791166;825.4428260923883;825.7440193539992;811.6875003123781;818.1981657975188;828.1180542722012;828.5070383122032;828.8963879515061;861.8060936289316;867.3494878840869;868.1839071273015;868.4355169140047;868.4485351801588;659.5053709717712;668.3183153183726;848.3467729848044;862.5687156421789;866.7313132928781;636.3254949753276;638.5211091681239;638.8786130635165;639.3766078073887;640.0942666127471;11928.224665396721;12171.695707607381;12227.205231659913;12266.202696824677;12267.447964841604;9837.213022958145;10409.739756506073;10514.31656942304;11002.119830413547;11512.194146409754;8353.457025293337;9174.633014679404;9238.307126965505;9307.92958809732;9861;3010.08192501287;3068.6624471308137;3097.6902309769066;3117.610298712661;3119.906402807919;39919.20161596752;40091.59908400908;40254.79872600648;40299.395509067384;41201.79399103015;8180.9181908181345;8187.754367368989;8204.425690201748;8310;8487.575621219037;14936.551903442914;14962.551123466314;14991.32539035746;14991.775123373158;15004.099754014795;6217.564770466024;6263.561550691499;6276.560640755195;6323.083152942798;6373.936260637334;3501.474778783152;3608.332458495187;3635.381985062546;3647.7993710345654;3658.5243918290985;2548.210054882992;2557.7698007179442;2580.2001379572016;2580.316216202708;2582.4705935283223;443.6783332084213;452.9320601909674;454.2414168338882;458.827939522679;463.4901608230986;378.4947095627313;516.2101983964466;524.3838489774575;529.5075579710906;537.1781174802559;7100.751473698396;7211.747588834365;7243.239459856639;7252.5648461092505;7345.3021962913435;465.97204167750044;533.7358007786171;537.3417563484778;541.2719891745596;547.5099785691863;3591.317649646559;3673.797941113211;3886.5336159660455;3998.640122388999;4022.0950286185375;49450;50423;50738;52798.47201527935;53295;43700.78149609295;44304;44467.77766111149;44613.33080003737;44701.776491117336;40877.59122408797;41145.382819257735;41300.173996520505;41393.1721365571;41393.79303103465;7669.884951725617;7784;7848.018997625297;7879.251471110236;8331.416800823885;29845.507724614115;31151.53272700866;31513.212169695023;31869.68130318667;32054.35891282208;39371.212575747755;39826.60173398229;39903.600963989986;40177.79911100426;40451;9750.853737193806;9940.155086817413;9947.751306217402;10063.949680251551;10082.092611664986;10573.682789516326;11053.944730276296;11109.444527773418;11183.217174797686;11415.200935934405;9889.653862114792;9899.703008909744;10010.799784004133;10095.242856785624;10291;9914.157296629868;10025.448600327052;10276.307237374116;10492.685219443429;10976;9991.600335986479;10029.942357225762;10076.546555404877;10108.039736225046;10119.342242754197;8918.955405222932;9146.176844084064;9200;9259.67591134307;9344.766380840534;8284.668613255402;8547.230749232598;8628.611712473079;8689.131086891513;8901.198892099743 11:24:09 INFO - 2015-12-11 11:24:09,762 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,881 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: __startTimestamp1449861849752__endTimestamp 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,763 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4631.49 Median:4783.12 stddev:473.44 (9.9%) stddev-sans-first:448.55 11:24:09 INFO - 2015-12-11 11:24:09,764 DEBUG : BROWSER_OUTPUT: Values: 2646.4 2747.1 2754.1 2755.5 2758.0 4510.2 4656.1 4693.4 4695.1 4717.1 4640.4 4656.7 4705.8 4711.1 4713.6 4301.1 4352.8 4372.8 4396.1 4441.8 4139.3 4333.3 4361.2 4397.0 4425.4 4246.9 4298.1 4337.1 4346.8 4371.7 4292.1 4350.8 4361.1 4394.8 4401.6 4140.9 4354.0 4360.1 4365.0 4418.6 4487.8 4556.1 4565.1 4581.5 4626.5 5025.4 5033.9 5046.6 5054.1 5090.0 4865.3 5068.4 5072.0 5077.5 5081.7 4608.6 4629.5 4636.6 4765.5 4769.4 5089.2 5095.2 5099.6 5122.9 5193.0 4903.8 4932.4 4934.0 4979.1 4986.6 4800.9 4892.0 4917.5 4920.1 5022.8 4957.6 4989.6 5001.4 5019.6 5024.2 4955.4 4955.9 4958.8 4960.7 5001.6 4068.9 4184.4 4210.1 4211.7 4218.4 3606.6 3682.2 3684.1 3709.6 3719.2 4319.7 4336.7 4339.5 4349.2 4377.5 4830.3 4957.2 5009.1 5050.3 5097.5 4170.4 4252.9 4253.6 4256.0 4290.2 4464.4 4510.1 4512.7 4513.5 4549.4 4610.5 4762.6 4781.5 4791.5 4803.6 4966.8 4992.9 5000.6 5005.4 5033.7 4773.3 4827.8 4845.7 4852.2 4872.4 4685.4 4816.7 5044.6 5063.0 5107.0 4896.9 4938.6 4955.0 4968.0 4975.6 4880.8 4931.9 4946.7 4948.5 4984.0 4648.0 4931.7 4944.7 4947.3 4993.6 4783.1 4792.2 4819.9 4848.7 4909.0 4910.8 4910.9 4915.1 4915.7 4964.6 4592.0 4808.2 4812.4 4818.1 4855.1 11:24:09 INFO - 2015-12-11 11:24:09,764 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,765 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42414.04 Median:31645.71 stddev:71022.60 (224.4%) stddev-sans-first:71152.34 11:24:09 INFO - 2015-12-11 11:24:09,765 DEBUG : BROWSER_OUTPUT: Values: 566.6 571.0 572.8 575.5 579.2 27100.9 27578.4 27619.6 35018.3 35843.6 40241.2 40810.2 40938.4 40958.2 40975.4 7873.7 8045.6 8049.4 8052.4 8054.8 7226.7 7409.8 9911.4 10112.3 10162.6 10027.0 10153.3 10153.7 10158.2 10163.7 7242.4 7428.6 9988.7 10092.5 10105.6 7124.5 7237.2 10225.9 10448.8 10474.3 36959.8 37481.8 37487.4 37532.6 37650.2 2849.2 2867.1 2935.5 3007.7 3409.8 28181.7 28309.0 28334.3 28430.9 28939.7 3263.6 3291.9 3300.9 3308.1 3399.3 217847.0 218586.0 218747.0 219043.0 219456.0 49928.0 55265.0 56141.0 56213.2 56213.7 46044.8 66694.7 68173.3 68219.0 68376.7 12890.7 13089.8 13091.1 13093.3 13100.9 9693.6 9719.5 9778.0 9781.7 9785.0 19059.8 19288.0 19367.6 19380.4 19464.1 7477.3 7746.9 7830.3 7839.6 7847.0 847.2 856.5 879.5 928.6 1035.8 26361.0 26587.5 26599.5 29881.4 31494.8 851.4 919.9 936.8 954.7 1035.6 13564.9 14011.1 14180.2 14200.8 14247.9 324530.0 330676.0 331343.0 331920.0 332651.0 46800.0 46839.0 46851.3 47440.8 47508.0 1241.7 1244.6 1249.6 1255.9 1257.9 24694.9 25578.6 26384.6 30137.4 31096.4 43537.3 44227.0 44244.8 44261.8 44286.0 249168.0 251277.0 251702.0 252837.0 253063.0 24112.0 24330.9 24831.6 29084.0 29549.4 34735.3 37064.0 37398.0 37435.4 37498.0 31078.2 31517.4 31720.2 32554.7 32635.2 25236.2 30338.8 31571.2 31785.7 32326.4 28956.1 29118.0 29449.7 29704.9 29722.1 24832.5 25751.5 28673.4 29026.7 29267.4 22205.5 22387.2 22540.4 22542.4 22781.4 11:24:09 INFO - 2015-12-11 11:24:09,765 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,765 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26399.46 Median:4083.37 stddev:81427.98 (1994.1%) stddev-sans-first:81632.88 11:24:09 INFO - 2015-12-11 11:24:09,765 DEBUG : BROWSER_OUTPUT: Values: 336.4 336.9 337.1 341.0 342.0 12454.6 12876.4 15099.5 15159.6 15978.5 12864.2 14283.4 14516.6 14570.7 15152.8 4204.8 4946.9 5083.4 5114.2 5123.4 5079.4 5115.5 5120.4 5122.8 5123.0 4956.0 5025.1 5042.2 5071.6 5075.6 5016.6 5021.7 5032.1 5041.6 5064.8 4472.4 4480.7 4481.8 4483.3 4537.5 18775.4 19024.2 19034.6 19272.1 19567.3 1832.3 1861.4 1878.5 1895.9 1923.8 9082.9 9241.6 9411.1 9985.1 12684.1 1685.9 1730.3 1739.9 1762.2 1820.8 54564.0 57934.4 58237.1 58915.4 59704.7 9545.0 9637.5 9775.0 9891.7 9966.8 10829.6 11163.7 11334.9 12529.3 12532.6 5436.3 5527.8 5824.3 6617.8 6638.4 6329.1 6387.6 6430.6 6454.7 6472.8 4076.2 4090.5 4094.4 4142.0 4169.2 1619.9 1623.4 1707.2 1715.3 1734.7 801.9 817.4 827.4 829.5 931.0 15199.9 15405.8 15640.4 15942.8 16167.9 760.3 795.4 798.7 808.0 837.9 7809.4 8932.6 9006.0 9254.6 9436.0 484719.9 488484.0 499520.0 505794.0 511413.0 74221.6 75260.6 76478.6 77127.0 77907.0 1068.7 1070.4 1086.5 1091.2 1093.6 14444.2 14597.4 14651.9 14750.9 15007.5 25396.0 26316.9 26555.9 30004.4 30107.0 34925.8 37447.3 38320.8 40025.0 43648.3 8565.4 8780.3 8900.3 8901.8 8910.3 10573.2 10605.7 12587.8 16101.5 16600.2 12710.1 12820.3 12964.5 13284.3 13335.8 12427.9 12880.4 13108.3 13352.8 13565.0 12851.9 12892.1 13579.8 13885.8 14025.5 8764.1 8848.1 8920.0 8923.3 8932.9 11928.8 13298.6 13385.9 13820.3 13980.6 11:24:09 INFO - 2015-12-11 11:24:09,765 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,765 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4923.10 Median:6205.10 stddev:2515.63 (40.5%) stddev-sans-first:2507.07 11:24:09 INFO - 2015-12-11 11:24:09,766 DEBUG : BROWSER_OUTPUT: Values: 1195.1 1614.8 1660.6 1697.5 1723.0 6041.9 7034.4 7191.3 7196.7 7220.0 7146.1 7274.6 7288.2 7311.8 7323.6 1798.9 1829.8 2053.4 2092.3 2136.8 2120.5 2125.9 2128.2 2129.5 2130.0 2026.4 2106.5 2115.1 2115.4 2120.0 2057.6 2062.4 2084.5 2085.6 2105.0 2080.3 2099.4 2101.7 2102.4 2104.5 7053.6 7110.8 7118.0 7121.9 7143.8 4089.6 4198.5 4217.0 4221.4 4225.0 2674.9 2685.1 2706.8 2745.5 2747.3 822.3 826.3 831.8 836.3 854.6 9416.6 9424.8 9425.3 9427.4 9448.8 3961.5 3965.8 4018.1 4019.3 4022.2 8019.1 8105.9 8110.0 8130.9 8147.5 4279.5 4333.2 4333.3 4336.2 4339.7 3885.5 3911.9 3918.1 3925.3 3926.5 2979.2 3015.8 3279.0 3285.4 3370.2 1065.0 1066.5 1072.0 1087.2 1090.9 852.1 852.9 926.2 1034.8 1150.0 6520.9 6531.3 6558.0 6568.7 6589.6 1036.2 1040.9 1044.7 1055.8 1079.3 5204.8 5279.8 5296.2 5301.9 5302.6 8127.6 8182.3 8342.2 8380.7 8402.1 8268.3 8317.4 8324.0 8405.0 8431.7 6426.2 6538.6 6557.6 6578.6 6632.2 6374.0 6381.6 6385.9 6391.7 6397.5 7377.5 7492.4 7512.3 7525.0 7547.1 7373.8 7573.5 7660.0 7694.4 7750.6 6253.6 6282.2 6300.3 6311.1 6325.2 6181.5 6566.3 6576.1 6579.1 6636.2 6228.7 6279.9 6330.7 6376.8 6404.7 5862.4 6175.6 6232.2 6280.6 6306.2 6330.8 6364.2 6380.8 6404.4 6422.2 5964.3 5990.2 5992.6 5997.5 5999.0 5669.5 6060.5 6098.5 6100.3 6109.7 11:24:09 INFO - 2015-12-11 11:24:09,766 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,767 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4677.31 Median:5329.17 stddev:1385.84 (26.0%) stddev-sans-first:1350.25 11:24:09 INFO - 2015-12-11 11:24:09,767 DEBUG : BROWSER_OUTPUT: Values: 301.2 303.0 306.9 307.6 310.2 5323.0 5335.3 5348.6 5367.4 5376.1 5024.1 5131.1 5198.7 5286.5 5322.7 4127.5 4137.6 4140.4 4141.3 4153.9 3916.8 4141.5 4141.5 4145.1 4152.8 3961.1 3999.6 4094.9 4107.4 4134.3 4133.0 4135.6 4137.8 4142.6 4144.1 3645.7 3647.2 3654.9 3656.4 3657.5 5084.2 5092.7 5096.9 5106.1 5116.1 4557.9 4673.0 4682.5 4739.0 4779.8 5632.2 5634.6 5635.4 5638.7 5642.0 3863.3 3867.1 3873.8 3876.9 3878.8 5850.3 5943.0 5944.9 5948.0 5952.0 3920.2 4014.6 4015.7 4016.1 4033.9 4077.7 4079.2 4080.1 4083.3 4085.2 4683.8 4684.0 4684.3 4689.9 4696.2 5622.6 5632.6 5640.6 5642.5 5643.6 1413.7 1424.7 1446.5 1451.6 1452.2 961.6 972.9 974.6 983.0 984.7 4944.1 4945.7 4951.2 4953.2 4954.9 5862.0 5863.8 5876.2 5877.1 5878.4 4780.2 4840.5 4899.3 4899.9 4983.8 3137.5 3150.0 3159.0 3166.0 3175.4 5542.7 5549.9 5552.3 5553.9 5557.7 5927.4 6044.6 6059.7 6061.9 6066.5 5545.8 5551.1 5551.6 5552.7 5553.8 5890.9 5892.9 5909.6 5911.4 5913.1 5741.7 5743.5 5746.6 5747.1 5748.4 5397.4 5546.1 5562.7 5571.4 5586.7 4027.2 4055.3 4057.8 4064.1 4065.5 5916.8 5919.1 5923.1 5924.4 5927.7 5584.6 5674.5 5691.1 5697.8 5706.5 5679.9 5696.3 5699.5 5699.6 5701.7 5574.2 5574.5 5576.4 5579.3 5582.1 5727.9 5729.2 5729.3 5732.9 5734.4 5415.9 5614.5 5619.0 5620.1 5621.1 11:24:09 INFO - 2015-12-11 11:24:09,767 DEBUG : BROWSER_OUTPUT: 11:24:09 INFO - 2015-12-11 11:24:09,767 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12232.17 Median:456.53 stddev:13993.50 (3065.2%) stddev-sans-first:14006.30 11:24:09 INFO - 2015-12-11 11:24:09,767 DEBUG : BROWSER_OUTPUT: Values: 774.5 776.8 782.2 795.2 816.9 12667.9 12972.7 12980.4 12985.2 12996.7 13484.0 13828.7 13833.2 13857.0 13858.3 636.6 644.9 807.7 825.4 825.7 811.7 818.2 828.1 828.5 828.9 861.8 867.3 868.2 868.4 868.4 659.5 668.3 848.3 862.6 866.7 636.3 638.5 638.9 639.4 640.1 11928.2 12171.7 12227.2 12266.2 12267.4 9837.2 10409.7 10514.3 11002.1 11512.2 8353.5 9174.6 9238.3 9307.9 9861.0 3010.1 3068.7 3097.7 3117.6 3119.9 39919.2 40091.6 40254.8 40299.4 41201.8 8180.9 8187.8 8204.4 8310.0 8487.6 14936.6 14962.6 14991.3 14991.8 15004.1 6217.6 6263.6 6276.6 6323.1 6373.9 3501.5 3608.3 3635.4 3647.8 3658.5 2548.2 2557.8 2580.2 2580.3 2582.5 443.7 452.9 454.2 458.8 463.5 378.5 516.2 524.4 529.5 537.2 7100.8 7211.7 7243.2 7252.6 7345.3 466.0 533.7 537.3 541.3 547.5 3591.3 3673.8 3886.5 3998.6 4022.1 49450.0 50423.0 50738.0 52798.5 53295.0 43700.8 44304.0 44467.8 44613.3 44701.8 40877.6 41145.4 41300.2 41393.2 41393.8 7669.9 7784.0 7848.0 7879.3 8331.4 29845.5 31151.5 31513.2 31869.7 32054.4 39371.2 39826.6 39903.6 40177.8 40451.0 9750.9 9940.2 9947.8 10063.9 10082.1 10573.7 11053.9 11109.4 11183.2 11415.2 9889.7 9899.7 10010.8 10095.2 10291.0 9914.2 10025.4 10276.3 10492.7 10976.0 9991.6 10029.9 10076.5 10108.0 10119.3 8919.0 9146.2 9200.0 9259.7 9344.8 8284.7 8547.2 8628.6 8689.1 8901.2 11:24:09 INFO - 2015-12-11 11:24:09,767 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:24:09 INFO - 2015-12-11 11:24:09,767 DEBUG : BROWSER_OUTPUT: 11:24:10 INFO - 2015-12-11 11:24:10,494 INFO : Browser exited with error code: 0 11:24:10 INFO - 2015-12-11 11:24:10,512 INFO : Completed test dromaeo_css (00:18:36) 11:24:10 INFO - 2015-12-11 11:24:10,512 INFO : Starting test kraken 11:24:10 INFO - 2015-12-11 11:24:10,512 DEBUG : operating with platform_type : linux_ 11:24:10 INFO - 2015-12-11 11:24:10,512 INFO : Initialising browser for kraken test... 11:24:10 INFO - 2015-12-11 11:24:10,518 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHeO16M/profile http://localhost:40478/getInfo.html 11:24:14 INFO - 2015-12-11 11:24:14,631 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:24:14 INFO - 2015-12-11 11:24:14,631 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:24:14 INFO - 2015-12-11 11:24:14,631 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:24:14 INFO - 2015-12-11 11:24:14,632 DEBUG : BROWSER_OUTPUT: __metrics 11:24:14 INFO - 2015-12-11 11:24:14,741 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] 11:24:14 INFO - 2015-12-11 11:24:14,801 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:24:14 ERROR - 2015-12-11 11:24:14,817 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 11:24:15 INFO - 2015-12-11 11:24:15,737 INFO : Browser initialized. 11:24:15 INFO - 2015-12-11 11:24:15,737 INFO : Running cycle 1/1 for kraken test... 11:24:15 INFO - 2015-12-11 11:24:15,738 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHeO16M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:24:27 INFO - 2015-12-11 11:24:27,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 142004224 11:24:27 INFO - 2015-12-11 11:24:27,771 DEBUG : BROWSER_OUTPUT: 11:24:30 INFO - 2015-12-11 11:24:30,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-beat-detection) 11:24:30 INFO - 2015-12-11 11:24:30,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 179982336 11:24:30 INFO - 2015-12-11 11:24:30,975 DEBUG : BROWSER_OUTPUT: 11:24:33 INFO - 2015-12-11 11:24:33,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-dft) 11:24:34 INFO - 2015-12-11 11:24:34,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 168046592 11:24:34 INFO - 2015-12-11 11:24:34,293 DEBUG : BROWSER_OUTPUT: 11:24:37 INFO - 2015-12-11 11:24:37,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-fft) 11:24:37 INFO - 2015-12-11 11:24:37,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 155140096 11:24:37 INFO - 2015-12-11 11:24:37,837 DEBUG : BROWSER_OUTPUT: 11:24:39 INFO - 2015-12-11 11:24:39,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40478/tests/kraken/driver.html?testName=audio-oscillator) 11:24:40 INFO - 2015-12-11 11:24:40,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 155308032 11:24:40 INFO - 2015-12-11 11:24:40,463 DEBUG : BROWSER_OUTPUT: 11:24:42 INFO - 2015-12-11 11:24:42,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:43 INFO - 2015-12-11 11:24:43,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 157184000 11:24:43 INFO - 2015-12-11 11:24:43,305 DEBUG : BROWSER_OUTPUT: 11:24:46 INFO - 2015-12-11 11:24:46,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40478/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:46 INFO - 2015-12-11 11:24:46,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 156053504 11:24:46 INFO - 2015-12-11 11:24:46,914 DEBUG : BROWSER_OUTPUT: 11:24:50 INFO - 2015-12-11 11:24:50,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40478/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:50 INFO - 2015-12-11 11:24:50,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 159010816 11:24:50 INFO - 2015-12-11 11:24:50,915 DEBUG : BROWSER_OUTPUT: 11:24:53 INFO - 2015-12-11 11:24:53,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40478/tests/kraken/driver.html?testName=json-parse-financial) 11:24:54 INFO - 2015-12-11 11:24:54,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 157368320 11:24:54 INFO - 2015-12-11 11:24:54,375 DEBUG : BROWSER_OUTPUT: 11:24:56 INFO - 2015-12-11 11:24:56,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:56 INFO - 2015-12-11 11:24:56,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 165937152 11:24:56 INFO - 2015-12-11 11:24:56,712 DEBUG : BROWSER_OUTPUT: 11:24:58 INFO - 2015-12-11 11:24:58,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:59 INFO - 2015-12-11 11:24:59,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 166490112 11:24:59 INFO - 2015-12-11 11:24:59,183 DEBUG : BROWSER_OUTPUT: 11:25:01 INFO - 2015-12-11 11:25:01,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:01 INFO - 2015-12-11 11:25:01,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 178585600 11:25:01 INFO - 2015-12-11 11:25:01,876 DEBUG : BROWSER_OUTPUT: 11:25:04 INFO - 2015-12-11 11:25:04,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:04 INFO - 2015-12-11 11:25:04,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 184786944 11:25:04 INFO - 2015-12-11 11:25:04,965 DEBUG : BROWSER_OUTPUT: 11:25:07 INFO - 2015-12-11 11:25:07,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:08 INFO - 2015-12-11 11:25:08,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 183009280 11:25:08 INFO - 2015-12-11 11:25:08,148 DEBUG : BROWSER_OUTPUT: 11:25:09 INFO - 2015-12-11 11:25:09,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40478/tests/kraken/driver.html?testName=ai-astar) 11:25:10 INFO - 2015-12-11 11:25:10,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 242446336 11:25:10 INFO - 2015-12-11 11:25:10,207 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,210 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:25:10 INFO - 2015-12-11 11:25:10,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:25:10 INFO - 2015-12-11 11:25:10,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:25:10 INFO - 2015-12-11 11:25:10,211 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:25:10 INFO - 2015-12-11 11:25:10,211 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;106;111;113;113;101;112;111;110 11:25:10 INFO - 2015-12-11 11:25:10,211 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;130;162;164;140;156;153;130;167;131 11:25:10 INFO - 2015-12-11 11:25:10,211 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;162;160;161;159;161;162;162;162 11:25:10 INFO - 2015-12-11 11:25:10,211 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;93;91;71;74;72;95;92;74 11:25:10 INFO - 2015-12-11 11:25:10,211 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;131;93;94;94;136;94;96;132 11:25:10 INFO - 2015-12-11 11:25:10,211 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;109;110;109;109;109 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;146;148;147;148;146 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;96 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;72;71;70;71;80;70;69 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;68;69;69;68;69;69 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;85;82;83;84;84;84;84;83 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;123;124;127;115;122;128;127;122;125 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;150;150;152;148;136;149;146;148;138 11:25:10 INFO - 2015-12-11 11:25:10,212 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;69;69;69;69;69;71;69;70;70 11:25:10 INFO - 2015-12-11 11:25:10,213 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:25:10 INFO - 2015-12-11 11:25:10,213 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:25:10 INFO - 2015-12-11 11:25:10,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1003 11:25:10 INFO - 2015-12-11 11:25:10,213 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:25:10 INFO - 2015-12-11 11:25:10,213 DEBUG : BROWSER_OUTPUT: __startTimestamp1449861910208__endTimestamp 11:25:10 INFO - 2015-12-11 11:25:10,213 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,221 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:25:10 INFO - 2015-12-11 11:25:10,221 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:25:10 INFO - 2015-12-11 11:25:10,221 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,221 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.68 (3.3%) stddev-sans-first:3.90 11:25:10 INFO - 2015-12-11 11:25:10,221 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 106.0 111.0 113.0 113.0 101.0 112.0 111.0 110.0 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:159.00 stddev:15.28 (9.6%) stddev-sans-first:15.42 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: Values: 163.0 130.0 162.0 164.0 140.0 156.0 153.0 130.0 167.0 131.0 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 162.0 160.0 161.0 159.0 161.0 162.0 162.0 162.0 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:82.50 stddev:10.54 (12.8%) stddev-sans-first:10.71 11:25:10 INFO - 2015-12-11 11:25:10,222 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 93.0 91.0 71.0 74.0 72.0 95.0 92.0 74.0 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.83 (20.0%) stddev-sans-first:19.48 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 131.0 93.0 94.0 94.0 136.0 94.0 96.0 132.0 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 146.0 148.0 147.0 148.0 146.0 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:3.13 (4.4%) stddev-sans-first:3.32 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 72.0 71.0 70.0 71.0 80.0 70.0 69.0 11:25:10 INFO - 2015-12-11 11:25:10,223 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 68.0 69.0 69.0 68.0 69.0 69.0 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.14 (1.4%) stddev-sans-first:1.17 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 85.0 82.0 83.0 84.0 84.0 84.0 84.0 83.0 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:125.50 stddev:3.78 (3.0%) stddev-sans-first:3.94 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: Values: 126.0 123.0 124.0 127.0 115.0 122.0 128.0 127.0 122.0 125.0 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:148.50 stddev:6.02 (4.1%) stddev-sans-first:5.57 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: Values: 137.0 150.0 150.0 152.0 148.0 136.0 149.0 146.0 148.0 138.0 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:69.50 stddev:2.79 (4.0%) stddev-sans-first:0.73 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: Values: 78.0 69.0 69.0 69.0 69.0 69.0 71.0 69.0 70.0 70.0 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:25:10 INFO - 2015-12-11 11:25:10,224 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-11 11:25:11,079 INFO : Browser exited with error code: 0 11:25:11 INFO - 2015-12-11 11:25:11,131 INFO : Completed test kraken (00:01:00) 11:25:11 INFO - 2015-12-11 11:25:11,131 INFO : Starting test v8_7 11:25:11 INFO - 2015-12-11 11:25:11,131 DEBUG : operating with platform_type : linux_ 11:25:11 INFO - 2015-12-11 11:25:11,131 INFO : Initialising browser for v8_7 test... 11:25:11 INFO - 2015-12-11 11:25:11,137 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwH_E28/profile http://localhost:40478/getInfo.html 11:25:15 INFO - 2015-12-11 11:25:15,051 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:25:15 INFO - 2015-12-11 11:25:15,051 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:25:15 INFO - 2015-12-11 11:25:15,051 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:25:15 INFO - 2015-12-11 11:25:15,051 DEBUG : BROWSER_OUTPUT: __metrics 11:25:15 INFO - 2015-12-11 11:25:15,180 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] 11:25:15 INFO - 2015-12-11 11:25:15,244 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:16 INFO - 2015-12-11 11:25:16,406 INFO : Browser initialized. 11:25:16 INFO - 2015-12-11 11:25:16,407 INFO : Running cycle 1/1 for v8_7 test... 11:25:16 INFO - 2015-12-11 11:25:16,407 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwH_E28/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:25:28 INFO - 2015-12-11 11:25:28,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 143060992 11:25:28 INFO - 2015-12-11 11:25:28,361 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40478/tests/v8_7/run.html (next: http://localhost:40478/tests/v8_7/run.html) 11:25:49 INFO - 2015-12-11 11:25:49,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 444112896 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |0;Richards;166.5278934221482 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.81113394358303 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 11:25:49 INFO - 2015-12-11 11:25:49,964 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: |8;Splay;602.7727546714889 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: __startTimestamp1449861949963__endTimestamp 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:25:49 INFO - 2015-12-11 11:25:49,965 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:25:49 INFO - 2015-12-11 11:25:49,966 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,966 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,966 DEBUG : BROWSER_OUTPUT: Values: 166.5 11:25:49 INFO - 2015-12-11 11:25:49,966 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,966 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.81 Median:186.81 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,966 DEBUG : BROWSER_OUTPUT: Values: 186.8 11:25:49 INFO - 2015-12-11 11:25:49,967 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,967 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,967 DEBUG : BROWSER_OUTPUT: Values: 278.0 11:25:49 INFO - 2015-12-11 11:25:49,967 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,967 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,968 DEBUG : BROWSER_OUTPUT: Values: 5133.3 11:25:49 INFO - 2015-12-11 11:25:49,968 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,968 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,968 DEBUG : BROWSER_OUTPUT: Values: 1984.1 11:25:49 INFO - 2015-12-11 11:25:49,968 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,968 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,969 DEBUG : BROWSER_OUTPUT: Values: 787.4 11:25:49 INFO - 2015-12-11 11:25:49,969 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,969 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,969 DEBUG : BROWSER_OUTPUT: Values: 12120.5 11:25:49 INFO - 2015-12-11 11:25:49,969 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,969 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,970 DEBUG : BROWSER_OUTPUT: Values: 27027.0 11:25:49 INFO - 2015-12-11 11:25:49,970 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,970 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.77 Median:602.77 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,970 DEBUG : BROWSER_OUTPUT: Values: 602.8 11:25:49 INFO - 2015-12-11 11:25:49,971 DEBUG : BROWSER_OUTPUT: 11:25:49 INFO - 2015-12-11 11:25:49,972 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:25:49 INFO - 2015-12-11 11:25:49,972 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:25:49 INFO - 2015-12-11 11:25:49,972 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:25:49 INFO - 2015-12-11 11:25:49,972 DEBUG : BROWSER_OUTPUT: 11:25:50 INFO - 2015-12-11 11:25:50,881 INFO : Browser exited with error code: 0 11:25:50 INFO - 2015-12-11 11:25:50,898 INFO : Completed test v8_7 (00:00:39) 11:25:51 INFO - 2015-12-11 11:25:51,041 INFO : Completed test suite (00:20:17) 11:25:51 INFO - 2015-12-11 11:25:51,041 DEBUG : Working with test: dromaeo_css 11:25:51 INFO - 2015-12-11 11:25:51,042 DEBUG : Generating results file: dromaeo_css 11:25:51 INFO - 2015-12-11 11:25:51,043 DEBUG : Working with test: kraken 11:25:51 INFO - 2015-12-11 11:25:51,043 DEBUG : Generating results file: kraken 11:25:51 INFO - 2015-12-11 11:25:51,043 INFO : javascript benchmark 11:25:51 INFO - 2015-12-11 11:25:51,043 DEBUG : Working with test: v8_7 11:25:51 INFO - 2015-12-11 11:25:51,043 DEBUG : Generating results file: v8_7 11:25:51 INFO - 2015-12-11 11:25:51,044 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:25:51 INFO - 2015-12-11 11:25:51,095 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:25:51 INFO - 2015-12-11 11:25:51,095 DEBUG : process_Request line: dromaeo_css 6279.35 graph.html#tests=[[72,132,35]] 11:25:51 INFO - 2015-12-11 11:25:51,095 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:25:51 INFO - 2015-12-11 11:25:51,123 DEBUG : process_Request line: kraken 1521.80 graph.html#tests=[[232,132,35]] 11:25:51 INFO - 2015-12-11 11:25:51,123 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:25:51 INFO - 2015-12-11 11:25:51,222 DEBUG : process_Request line: v8_7 19828.08 graph.html#tests=[[230,132,35]] 11:25:51 INFO - 2015-12-11 11:25:51,223 INFO : javascript benchmark 11:25:51 INFO - 2015-12-11 11:25:51,227 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2646.3913299941014, 2747.093459158478, 2754.063618369754, 2755.4626847764694, 2758.048473276719, 4510.210713125206, 4656.1153380857695, 4693.413323334583, 4695.107929493398, 4717.056588682261, 4640.4431468223775, 4656.650751193657, 4705.835295764649, 4711.128441238373, 4713.552212539812, 4301.096769678371, 4352.825886964518, 4372.759498227604, 4396.098799746061, 4441.844535441261, 4139.337705967046, 4333.285007973681, 4361.171377438292, 4396.956030439686, 4425.380446737459, 4246.91506169878, 4298.097399546084, 4337.110892267077, 4346.8043938022865, 4371.650267978554, 4292.1415716856445, 4350.782460876943, 4361.105973275471, 4394.758288294142, 4401.625861801751, 4140.855070072533, 4353.998580326511, 4360.127974405132, 4365.0, 4418.5581441855875, 4487.753173575452, 4556.066006468666, 4565.086982603492, 4581.496035436099, 4626.514216007338, 5025.3718285214345, 5033.905065815701, 5046.621503387224, 5054.1407960646775, 5090.0, 4865.270209468573, 5068.4424713281505, 5072.036313100499, 5077.517635824591, 5081.695098294077, 4608.5621865922685, 4629.467611224685, 4636.559526844978, 4765.499622539653, 4769.427668679711, 5089.160288552422, 5095.235714642833, 5099.56653684441, 5122.948770512322, 5193.0, 4903.754812259373, 4932.408111026628, 4933.975330123327, 4979.128652485801, 4986.576141028053, 4800.855974320776, 4891.951080489221, 4917.483664215278, 4920.138975679241, 5022.824201152942, 4957.603391728725, 4989.55094041538, 5001.374828146481, 5019.598432125421, 5024.171011783088, 4955.40535135786, 4955.876103097451, 4958.752062396866, 4960.677555958923, 5001.599872010231, 4068.877933661995, 4184.372344148342, 4210.073783767566, 4211.663066954637, 4218.388333691598, 3606.621304762962, 3682.1715114099115, 3684.097396137963, 3709.647583479565, 3719.1817800083936, 4319.719218250803, 4336.718113322624, 4339.500957389941, 4349.151915376535, 4377.474703035592, 4830.3479030331155, 4957.157283261854, 5009.148444764399, 5050.3434553507805, 5097.46476619957, 4170.436991006236, 4252.87241382759, 4253.574642535784, 4255.957440425618, 4290.249206388869, 4464.352668863062, 4510.120526497367, 4512.661550383735, 4513.480949690827, 4549.385832912581, 4610.469795973506, 4762.642801789949, 4781.521847815191, 4791.4729379767505, 4803.615710743202, 4966.826161084345, 4992.926520798046, 5000.649954503296, 5005.424376196784, 5033.697978121324, 4773.260144677581, 4827.806887724592, 4845.709257444564, 4852.223644216909, 4872.3909511311085, 4685.390899183084, 4816.735079570657, 5044.571211447068, 5063.0, 5107.029664363759, 4896.853094407174, 4938.580220681139, 4954.950450495449, 4967.975160124176, 4975.57707594844, 4880.829170978998, 4931.852044438672, 4946.727929963887, 4948.455669876239, 4984.028114517634, 4648.0, 4931.679440836334, 4944.728039957693, 4947.257911313188, 4993.5755460784785, 4783.115123702126, 4792.209285467999, 4819.927701084416, 4848.7090774553635, 4908.9754551227015, 4910.7544622768, 4910.901781964412, 4915.139850526072, 4915.680480768739, 4964.627652925973, 4591.966807468293, 4808.206645903527, 4812.398450193726, 4818.060478206856, 4855.1260773061185], "unit": "ms", "name": "dojo.html", "value": 4602.91190983561}, {"lowerIsBetter": false, "replicates": [566.628858097946, 570.9771609135635, 572.7909313100719, 575.499315595432, 579.2035950567969, 27100.864495677517, 27578.448431031367, 27619.5857062144, 35018.29963400731, 35843.64156358436, 40241.19517609646, 40810.183796324054, 40938.385924211085, 40958.18083638325, 40975.38536921948, 7873.724419645314, 8045.597720113971, 8049.436539442241, 8052.3558115350925, 8054.758357249292, 7226.710931562731, 7409.777706668781, 9911.405315681046, 10112.292139550234, 10162.59349626014, 10027.0, 10153.340032897839, 10153.746156346113, 10158.238132140083, 10163.6950891473, 7242.384397326234, 7428.591427471487, 9988.700338989805, 10092.495375231245, 10105.595776168944, 7124.5012849100585, 7237.203907570163, 10225.897741022569, 10448.843267350996, 10474.26680132391, 36959.815200924095, 37481.81259093687, 37487.43768843469, 37532.62467375346, 37650.24699506022, 2849.216465472012, 2867.1111955293927, 2935.5156399194107, 3007.7142671446177, 3409.7613167078316, 28181.71818281832, 28309.0, 28334.29164270889, 28430.857845710845, 28939.710602893912, 3263.640999490054, 3291.8518666660057, 3300.9174770630925, 3308.123347312964, 3399.2521645238007, 217847.0, 218586.0, 218747.0, 219043.0, 219455.9999999984, 49928.0, 55265.0, 56141.0, 56213.15680264717, 56213.718931405085, 46044.769776150904, 66694.66652666706, 68173.27306907668, 68219.0, 68376.6581167101, 12890.67773305675, 13089.803652945213, 13091.083624146218, 13093.345332733325, 13100.934495327463, 9693.563789629483, 9719.46542940145, 9778.044391121804, 9781.706548803548, 9785.0214978503, 19059.80940190608, 19288.0, 19367.612647746966, 19380.449564034843, 19464.124114414884, 7477.252274772588, 7746.883796743054, 7830.334421574116, 7839.568823714636, 7846.960765196138, 847.2120927537326, 856.4604299291531, 879.5382424227332, 928.5682157796657, 1035.803197392508, 26361.0, 26587.46825063488, 26599.468010640066, 29881.402371952438, 31494.842525787226, 851.4167795060404, 919.8620206968874, 936.8079543693526, 954.708813811794, 1035.5650626736788, 13564.864351356557, 14011.08927919682, 14180.220087895264, 14200.786988195185, 14247.857521424861, 324530.0, 330676.0, 331343.0, 331920.0, 332651.0, 46800.0, 46839.0, 46851.29723054157, 47440.7627961858, 47508.0, 1241.6771639373646, 1244.6328333141746, 1249.6376050945305, 1255.9434825432877, 1257.936983347311, 24694.876525617976, 25578.616320755576, 26384.604230936937, 30137.397252055274, 31096.378072437972, 43537.346939795294, 44227.0, 44244.778776105915, 44261.77869110634, 44286.0, 249168.0, 251277.0, 251702.0, 252837.0, 253063.0, 24112.0, 24330.87834560816, 24831.62752558677, 29084.0, 29549.409011820073, 34735.30529389348, 37064.0, 37398.0, 37435.43846842245, 37498.0, 31078.22304442407, 31517.369652607278, 31720.206994825316, 32554.674453255164, 32635.18412039718, 25236.24291271265, 30338.84830575833, 31571.21071973219, 31785.682143178274, 32326.35347293088, 28956.131316060553, 29118.0, 29449.705502944696, 29704.851475743348, 29722.10833674993, 24832.50334993254, 25751.484970300113, 28673.42653146967, 29026.709732903244, 29267.414651707273, 22205.462799870867, 22387.216447424264, 22540.436489087904, 22542.436439089153, 22781.430464238525], "unit": "ms", "name": "ext.html", "value": 17062.668412595933}, {"lowerIsBetter": false, "replicates": [336.3659501839033, 336.8753561182363, 337.0831338758576, 340.99829500852496, 341.99487007694887, 12454.564090256843, 12876.42056107475, 15099.547013589583, 15159.62100947477, 15978.520644380658, 12864.163829351086, 14283.428662853474, 14516.637084072903, 14570.708585828277, 15152.772708409382, 4204.810783514749, 4946.901061978767, 5083.415407228179, 5114.23286507025, 5123.436421993578, 5079.390473143228, 5115.514026167527, 5120.359955005624, 5122.769475373599, 5122.974385128069, 4955.950440495603, 5025.145725226702, 5042.243663450475, 5071.594272458195, 5075.568576670988, 5016.648834581581, 5021.673591216578, 5032.069067222539, 5041.59667226621, 5064.82273120439, 4472.418585583886, 4480.686351955364, 4481.775911204427, 4483.327500874862, 4537.546245375469, 18775.436736897915, 19024.239030438766, 19034.61930761377, 19272.132754025963, 19567.315143969892, 1832.3220408448826, 1861.4415675297357, 1878.4552479780848, 1895.895725735084, 1923.7595300587427, 9082.86375704365, 9241.6303347866, 9411.10594493522, 9985.101340879355, 12684.112112152154, 1685.8819882608223, 1730.2646375290576, 1739.8956062636155, 1762.1981998190793, 1820.8270214329618, 54564.0, 57934.42065579374, 58237.126443103814, 58915.41084589142, 59704.70147649277, 9545.0, 9637.469939153274, 9774.951125244328, 9891.653792117386, 9966.750831229278, 10829.566817327219, 11163.665090047312, 11334.886651133547, 12529.31088790107, 12532.621411644712, 5436.293281873332, 5527.806526771624, 5824.271966004249, 6617.8014659560295, 6638.369354911276, 6329.145565348711, 6387.648679322682, 6430.582012169194, 6454.741810327534, 6472.838179045561, 4076.2255171517318, 4090.509138903291, 4094.4472496213225, 4142.0, 4169.228692691801, 1619.9271032803551, 1623.3863479797517, 1707.2488105233658, 1715.305301352954, 1734.6877562038953, 801.9478733882279, 817.3910436724678, 827.3753316246195, 829.5478963964654, 931.0456781798711, 15199.924000379928, 15405.845941540665, 15640.374385024472, 15942.840571594135, 16167.919160404357, 760.3195140349357, 795.367682692261, 798.6885114805231, 808.0424696734389, 837.937154713399, 7809.3752499799875, 8932.553372331487, 9005.954970225106, 9254.565542340948, 9436.0, 484719.9022711932, 488484.0, 499520.0, 505794.0, 511413.0, 74221.62889185628, 75260.62369688226, 76478.61760691273, 77127.0, 77907.0, 1068.738159151013, 1070.4219721350385, 1086.5002099034532, 1091.2088735666578, 1093.5625749700184, 14444.205568693822, 14597.398197372238, 14651.853481465476, 14750.918691444276, 15007.549773506813, 25396.0, 26316.947322106902, 26555.867220663775, 30004.399912002074, 30107.0, 34925.82537087298, 37447.2510549782, 38320.80839595784, 40025.0, 43648.345274821535, 8565.400421970402, 8780.341474389574, 8900.332475064266, 8901.821963560564, 8910.287177025952, 10573.154147668014, 10605.734856628646, 12587.811182832082, 16101.516954491384, 16600.169991500617, 12710.110292279453, 12820.294883781482, 12964.481420743065, 13284.335783210994, 13335.799963000369, 12427.93786031064, 12880.42038108306, 13108.279044652254, 13352.799708004582, 13565.0, 12851.871481285067, 12892.097553171188, 13579.796303055264, 13885.791713124108, 14025.5091071812, 8764.123587641185, 8848.1151884811, 8919.955400222958, 8923.286137108886, 8932.86600700977, 11928.821067684165, 13298.601041968757, 13385.933070334586, 13820.308984550531, 13980.58058258254], "unit": "ms", "name": "jquery.html", "value": 8060.173513065354}, {"lowerIsBetter": false, "replicates": [1195.0917302849832, 1614.8062232532097, 1660.6263590692088, 1697.5077227603988, 1722.9741553876686, 6041.879162416754, 7034.437245020399, 7191.2808719128125, 7196.676149573269, 7220.0, 7146.142462904446, 7274.636268186596, 7288.198298187195, 7311.817204569875, 7323.633818309077, 1798.8650851186214, 1829.8170182981662, 2053.435305291042, 2092.288621868568, 2136.7970042845905, 2120.54408302215, 2125.872447653138, 2128.1912873108276, 2129.5421484380854, 2130.0095455613136, 2026.3718247343297, 2106.4733816545863, 2115.0587988345114, 2115.3548167808813, 2120.0035983087923, 2057.5987682401937, 2062.3709768520594, 2084.4684605425596, 2085.624587574236, 2105.0422057963588, 2080.2823026055985, 2099.4331530486684, 2101.747790265178, 2102.4008157675144, 2104.4633618427356, 7053.612051337174, 7110.786676399716, 7117.964410177916, 7121.928780712178, 7143.785686429415, 4089.5501494835544, 4198.454200953856, 4216.978915105405, 4221.409002739619, 4225.04936389313, 2674.8930042798265, 2685.0736495909077, 2706.8375897446217, 2745.5058089543872, 2747.2994386431333, 822.2558584481054, 826.3430572694662, 831.7920519870032, 836.3225787112458, 854.6282367170301, 9416.62333506659, 9424.811503769886, 9425.2931030173, 9427.387219830689, 9448.811023779555, 3961.485006949078, 3965.8017099144927, 4018.07584255617, 4019.2966230909474, 4022.215667944781, 8019.077806052262, 8105.878411823827, 8110.026796784306, 8130.918690813134, 8147.470414423044, 4279.507856596469, 4333.15503476819, 4333.306670932636, 4336.219480493542, 4339.674524410681, 3885.5337359516475, 3911.882643520699, 3918.0792513759243, 3925.3326934421216, 3926.450296958428, 2979.1807253005595, 3015.7888947773886, 3278.9836050819595, 3285.3593549257666, 3370.224848284908, 1064.957401703923, 1066.520065970301, 1072.0274694562042, 1087.1628845788698, 1090.8800031996475, 852.0584753847033, 852.9061803201643, 926.1757036237753, 1034.8447732839984, 1149.988500114988, 6520.934790652128, 6531.314212007671, 6557.967210163919, 6568.737250510022, 6589.604623722592, 1036.186673321687, 1040.921930855189, 1044.7283706236433, 1055.8469021991768, 1079.2876701377054, 5204.76578553966, 5279.841604751864, 5296.152615581565, 5301.920471192935, 5302.628815982921, 8127.552984585786, 8182.345412366996, 8342.249197572248, 8380.664773409117, 8402.11777763326, 8268.2558569729, 8317.376196785266, 8324.0, 8405.033421156522, 8431.662733490715, 6426.196725409324, 6538.640374779433, 6557.639329836905, 6578.63817490033, 6632.1709786276715, 6373.968130159319, 6381.617102973836, 6385.8722825544155, 6391.744330226739, 6397.488200944006, 7377.483576149618, 7492.363149132385, 7512.32389084985, 7524.962375188089, 7547.132079810673, 7373.77878663641, 7573.46985710995, 7660.0, 7694.384449244159, 7750.573718445539, 6253.624782513064, 6282.2147231596055, 6300.306966233802, 6311.084892690443, 6325.240971083499, 6181.505479561714, 6566.277709451861, 6576.079348891255, 6579.078928950046, 6636.2368327642935, 6228.691974685366, 6279.874402512016, 6330.746770129143, 6376.776812811529, 6404.71178796946, 5862.355140934579, 6175.5677102602385, 6232.220972378453, 6280.623162610258, 6306.211723534559, 6330.778422755181, 6364.172657554488, 6380.776672816429, 6404.359564043559, 6422.165118534747, 5964.343922168471, 5990.191324171181, 5992.610480318765, 5997.520198384206, 5999.040153575407, 5669.54643628517, 6060.484858787053, 6098.512119030555, 6100.298465676504, 6109.694515274307], "unit": "ms", "name": "mootools.html", "value": 4055.9958946960055}, {"lowerIsBetter": false, "replicates": [301.23035643929757, 302.9560713696514, 306.8573113502222, 307.58783230471164, 310.1873092497655, 5323.0, 5335.33308336458, 5348.625596208267, 5367.355917289921, 5376.059189641816, 5024.070546948817, 5131.102057139995, 5198.740062996854, 5286.524212820846, 5322.654027488211, 4127.463429754142, 4137.6482998944975, 4140.399642051901, 4141.316682747343, 4153.937690934638, 3916.823742931575, 4141.482314710661, 4141.482314710661, 4145.0880806222585, 4152.792360381969, 3961.1285517186175, 3999.620036096581, 4094.877153685394, 4107.424960505532, 4134.29716948118, 4133.04939863833, 4135.60711732385, 4137.813798379065, 4142.565030671796, 4144.12973275611, 3645.6901163401144, 3647.1793846384617, 3654.853805847763, 3656.433252845813, 3657.4696668983115, 5084.161113416282, 5092.668976516515, 5096.949030509684, 5106.131957567222, 5116.053530096944, 4557.886052848672, 4673.042026384583, 4682.531746825324, 4739.0, 4779.784909679072, 5632.239647647556, 5634.577406694514, 5635.408282130358, 5638.718064096779, 5642.04085305499, 3863.285292220948, 3867.1298957734566, 3873.845046198149, 3876.8836934891997, 3878.8448462061483, 5850.327212370589, 5943.0, 5944.881102377972, 5948.0, 5952.047672372443, 3920.1571662092215, 4014.638682518529, 4015.6988225883174, 4016.0562267867613, 4033.858814941522, 4077.673786097105, 4079.204555111784, 4080.143169934347, 4083.305838007546, 4085.22380747657, 4683.812647494062, 4684.039771846763, 4684.344191813149, 4689.859304220879, 4696.178168820511, 5622.57830662702, 5632.5775566831835, 5640.605157639008, 5642.463965923231, 5643.633163844337, 1413.6819215676392, 1424.7293014327245, 1446.4720377062297, 1451.608065822222, 1452.194032312056, 961.6009356117133, 972.9221662267001, 974.6004138303404, 983.041534503853, 984.6652138272879, 4944.1100601891285, 4945.67853089548, 4951.158303088484, 4953.157963146274, 4954.8761280968265, 5862.0, 5863.824085277449, 5876.206712093813, 5877.147813567009, 5878.441548052928, 4780.235162374073, 4840.515948405202, 4899.338589290472, 4899.946511500045, 4983.775730092155, 3137.51368537877, 3149.9685003150134, 3159.020703581897, 3166.0, 3175.380800743833, 5542.667439953535, 5549.889002220014, 5552.333719953632, 5553.944460555424, 5557.694326811983, 5927.407259274038, 6044.576879618472, 6059.7273122709585, 6061.908856405889, 6066.545009124245, 5545.805896793593, 5551.139573366135, 5551.639143455663, 5552.666839989613, 5553.805616803393, 5890.941090589039, 5892.852678683067, 5909.586328957103, 5911.379305172895, 5913.113033045078, 5741.655500669973, 5743.540516758733, 5746.592084939217, 5747.051736463437, 5748.425157484218, 5397.3523177218985, 5546.140348246028, 5562.666240025612, 5571.4428557143965, 5586.664800112007, 4027.234825383168, 4055.2903241931954, 4057.756534607933, 4064.085580744309, 4065.4511640928094, 5916.822495325147, 5919.082542205965, 5923.08192230205, 5924.437178468039, 5927.733252003756, 5584.609077364708, 5674.517665998271, 5691.089425691869, 5697.800576979786, 5706.514946229451, 5679.858003549944, 5696.316442026983, 5699.487046165865, 5699.5725320600295, 5701.743421545957, 5574.219609254626, 5574.470425309589, 5576.414476479911, 5579.274694289878, 5582.078956972054, 5727.8568035799435, 5729.169270455844, 5729.312482502127, 5732.914006289992, 5734.426557344233, 5415.891682166413, 5614.52276556481, 5619.0, 5620.1288800236025, 5621.072523033654], "unit": "ms", "name": "prototype.html", "value": 4231.6854058211775}, {"lowerIsBetter": false, "replicates": [774.4810976645647, 776.8019155115445, 782.1552723059095, 795.1889073145392, 816.8897198878157, 12667.873321266785, 12972.740545189103, 12980.350982450887, 12985.220886746802, 12996.74006519869, 13484.0, 13828.723425531483, 13833.17000979942, 13857.0, 13858.307084645752, 636.5544119116637, 644.9097126402307, 807.7092246791166, 825.4428260923883, 825.7440193539992, 811.6875003123781, 818.1981657975188, 828.1180542722012, 828.5070383122032, 828.8963879515061, 861.8060936289316, 867.3494878840869, 868.1839071273015, 868.4355169140047, 868.4485351801588, 659.5053709717712, 668.3183153183726, 848.3467729848044, 862.5687156421789, 866.7313132928781, 636.3254949753276, 638.5211091681239, 638.8786130635165, 639.3766078073887, 640.0942666127471, 11928.224665396721, 12171.695707607381, 12227.205231659913, 12266.202696824677, 12267.447964841604, 9837.213022958145, 10409.739756506073, 10514.31656942304, 11002.119830413547, 11512.194146409754, 8353.457025293337, 9174.633014679404, 9238.307126965505, 9307.92958809732, 9861.0, 3010.08192501287, 3068.6624471308137, 3097.6902309769066, 3117.610298712661, 3119.906402807919, 39919.20161596752, 40091.59908400908, 40254.79872600648, 40299.395509067384, 41201.79399103015, 8180.9181908181345, 8187.754367368989, 8204.425690201748, 8310.0, 8487.575621219037, 14936.551903442914, 14962.551123466314, 14991.32539035746, 14991.775123373158, 15004.099754014795, 6217.564770466024, 6263.561550691499, 6276.560640755195, 6323.083152942798, 6373.936260637334, 3501.474778783152, 3608.332458495187, 3635.381985062546, 3647.7993710345654, 3658.5243918290985, 2548.210054882992, 2557.7698007179442, 2580.2001379572016, 2580.316216202708, 2582.4705935283223, 443.6783332084213, 452.9320601909674, 454.2414168338882, 458.827939522679, 463.4901608230986, 378.4947095627313, 516.2101983964466, 524.3838489774575, 529.5075579710906, 537.1781174802559, 7100.751473698396, 7211.747588834365, 7243.239459856639, 7252.5648461092505, 7345.3021962913435, 465.97204167750044, 533.7358007786171, 537.3417563484778, 541.2719891745596, 547.5099785691863, 3591.317649646559, 3673.797941113211, 3886.5336159660455, 3998.640122388999, 4022.0950286185375, 49450.0, 50423.0, 50738.0, 52798.47201527935, 53295.0, 43700.78149609295, 44304.0, 44467.77766111149, 44613.33080003737, 44701.776491117336, 40877.59122408797, 41145.382819257735, 41300.173996520505, 41393.1721365571, 41393.79303103465, 7669.884951725617, 7784.0, 7848.018997625297, 7879.251471110236, 8331.416800823885, 29845.507724614115, 31151.53272700866, 31513.212169695023, 31869.68130318667, 32054.35891282208, 39371.212575747755, 39826.60173398229, 39903.600963989986, 40177.79911100426, 40451.0, 9750.853737193806, 9940.155086817413, 9947.751306217402, 10063.949680251551, 10082.092611664986, 10573.682789516326, 11053.944730276296, 11109.444527773418, 11183.217174797686, 11415.200935934405, 9889.653862114792, 9899.703008909744, 10010.799784004133, 10095.242856785624, 10291.0, 9914.157296629868, 10025.448600327052, 10276.307237374116, 10492.685219443429, 10976.0, 9991.600335986479, 10029.942357225762, 10076.546555404877, 10108.039736225046, 10119.342242754197, 8918.955405222932, 9146.176844084064, 9200.0, 9259.67591134307, 9344.766380840534, 8284.668613255402, 8547.230749232598, 8628.611712473079, 8689.131086891513, 8901.198892099743], "unit": "ms", "name": "yui.html", "value": 5641.658087351152}], "name": "dromaeo_css", "value": 6279.3473194509415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 111.0, 113.0, 113.0, 101.0, 112.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [163.0, 130.0, 162.0, 164.0, 140.0, 156.0, 153.0, 130.0, 167.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 160.0, 161.0, 159.0, 161.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 93.0, 91.0, 71.0, 74.0, 72.0, 95.0, 92.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 131.0, 93.0, 94.0, 94.0, 136.0, 94.0, 96.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 72.0, 71.0, 70.0, 71.0, 80.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 85.0, 82.0, 83.0, 84.0, 84.0, 84.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [126.0, 123.0, 124.0, 127.0, 115.0, 122.0, 128.0, 127.0, 122.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [137.0, 150.0, 150.0, 152.0, 148.0, 136.0, 149.0, 146.0, 148.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [78.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1521.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [186.81113394358303], "unit": "score", "name": "DeltaBlue", "value": 353.92965399999986}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [602.7727546714889], "unit": "score", "name": "Splay", "value": 135.19356900000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19828.08103653324}]} 11:25:51 INFO - RETURN: dromaeo_css: 6279.35 11:25:51 INFO - RETURN: kraken: 1521.80 11:25:51 INFO - RETURN: v8_7: 19828.08 11:25:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19828.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6279.35"}}} 11:25:51 INFO - Return code: 0 11:25:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:25:51 ERROR - # TBPL SUCCESS # 11:25:51 INFO - Running post-action listener: _resource_record_post_action 11:25:51 INFO - Running post-run listener: _resource_record_post_run 11:25:52 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509632512; Read time: 8; Write time: 583012 11:25:52 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 231079936; Read time: 0; Write time: 355816 11:25:52 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278114304; Read time: 8; Write time: 227160 11:25:52 INFO - Running post-run listener: _upload_blobber_files 11:25:52 INFO - Blob upload gear active. 11:25:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:25:52 INFO - Copying logs to upload dir... 11:25:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.061892 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-11 11:25:52.498957) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:25:52.503086) ========= 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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010087 build_url: 'https://queue.taskcluster.net/v1/task/-yWDbpJoQ-e-8qtrlw1HwA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:25:52.558797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:25:52.559187) ========= 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=6d5287d839824eebc594b0c9000001d1-1449860669.235410-74122374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:25:52.609484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 11:25:52.609825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 11:25:52.610127) ========= ========= Total master_lag: 0.26 =========