builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1449778970.71 results: success (0) buildid: 20151210113952 builduid: 1a6bc0829c314e729d621b58604c676c revision: 11c67a7b46b5158bd48a7216ab45f124a71d4794 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.715105) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.715579) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.715875) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006425 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.743170) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.743475) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.764336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.764692) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.814416) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.814795) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.815258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.815606) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 12:22:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-10 12:22:50 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.944260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.944584) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020371 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.996127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:50.996474) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 11c67a7b46b5158bd48a7216ab45f124a71d4794 --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 11c67a7b46b5158bd48a7216ab45f124a71d4794 --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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 12:22:51,030 truncating revision to first 12 chars 2015-12-10 12:22:51,030 Setting DEBUG logging. 2015-12-10 12:22:51,030 attempt 1/10 2015-12-10 12:22:51,030 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/11c67a7b46b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 12:22:51,297 unpacking tar archive at: fx-team-11c67a7b46b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:51.541279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:51.541622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:51.554511) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:51.554779) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 12:22:51.555188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 12:22:51.555494) ========= /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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:22:51 INFO - MultiFileLogger online at 20151210 12:22:51 in /builds/slave/test 12:22:51 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 12:22:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:22:51 INFO - {'append_to_log': False, 12:22:51 INFO - 'base_work_dir': '/builds/slave/test', 12:22:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:22:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:22:51 INFO - 'branch': 'Fx-Team-Non-PGO', 12:22:51 INFO - 'buildbot_json_path': 'buildprops.json', 12:22:51 INFO - 'config_files': ('talos/linux_config.py',), 12:22:51 INFO - 'default_actions': ('clobber', 12:22:51 INFO - 'read-buildbot-config', 12:22:51 INFO - 'download-and-extract', 12:22:51 INFO - 'populate-webroot', 12:22:51 INFO - 'create-virtualenv', 12:22:51 INFO - 'install', 12:22:51 INFO - 'run-tests'), 12:22:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:22:51 INFO - 'download_minidump_stackwalk': True, 12:22:51 INFO - 'download_symbols': 'ondemand', 12:22:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:22:51 INFO - 'tooltool.py': '/tools/tooltool.py', 12:22:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:22:51 INFO - '/tools/misc-python/virtualenv.py')}, 12:22:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:22:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:22:51 INFO - 'installer_path': 'installer.exe', 12:22:51 INFO - 'log_level': 'info', 12:22:51 INFO - 'log_name': 'talos', 12:22:51 INFO - 'log_to_console': True, 12:22:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:22:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:22:51 INFO - 'opt_config_files': (), 12:22:51 INFO - 'pip_index': False, 12:22:51 INFO - 'sps_profile': False, 12:22:51 INFO - 'sps_profile_interval': 0, 12:22:51 INFO - 'suite': 'dromaeojs', 12:22:51 INFO - 'system_bits': '64', 12:22:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:22:51 INFO - 'title': 'talos-linux64-ix-030', 12:22:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:22:51 INFO - 'use_talos_json': True, 12:22:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:22:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:22:51 INFO - 'work_dir': 'build'} 12:22:51 INFO - ##### 12:22:51 INFO - ##### Running clobber step. 12:22:51 INFO - ##### 12:22:51 INFO - Running pre-action listener: _resource_record_pre_action 12:22:51 INFO - Running main action method: clobber 12:22:51 INFO - rmtree: /builds/slave/test/build 12:22:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:22:52 INFO - Running post-action listener: _resource_record_post_action 12:22:52 INFO - ##### 12:22:52 INFO - ##### Running read-buildbot-config step. 12:22:52 INFO - ##### 12:22:52 INFO - Running pre-action listener: _resource_record_pre_action 12:22:52 INFO - Running main action method: read_buildbot_config 12:22:52 INFO - Using buildbot properties: 12:22:52 INFO - { 12:22:52 INFO - "properties": { 12:22:52 INFO - "buildnumber": 1002, 12:22:52 INFO - "product": "firefox", 12:22:52 INFO - "script_repo_revision": "production", 12:22:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:22:52 INFO - "repository": "", 12:22:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:22:52 INFO - "buildid": "20151210113952", 12:22:52 INFO - "slavename": "talos-linux64-ix-030", 12:22:52 INFO - "pgo_build": "False", 12:22:52 INFO - "basedir": "/builds/slave/test", 12:22:52 INFO - "project": "", 12:22:52 INFO - "platform": "ubuntu64_hw", 12:22:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:22:52 INFO - "slavebuilddir": "test", 12:22:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:22:52 INFO - "branch": "fx-team", 12:22:52 INFO - "repo_path": "integration/fx-team", 12:22:52 INFO - "stage_platform": "linux64", 12:22:52 INFO - "builduid": "1a6bc0829c314e729d621b58604c676c", 12:22:52 INFO - "revision": "11c67a7b46b5158bd48a7216ab45f124a71d4794" 12:22:52 INFO - }, 12:22:52 INFO - "sourcestamp": { 12:22:52 INFO - "repository": "", 12:22:52 INFO - "hasPatch": false, 12:22:52 INFO - "project": "", 12:22:52 INFO - "branch": "fx-team-linux64-talos", 12:22:52 INFO - "changes": [ 12:22:52 INFO - { 12:22:52 INFO - "category": null, 12:22:52 INFO - "files": [ 12:22:52 INFO - { 12:22:52 INFO - "url": null, 12:22:52 INFO - "name": "https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:22:52 INFO - } 12:22:52 INFO - ], 12:22:52 INFO - "repository": "", 12:22:52 INFO - "rev": "11c67a7b46b5158bd48a7216ab45f124a71d4794", 12:22:52 INFO - "who": "felipc@gmail.com", 12:22:52 INFO - "when": 1449778916, 12:22:52 INFO - "number": 7268183, 12:22:52 INFO - "comments": "Bug 1231728 - Fixes sync/setup.js switch statement. r=markh", 12:22:52 INFO - "project": "", 12:22:52 INFO - "at": "Thu 10 Dec 2015 12:21:56", 12:22:52 INFO - "branch": "fx-team-linux64-talos", 12:22:52 INFO - "revlink": "", 12:22:52 INFO - "properties": [ 12:22:52 INFO - [ 12:22:52 INFO - "buildid", 12:22:52 INFO - "20151210113952", 12:22:52 INFO - "Change" 12:22:52 INFO - ], 12:22:52 INFO - [ 12:22:52 INFO - "builduid", 12:22:52 INFO - "1a6bc0829c314e729d621b58604c676c", 12:22:52 INFO - "Change" 12:22:52 INFO - ], 12:22:52 INFO - [ 12:22:52 INFO - "pgo_build", 12:22:52 INFO - "False", 12:22:52 INFO - "Change" 12:22:52 INFO - ] 12:22:52 INFO - ], 12:22:52 INFO - "revision": "11c67a7b46b5158bd48a7216ab45f124a71d4794" 12:22:52 INFO - } 12:22:52 INFO - ], 12:22:52 INFO - "revision": "11c67a7b46b5158bd48a7216ab45f124a71d4794" 12:22:52 INFO - } 12:22:52 INFO - } 12:22:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:22:52 INFO - Running post-action listener: _resource_record_post_action 12:22:52 INFO - ##### 12:22:52 INFO - ##### Running download-and-extract step. 12:22:52 INFO - ##### 12:22:52 INFO - Running pre-action listener: _resource_record_pre_action 12:22:52 INFO - Running main action method: download_and_extract 12:22:52 INFO - mkdir: /builds/slave/test/build/tests 12:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:22:52 INFO - https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:22:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/test_packages.json 12:22:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/test_packages.json 12:22:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:22:54 INFO - Downloaded 1302 bytes. 12:22:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:22:54 INFO - Using the following test package requirements: 12:22:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:22:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:54 INFO - u'jsshell-linux-x86_64.zip'], 12:22:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:22:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:22:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:22:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:22:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:22:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:22:54 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')]} 12:22:54 INFO - https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:22:58 INFO - Downloaded 21866925 bytes. 12:22:58 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 12:22:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:22:58 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 12:22:59 INFO - Return code: 0 12:22:59 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 12:22: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')]} 12:22:59 INFO - https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:22:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:22:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:22:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:23:07 INFO - Downloaded 21866925 bytes. 12:23:07 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 12:23:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:23:07 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 12:23:08 INFO - Return code: 0 12:23: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')]} 12:23:08 INFO - https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:23:09 INFO - Downloaded 11132038 bytes. 12:23:09 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 12:23:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:23:09 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 12:23:09 INFO - Return code: 0 12:23:09 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')]} 12:23:09 INFO - https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pthj8n_QSwq8HEoTOUagyw/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 12:23:11 INFO - Downloaded 57730947 bytes. 12:23:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:23:11 INFO - mkdir: /builds/slave/test/properties 12:23:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:23:11 INFO - Writing to file /builds/slave/test/properties/build_url 12:23:11 INFO - Contents: 12:23:11 INFO - build_url:https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:23:11 INFO - Running post-action listener: _resource_record_post_action 12:23:11 INFO - Running post-action listener: set_extra_try_arguments 12:23:11 INFO - ##### 12:23:11 INFO - ##### Running populate-webroot step. 12:23:11 INFO - ##### 12:23:11 INFO - Running pre-action listener: _resource_record_pre_action 12:23:11 INFO - Running main action method: populate_webroot 12:23:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:23:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:23:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:23:11 INFO - '--tppagecycles', 12:23:11 INFO - '7'], 12:23:11 INFO - 'tests': ['tsvgm']}}, 12:23:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:23:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:23:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:23:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:23:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'tests': ['damp', 'tps']}, 12:23:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['damp', 'tps']}, 12:23:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:23:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:23:11 INFO - 'other': {'tests': ['a11yr', 12:23:11 INFO - 'ts_paint', 12:23:11 INFO - 'tpaint', 12:23:11 INFO - 'sessionrestore', 12:23:11 INFO - 'sessionrestore_no_auto_restore']}, 12:23:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['a11yr', 12:23:11 INFO - 'ts_paint', 12:23:11 INFO - 'tpaint', 12:23:11 INFO - 'sessionrestore', 12:23:11 INFO - 'sessionrestore_no_auto_restore']}, 12:23:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['a11yr', 12:23:11 INFO - 'ts_paint', 12:23:11 INFO - 'tpaint', 12:23:11 INFO - 'sessionrestore', 12:23:11 INFO - 'sessionrestore_no_auto_restore']}, 12:23:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['a11yr', 12:23:11 INFO - 'ts_paint', 12:23:11 INFO - 'tpaint', 12:23:11 INFO - 'sessionrestore', 12:23:11 INFO - 'sessionrestore_no_auto_restore']}, 12:23:11 INFO - 'other_l64': {'tests': ['a11yr', 12:23:11 INFO - 'ts_paint', 12:23:11 INFO - 'tpaint', 12:23:11 INFO - 'sessionrestore', 12:23:11 INFO - 'sessionrestore_no_auto_restore']}, 12:23:11 INFO - 'other_nol64': {'tests': ['a11yr', 12:23:11 INFO - 'ts_paint', 12:23:11 INFO - 'tpaint', 12:23:11 INFO - 'sessionrestore', 12:23:11 INFO - 'sessionrestore_no_auto_restore']}, 12:23:11 INFO - 'svgr': {'tests': ['tsvgx', 12:23:11 INFO - 'tsvgr_opacity', 12:23:11 INFO - 'tart', 12:23:11 INFO - 'tscrollx', 12:23:11 INFO - 'cart']}, 12:23:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['tsvgx', 12:23:11 INFO - 'tsvgr_opacity', 12:23:11 INFO - 'tart', 12:23:11 INFO - 'tscrollx', 12:23:11 INFO - 'cart']}, 12:23:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'tests': ['tp5o']}, 12:23:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'talos_options': ['--e10s'], 12:23:11 INFO - 'tests': ['tp5o']}, 12:23:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'talos_options': ['--xperf_path', 12:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:11 INFO - 'tests': ['tp5n']}, 12:23:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:11 INFO - 'talos_options': ['--e10s', 12:23:11 INFO - '--xperf_path', 12:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:11 INFO - 'tests': ['tp5n']}}, 12:23:11 INFO - 'talos.zip': {'path': '', 12:23:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:23:11 INFO - Running post-action listener: _resource_record_post_action 12:23:11 INFO - ##### 12:23:11 INFO - ##### Running create-virtualenv step. 12:23:11 INFO - ##### 12:23:11 INFO - Running pre-action listener: _resource_record_pre_action 12:23:11 INFO - Running main action method: create_virtualenv 12:23:11 INFO - Creating virtualenv /builds/slave/test/build/venv 12:23:11 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 12:23:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:23:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:23:11 INFO - Using real prefix '/usr' 12:23:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:23:12 INFO - Installing distribute.............................................................................................................................................................................................done. 12:23:14 INFO - Installing pip.................done. 12:23:14 INFO - Return code: 0 12:23:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:23: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')]} 12:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23: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')]} 12:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23: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', 'pip>=1.5'] in /builds/slave/test/build 12:23: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 pip>=1.5 12:23:14 INFO - Using env: {'DISPLAY': ':0', 12:23:14 INFO - 'HOME': '/home/cltbld', 12:23:14 INFO - 'LANG': 'en_US.UTF-8', 12:23:14 INFO - 'LANGUAGE': 'en_US:en', 12:23:14 INFO - 'LOGNAME': 'cltbld', 12:23:14 INFO - 'MAIL': '/var/mail/cltbld', 12:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:14 INFO - 'MOZ_NO_REMOTE': '1', 12:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:14 INFO - 'NO_EM_RESTART': '1', 12:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:14 INFO - 'PWD': '/builds/slave/test', 12:23:14 INFO - 'SHELL': '/bin/bash', 12:23:14 INFO - 'SHLVL': '1', 12:23:14 INFO - 'TERM': 'linux', 12:23:14 INFO - 'TMOUT': '86400', 12:23:14 INFO - 'USER': 'cltbld', 12:23:14 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:14 INFO - '_': '/tools/buildbot/bin/python'} 12:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:14 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 12:23:14 INFO - Cleaning up... 12:23:14 INFO - Return code: 0 12:23:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:23: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')]} 12:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23: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')]} 12:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23: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', '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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:23: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 psutil>=0.7.1 12:23:14 INFO - Using env: {'DISPLAY': ':0', 12:23:14 INFO - 'HOME': '/home/cltbld', 12:23:14 INFO - 'LANG': 'en_US.UTF-8', 12:23:14 INFO - 'LANGUAGE': 'en_US:en', 12:23:14 INFO - 'LOGNAME': 'cltbld', 12:23:14 INFO - 'MAIL': '/var/mail/cltbld', 12:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:14 INFO - 'MOZ_NO_REMOTE': '1', 12:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:14 INFO - 'NO_EM_RESTART': '1', 12:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:14 INFO - 'PWD': '/builds/slave/test', 12:23:14 INFO - 'SHELL': '/bin/bash', 12:23:14 INFO - 'SHLVL': '1', 12:23:14 INFO - 'TERM': 'linux', 12:23:14 INFO - 'TMOUT': '86400', 12:23:14 INFO - 'USER': 'cltbld', 12:23:14 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:14 INFO - '_': '/tools/buildbot/bin/python'} 12:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:14 INFO - Downloading/unpacking psutil>=0.7.1 12:23: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 12:23: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 12:23: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 12:23: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 12:23: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 12:23: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 12:23:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:23:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:16 INFO - Installing collected packages: psutil 12:23:16 INFO - Running setup.py install for psutil 12:23:16 INFO - building 'psutil._psutil_linux' extension 12:23:16 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 12:23:16 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 12:23:16 INFO - building 'psutil._psutil_posix' extension 12:23:16 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 12:23:16 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 12:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:16 INFO - Successfully installed psutil 12:23:16 INFO - Cleaning up... 12:23:17 INFO - Return code: 0 12:23:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:23:17 INFO - Using env: {'DISPLAY': ':0', 12:23:17 INFO - 'HOME': '/home/cltbld', 12:23:17 INFO - 'LANG': 'en_US.UTF-8', 12:23:17 INFO - 'LANGUAGE': 'en_US:en', 12:23:17 INFO - 'LOGNAME': 'cltbld', 12:23:17 INFO - 'MAIL': '/var/mail/cltbld', 12:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:17 INFO - 'MOZ_NO_REMOTE': '1', 12:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:17 INFO - 'NO_EM_RESTART': '1', 12:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:17 INFO - 'PWD': '/builds/slave/test', 12:23:17 INFO - 'SHELL': '/bin/bash', 12:23:17 INFO - 'SHLVL': '1', 12:23:17 INFO - 'TERM': 'linux', 12:23:17 INFO - 'TMOUT': '86400', 12:23:17 INFO - 'USER': 'cltbld', 12:23:17 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:17 INFO - '_': '/tools/buildbot/bin/python'} 12:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:23: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 12:23: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 12:23: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 12:23: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 12:23: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 12:23: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 12:23:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:23:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:23:18 INFO - Installing collected packages: mozsystemmonitor 12:23:18 INFO - Running setup.py install for mozsystemmonitor 12:23:19 INFO - Successfully installed mozsystemmonitor 12:23:19 INFO - Cleaning up... 12:23:19 INFO - Return code: 0 12:23:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:23:19 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')]} 12:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:19 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')]} 12:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:19 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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23:19 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 12:23:19 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 12:23:19 INFO - Using env: {'DISPLAY': ':0', 12:23:19 INFO - 'HOME': '/home/cltbld', 12:23:19 INFO - 'LANG': 'en_US.UTF-8', 12:23:19 INFO - 'LANGUAGE': 'en_US:en', 12:23:19 INFO - 'LOGNAME': 'cltbld', 12:23:19 INFO - 'MAIL': '/var/mail/cltbld', 12:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:19 INFO - 'MOZ_NO_REMOTE': '1', 12:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:19 INFO - 'NO_EM_RESTART': '1', 12:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:19 INFO - 'PWD': '/builds/slave/test', 12:23:19 INFO - 'SHELL': '/bin/bash', 12:23:19 INFO - 'SHLVL': '1', 12:23:19 INFO - 'TERM': 'linux', 12:23:19 INFO - 'TMOUT': '86400', 12:23:19 INFO - 'USER': 'cltbld', 12:23:19 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:19 INFO - '_': '/tools/buildbot/bin/python'} 12:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:19 INFO - Downloading/unpacking blobuploader==1.2.4 12:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:23:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:23:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:23:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 INFO - Downloading docopt-0.6.1.tar.gz 12:23:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:23:21 INFO - Installing collected packages: blobuploader, requests, docopt 12:23:21 INFO - Running setup.py install for blobuploader 12:23:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:23:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:23:21 INFO - Running setup.py install for requests 12:23:22 INFO - Running setup.py install for docopt 12:23:22 INFO - Successfully installed blobuploader requests docopt 12:23:22 INFO - Cleaning up... 12:23:22 INFO - Return code: 0 12:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:22 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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23:22 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 12:23:22 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 12:23:22 INFO - Using env: {'DISPLAY': ':0', 12:23:22 INFO - 'HOME': '/home/cltbld', 12:23:22 INFO - 'LANG': 'en_US.UTF-8', 12:23:22 INFO - 'LANGUAGE': 'en_US:en', 12:23:22 INFO - 'LOGNAME': 'cltbld', 12:23:22 INFO - 'MAIL': '/var/mail/cltbld', 12:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:22 INFO - 'MOZ_NO_REMOTE': '1', 12:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:22 INFO - 'NO_EM_RESTART': '1', 12:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:22 INFO - 'PWD': '/builds/slave/test', 12:23:22 INFO - 'SHELL': '/bin/bash', 12:23:22 INFO - 'SHLVL': '1', 12:23:22 INFO - 'TERM': 'linux', 12:23:22 INFO - 'TMOUT': '86400', 12:23:22 INFO - 'USER': 'cltbld', 12:23:22 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:22 INFO - '_': '/tools/buildbot/bin/python'} 12:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:22 INFO - Running setup.py (path:/tmp/pip-J7u1Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:22 INFO - Running setup.py (path:/tmp/pip-zpqSyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:22 INFO - Running setup.py (path:/tmp/pip-22SIQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:22 INFO - Running setup.py (path:/tmp/pip-2vAZeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:22 INFO - Running setup.py (path:/tmp/pip-LH1PkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:22 INFO - Running setup.py (path:/tmp/pip-pXdq6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:22 INFO - Running setup.py (path:/tmp/pip-9z2Ycn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:23 INFO - Running setup.py (path:/tmp/pip-mnunbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:23 INFO - Running setup.py (path:/tmp/pip-FmK1_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:23 INFO - Running setup.py (path:/tmp/pip-jP86Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:23 INFO - Running setup.py (path:/tmp/pip-2lshw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:23 INFO - Running setup.py (path:/tmp/pip-P75OEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:23 INFO - Running setup.py (path:/tmp/pip-LMOOy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:23 INFO - Running setup.py (path:/tmp/pip-HfSIdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:23 INFO - Running setup.py (path:/tmp/pip-s8JoBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:23 INFO - Running setup.py (path:/tmp/pip-A65QTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:23 INFO - Running setup.py (path:/tmp/pip-MJzAgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:23:23 INFO - Running setup.py install for manifestparser 12:23:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:23:23 INFO - Running setup.py install for mozcrash 12:23:23 INFO - Running setup.py install for mozdebug 12:23:23 INFO - Running setup.py install for mozdevice 12:23:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Running setup.py install for mozfile 12:23:24 INFO - Running setup.py install for mozhttpd 12:23:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Running setup.py install for mozinfo 12:23:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Running setup.py install for mozInstall 12:23:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Running setup.py install for mozleak 12:23:24 INFO - Running setup.py install for mozlog 12:23:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Running setup.py install for moznetwork 12:23:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:23:24 INFO - Running setup.py install for mozprocess 12:23:24 INFO - Running setup.py install for mozprofile 12:23:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Running setup.py install for mozrunner 12:23:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Running setup.py install for mozscreenshot 12:23:25 INFO - Running setup.py install for moztest 12:23:25 INFO - Running setup.py install for mozversion 12:23:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:23:25 INFO - Cleaning up... 12:23:25 INFO - Return code: 0 12:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:25 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')]} 12:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:25 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')]} 12:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:25 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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23:25 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 12:23:25 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 12:23:25 INFO - Using env: {'DISPLAY': ':0', 12:23:25 INFO - 'HOME': '/home/cltbld', 12:23:25 INFO - 'LANG': 'en_US.UTF-8', 12:23:25 INFO - 'LANGUAGE': 'en_US:en', 12:23:25 INFO - 'LOGNAME': 'cltbld', 12:23:25 INFO - 'MAIL': '/var/mail/cltbld', 12:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:25 INFO - 'MOZ_NO_REMOTE': '1', 12:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:25 INFO - 'NO_EM_RESTART': '1', 12:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:25 INFO - 'PWD': '/builds/slave/test', 12:23:25 INFO - 'SHELL': '/bin/bash', 12:23:25 INFO - 'SHLVL': '1', 12:23:25 INFO - 'TERM': 'linux', 12:23:25 INFO - 'TMOUT': '86400', 12:23:25 INFO - 'USER': 'cltbld', 12:23:25 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:25 INFO - '_': '/tools/buildbot/bin/python'} 12:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:25 INFO - Running setup.py (path:/tmp/pip-ujBigI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:25 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)) 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:25 INFO - Running setup.py (path:/tmp/pip-TAJwsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:25 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)) 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:25 INFO - Running setup.py (path:/tmp/pip-Jf9DHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:25 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)) 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:25 INFO - Running setup.py (path:/tmp/pip-iX4M5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:25 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)) 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:25 INFO - Running setup.py (path:/tmp/pip-OcLNug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:26 INFO - Running setup.py (path:/tmp/pip-vlsm5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:26 INFO - Running setup.py (path:/tmp/pip-2TRkEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:26 INFO - Running setup.py (path:/tmp/pip-OCkTmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:26 INFO - Running setup.py (path:/tmp/pip-XRwCUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:26 INFO - Running setup.py (path:/tmp/pip-9Gq5KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:26 INFO - Running setup.py (path:/tmp/pip-38ubN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:26 INFO - Running setup.py (path:/tmp/pip-uIFEJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:26 INFO - Running setup.py (path:/tmp/pip-Jrdel2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:26 INFO - Running setup.py (path:/tmp/pip-TLWQl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:26 INFO - Running setup.py (path:/tmp/pip-ODj4Zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:26 INFO - Running setup.py (path:/tmp/pip-ESL3bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:26 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)) 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:26 INFO - Running setup.py (path:/tmp/pip-QN7uJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:26 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)) 12:23:26 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)) 12:23:26 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)) 12:23:26 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)) 12:23:26 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)) 12:23:26 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)) 12:23:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:23:26 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 12:23:26 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 12:23:26 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 12:23:26 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 12:23:26 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 12:23:26 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 12:23:28 INFO - Downloading blessings-1.5.1.tar.gz 12:23:28 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 12:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:23:28 INFO - Installing collected packages: blessings 12:23:28 INFO - Running setup.py install for blessings 12:23:28 INFO - Successfully installed blessings 12:23:28 INFO - Cleaning up... 12:23:28 INFO - Return code: 0 12:23:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:29 INFO - Reading from file tmpfile_stdout 12:23:29 INFO - Current package versions: 12:23:29 INFO - argparse == 1.2.1 12:23:29 INFO - blessings == 1.5.1 12:23:29 INFO - blobuploader == 1.2.4 12:23:29 INFO - docopt == 0.6.1 12:23:29 INFO - manifestparser == 1.1 12:23:29 INFO - mozInstall == 1.12 12:23:29 INFO - mozcrash == 0.16 12:23:29 INFO - mozdebug == 0.1 12:23:29 INFO - mozdevice == 0.47 12:23:29 INFO - mozfile == 1.2 12:23:29 INFO - mozhttpd == 0.7 12:23:29 INFO - mozinfo == 0.9 12:23:29 INFO - mozleak == 0.1 12:23:29 INFO - mozlog == 3.1 12:23:29 INFO - moznetwork == 0.27 12:23:29 INFO - mozprocess == 0.22 12:23:29 INFO - mozprofile == 0.27 12:23:29 INFO - mozrunner == 6.11 12:23:29 INFO - mozscreenshot == 0.1 12:23:29 INFO - mozsystemmonitor == 0.0 12:23:29 INFO - moztest == 0.7 12:23:29 INFO - mozversion == 1.4 12:23:29 INFO - psutil == 3.1.1 12:23:29 INFO - requests == 1.2.3 12:23:29 INFO - wsgiref == 0.1.2 12:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:29 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')]} 12:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:29 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')]} 12:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:29 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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23:29 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 12:23:29 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 12:23:29 INFO - Using env: {'DISPLAY': ':0', 12:23:29 INFO - 'HOME': '/home/cltbld', 12:23:29 INFO - 'LANG': 'en_US.UTF-8', 12:23:29 INFO - 'LANGUAGE': 'en_US:en', 12:23:29 INFO - 'LOGNAME': 'cltbld', 12:23:29 INFO - 'MAIL': '/var/mail/cltbld', 12:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:29 INFO - 'MOZ_NO_REMOTE': '1', 12:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:29 INFO - 'NO_EM_RESTART': '1', 12:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:29 INFO - 'PWD': '/builds/slave/test', 12:23:29 INFO - 'SHELL': '/bin/bash', 12:23:29 INFO - 'SHLVL': '1', 12:23:29 INFO - 'TERM': 'linux', 12:23:29 INFO - 'TMOUT': '86400', 12:23:29 INFO - 'USER': 'cltbld', 12:23:29 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:29 INFO - '_': '/tools/buildbot/bin/python'} 12:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 INFO - Cleaning up... 12:23:29 INFO - Return code: 0 12:23:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:23:29 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')]} 12:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:29 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')]} 12:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:29 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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23:29 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 12:23:29 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 12:23:29 INFO - Using env: {'DISPLAY': ':0', 12:23:29 INFO - 'HOME': '/home/cltbld', 12:23:29 INFO - 'LANG': 'en_US.UTF-8', 12:23:29 INFO - 'LANGUAGE': 'en_US:en', 12:23:29 INFO - 'LOGNAME': 'cltbld', 12:23:29 INFO - 'MAIL': '/var/mail/cltbld', 12:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:29 INFO - 'MOZ_NO_REMOTE': '1', 12:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:29 INFO - 'NO_EM_RESTART': '1', 12:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:29 INFO - 'PWD': '/builds/slave/test', 12:23:29 INFO - 'SHELL': '/bin/bash', 12:23:29 INFO - 'SHLVL': '1', 12:23:29 INFO - 'TERM': 'linux', 12:23:29 INFO - 'TMOUT': '86400', 12:23:29 INFO - 'USER': 'cltbld', 12:23:29 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:29 INFO - '_': '/tools/buildbot/bin/python'} 12:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:29 INFO - Downloading/unpacking jsonschema 12:23:29 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 12:23:29 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 12:23:29 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 12:23:29 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 12:23:29 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 12:23:29 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 12:23:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:23:31 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 12:23:31 INFO - Downloading/unpacking functools32 (from jsonschema) 12:23:31 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 12:23:31 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 12:23:31 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 12:23:31 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 12:23:31 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 12:23:31 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 12:23:31 INFO - Downloading functools32-3.2.3-2.tar.gz 12:23:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:23:31 INFO - warning: no files found matching '*.txt' 12:23:31 INFO - no previously-included directories found matching 'build' 12:23:31 INFO - no previously-included directories found matching 'dist' 12:23:31 INFO - no previously-included directories found matching '.git*' 12:23:31 INFO - Installing collected packages: jsonschema, functools32 12:23:31 INFO - Running setup.py install for functools32 12:23:31 INFO - warning: no files found matching '*.txt' 12:23:31 INFO - no previously-included directories found matching 'build' 12:23:31 INFO - no previously-included directories found matching 'dist' 12:23:31 INFO - no previously-included directories found matching '.git*' 12:23:31 INFO - Successfully installed jsonschema functools32 12:23:31 INFO - Cleaning up... 12:23:31 INFO - Return code: 0 12:23:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:23:31 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')]} 12:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:31 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')]} 12:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:31 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 0x7ff0618b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c79240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', '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 12:23:31 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 12:23:31 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 12:23:31 INFO - Using env: {'DISPLAY': ':0', 12:23:31 INFO - 'HOME': '/home/cltbld', 12:23:31 INFO - 'LANG': 'en_US.UTF-8', 12:23:31 INFO - 'LANGUAGE': 'en_US:en', 12:23:31 INFO - 'LOGNAME': 'cltbld', 12:23:31 INFO - 'MAIL': '/var/mail/cltbld', 12:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:31 INFO - 'MOZ_NO_REMOTE': '1', 12:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:31 INFO - 'NO_EM_RESTART': '1', 12:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:31 INFO - 'PWD': '/builds/slave/test', 12:23:31 INFO - 'SHELL': '/bin/bash', 12:23:31 INFO - 'SHLVL': '1', 12:23:31 INFO - 'TERM': 'linux', 12:23:31 INFO - 'TMOUT': '86400', 12:23:31 INFO - 'USER': 'cltbld', 12:23:31 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:31 INFO - '_': '/tools/buildbot/bin/python'} 12:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:31 INFO - Downloading/unpacking flake8 12:23:31 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 12:23:31 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 12:23:31 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 12:23:31 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 12:23:31 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 12:23:31 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 12:23:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:23:33 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 12:23:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:23:33 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 12:23:33 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 12:23:33 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 12:23:33 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 12:23:33 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 12:23:33 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 12:23:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:23:33 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 12:23:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:23:33 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 12:23:33 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 12:23:33 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 12:23:33 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 12:23:33 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 12:23:33 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 12:23:34 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 12:23:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:23:34 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 12:23:34 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 12:23:34 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 12:23:34 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 12:23:34 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 12:23:34 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 12:23:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:23:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:23:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:23:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:23:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:23:34 INFO - no previously-included directories found matching 'docs/_build' 12:23:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:23:34 INFO - Running setup.py install for pep8 12:23:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:23:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:23:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:23:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:23:34 INFO - no previously-included directories found matching 'docs/_build' 12:23:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:23:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:23:34 INFO - Cleaning up... 12:23:34 INFO - Return code: 0 12:23:34 INFO - Running post-action listener: _resource_record_post_action 12:23:34 INFO - Running post-action listener: _start_resource_monitoring 12:23:34 INFO - Starting resource monitoring. 12:23:34 INFO - ##### 12:23:34 INFO - ##### Running install step. 12:23:34 INFO - ##### 12:23:34 INFO - Running pre-action listener: _resource_record_pre_action 12:23:34 INFO - Running main action method: install 12:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:34 INFO - Reading from file tmpfile_stdout 12:23:34 INFO - Detecting whether we're running mozinstall >=1.0... 12:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:23:34 INFO - Reading from file tmpfile_stdout 12:23:34 INFO - Output received: 12:23:34 INFO - Usage: mozinstall [options] installer 12:23:34 INFO - Options: 12:23:34 INFO - -h, --help show this help message and exit 12:23:34 INFO - -d DEST, --destination=DEST 12:23:34 INFO - Directory to install application into. [default: 12:23:34 INFO - "/builds/slave/test"] 12:23:34 INFO - --app=APP Application being installed. [default: firefox] 12:23:34 INFO - mkdir: /builds/slave/test/build/application 12:23:34 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'] 12:23:34 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 12:23:49 INFO - Reading from file tmpfile_stdout 12:23:49 INFO - Output received: 12:23:49 INFO - /builds/slave/test/build/application/firefox/firefox 12:23:49 INFO - Running post-action listener: _resource_record_post_action 12:23:49 INFO - ##### 12:23:49 INFO - ##### Running run-tests step. 12:23:49 INFO - ##### 12:23:49 INFO - Running pre-action listener: _resource_record_pre_action 12:23:49 INFO - Running main action method: run_tests 12:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:23:49 INFO - Python 2.7.3 12:23:49 INFO - Return code: 0 12:23:49 INFO - grabbing minidump binary from tooltool 12:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:23:49 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 0x1d080b0>, '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 0x1d08fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:23:49 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 12:23:49 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 12:23:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:23:49 INFO - Return code: 0 12:23:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:23:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:23:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:23:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:23:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:23:50 INFO - Return code: 0 12:23:50 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/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 12:23:50 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/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 12:23:50 INFO - Using env: {'DISPLAY': ':0', 12:23:50 INFO - 'HOME': '/home/cltbld', 12:23:50 INFO - 'LANG': 'en_US.UTF-8', 12:23:50 INFO - 'LANGUAGE': 'en_US:en', 12:23:50 INFO - 'LOGNAME': 'cltbld', 12:23:50 INFO - 'MAIL': '/var/mail/cltbld', 12:23:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:23:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:50 INFO - 'MOZ_NO_REMOTE': '1', 12:23:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:50 INFO - 'NO_EM_RESTART': '1', 12:23:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:50 INFO - 'PWD': '/builds/slave/test', 12:23:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:23:50 INFO - 'SHELL': '/bin/bash', 12:23:50 INFO - 'SHLVL': '1', 12:23:50 INFO - 'TERM': 'linux', 12:23:50 INFO - 'TMOUT': '86400', 12:23:50 INFO - 'USER': 'cltbld', 12:23:50 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765', 12:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:50 INFO - '_': '/tools/buildbot/bin/python'} 12:23:50 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/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 12:23:50 INFO - mozversion INFO | application_buildid: 20151210113952 12:23:50 INFO - mozversion INFO | application_changeset: 11c67a7b46b5158bd48a7216ab45f124a71d4794 12:23:50 INFO - mozversion INFO | application_display_name: Nightly 12:23:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:23:50 INFO - mozversion INFO | application_name: Firefox 12:23:50 INFO - mozversion INFO | application_remotingname: firefox 12:23:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:23:50 INFO - mozversion INFO | application_vendor: Mozilla 12:23:50 INFO - mozversion INFO | application_version: 45.0a1 12:23:50 INFO - mozversion INFO | platform_buildid: 20151210113952 12:23:50 INFO - mozversion INFO | platform_changeset: 11c67a7b46b5158bd48a7216ab45f124a71d4794 12:23:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:23:50 INFO - mozversion INFO | platform_version: 45.0a1 12:23:50 INFO - 2015-12-10 12:23:50,782 DEBUG : using testdate: 1449779030 12:23:50 INFO - 2015-12-10 12:23:50,782 DEBUG : actual date: 1449779030 12:23:50 INFO - 2015-12-10 12:23:50,791 INFO : starting webserver on 'localhost:42018' 12:23:50 INFO - 2015-12-10 12:23:50,792 INFO : Starting test suite talos-linux64-ix-030 12:23:50 INFO - 2015-12-10 12:23:50,792 INFO : Starting test dromaeo_css 12:23:50 INFO - 2015-12-10 12:23:50,792 DEBUG : operating with platform_type : linux_ 12:23:50 INFO - 2015-12-10 12:23:50,793 INFO : Initialising browser for dromaeo_css test... 12:23:50 INFO - 2015-12-10 12:23:50,808 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5pz4n/profile http://localhost:42018/getInfo.html 12:23:55 INFO - 2015-12-10 12:23:55,597 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:23:55 INFO - 2015-12-10 12:23:55,597 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:23:55 INFO - 2015-12-10 12:23:55,597 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:23:55 INFO - 2015-12-10 12:23:55,597 DEBUG : BROWSER_OUTPUT: __metrics 12:23:55 INFO - 2015-12-10 12:23:55,678 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] 12:23:55 INFO - 2015-12-10 12:23:55,754 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] 12:23:56 INFO - 2015-12-10 12:23:56,629 INFO : Browser initialized. 12:23:56 INFO - 2015-12-10 12:23:56,629 INFO : Running cycle 1/1 for dromaeo_css test... 12:23:56 INFO - 2015-12-10 12:23:56,630 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5pz4n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:24:08 INFO - 2015-12-10 12:24:08,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 142598144 12:24:08 INFO - 2015-12-10 12:24:08,667 DEBUG : BROWSER_OUTPUT: 12:24:59 INFO - 2015-12-10 12:24:59,966 DEBUG : BROWSER_OUTPUT: 1449779099964 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] 12:27:11 INFO - 2015-12-10 12:27:11,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42018/tests/dromaeo/cssquery-ext.html) 12:27:12 INFO - 2015-12-10 12:27:12,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 244195328 12:27:12 INFO - 2015-12-10 12:27:12,934 DEBUG : BROWSER_OUTPUT: 12:30:15 INFO - 2015-12-10 12:30:15,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/dromaeo/cssquery-ext.html (next: http://localhost:42018/tests/dromaeo/cssquery-jquery.html) 12:30:16 INFO - 2015-12-10 12:30:16,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 222674944 12:30:16 INFO - 2015-12-10 12:30:16,042 DEBUG : BROWSER_OUTPUT: 12:33:18 INFO - 2015-12-10 12:33:18,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42018/tests/dromaeo/cssquery-mootools.html) 12:33:18 INFO - 2015-12-10 12:33:18,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 213372928 12:33:18 INFO - 2015-12-10 12:33:18,693 DEBUG : BROWSER_OUTPUT: 12:36:20 INFO - 2015-12-10 12:36:20,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42018/tests/dromaeo/cssquery-prototype.html) 12:36:21 INFO - 2015-12-10 12:36:21,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 201375744 12:36:21 INFO - 2015-12-10 12:36:21,177 DEBUG : BROWSER_OUTPUT: 12:39:23 INFO - 2015-12-10 12:39:23,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42018/tests/dromaeo/cssquery-yui.html) 12:39:24 INFO - 2015-12-10 12:39:24,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 203776000 12:39:24 INFO - 2015-12-10 12:39:24,538 DEBUG : BROWSER_OUTPUT: 12:42:26 INFO - 2015-12-10 12:42:26,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/dromaeo/cssquery-yui.html (next: http://localhost:42018/tests/dromaeo/cssquery-dojo.html) 12:42:27 INFO - 2015-12-10 12:42:27,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 249966592 12:42:27 INFO - 2015-12-10 12:42:27,159 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,159 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:42:27 INFO - 2015-12-10 12:42:27,159 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:42:27 INFO - 2015-12-10 12:42:27,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:42:27 INFO - 2015-12-10 12:42:27,160 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:42:27 INFO - 2015-12-10 12:42:27,160 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2614.320276728051;2657.2426858345375;2686.8253563518356;2694.5553983592704;2703.189043287013;4499.257622492293;4591.563801438862;4630.958034442248;4673.579377855992;4682.157211701892;4568.154891345095;4629.953700462995;4637.165310244155;4652.162610730067;4666.276727107295;4297.914041719164;4311.417958575584;4313.439252897135;4351.173277077361;4357.912841743163;4098.4876890388705;4326;4333.739975601458;4380.1458715550325;4399.912001759979;4159.750414975111;4225.3873188387815;4266.57334266574;4276.893077673052;4282.164977829309;4250.978745106286;4328.069465064995;4334.154839806239;4367.934480982788;4381.9561804381865;4117.649999750025;4296.5059018213;4301.78491075445;4302.870913872589;4362.389265502832;4480.775961201927;4480.798364073592;4523.208438523278;4615.169269531483;4643.512431194744;4954.43024052235;4971.254311853215;4984.750762461862;5014.974925125388;5022.949770502285;4750.2874568814605;5013.849584512434;5013.874653133665;5015.924761128586;5017.071841709296;4512.9774351128035;4564.360989461478;4605.608523275526;4620.768961551977;4628.490866004737;5071.8985620287385;5074.06129865976;5074.67014644047;5081.8475445736685;5125.564327032244;4740.976295118502;4881.414230292387;4882.829100981448;4884.609231261491;4929.556339929423;4859.465458799529;4917.557419832232;4949.851504454872;4983.6760610560195;4988.80044798204;4908.460069392364;4925.630577706686;4933.703977761345;4936.6297527685565;4985.4266759323145;4813.687110337817;4920.237363208708;4932.062908047459;4932.506749325111;4980.427250866124;4100.01599616096;4106.342985122366;4154.750714957052;4165.291900376943;4199.811008504625;3603.747737658391;3616.27674465108;3618.16782140104;3628.872989445357;3642.1076836175307;4089.9591004090175;4252.234597772369;4256.382824490432;4295.484541854935;4307.418498502725;4853.563179313879;4857.781399837016;4892.951070489321;4904.828331008469;4909.361782968192;4253.829846806155;4286.185624731291;4295.742255464682;4302.440682711227;4338.652907767434;4411.316245981878;4411.977940110279;4413.293872980308;4416.205083085076;4464.107178564235;4577.908441831145;4685.297205419214;4728.38530990969;4729.196036673842;4751.192297309466;4945.950540494549;4948.950510494849;4954.851354459372;4985.900281994267;4990.201567749288;4688.296755486705;4693.037927224979;4696.2955556666775;4707.199776038014;4739.7867095981455;4663.463701674215;4773.618110551078;4906.852794416173;4926.088673595396;4969.45336013031;4873.6832105913;4921.876953076058;4992.775325110451;4998.725070121178;5045.2432135180015;4801.135795556834;4816.759162041954;4822.662413631012;4828.493008234085;4868.196747536616;4648.628109751144;4778.904421911612;4808.08646357191;4819.445763737215;4866.197077482176;4624.421947256593;4688.038952014897;4701.882452938704;4783.210770223013;4822.517748225149;4867.415910090812;4870.439899411613;4876.585490233228;4878.292647566012;4879.268109783561;4755.857324280277;4767.6424268179335;4768.666193366431;4769.689970151929;4798.712077275374 12:42:27 INFO - 2015-12-10 12:42:27,164 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.4994663102325;577.321647064699;583.8948989181948;587.5886879184571;592.2182718811171;26900.19299421018;35791.82104089479;36789.81605091978;36836.63163368365;36996.26007479849;40374.39438408426;40956.79521602395;40958;40961.59038409615;41110.58889411105;6928;7049.259827718092;7984.041914970212;8131.268185863271;8144.51132932023;9985.500724963722;10186.949065254663;10199.337043092175;10200.387976721384;10209.438480883548;9942.353747006422;10035.749106272366;10053.09522143007;10058.798824023515;10059.949700251489;7270.78187654366;7448.031755871756;10039.648612298572;10145.797084058315;10366.688999330032;10022.54898529568;10167.23745719074;10169.745756356077;10172.186225101974;10185.28702990791;37204.25591488182;37662.81168594167;37699.623003769884;37735.24529509395;37756;2807.1578526441986;2814.183886672883;2899.4635992341487;2994.116735563014;3383.4924761285756;28025.57961630577;28054;28114.578281325797;28252.434951301064;28450.146495605164;3209.646938836726;3559.697425718817;3570.410882204433;3586.8923932282073;3692.5199724035974;207182;209124;209608;209609;209746.95126524422;53425.46574534283;54430;56811.71594142003;57210.42789572134;57225.14162287569;65410.345896541374;66739.32824702225;66977;67099.66450167718;67109.66445167742;13907.791383129059;13997.3701183447;14006.859931400759;14039.298035098203;14052.718945621235;9673.661421850202;9697.854532182022;9710.902890971141;9719.17387022111;9719.61121555144;19552.51118722015;19904.70142947857;19927.003649817452;19934.202631894852;19940.102695378744;7612.581308028111;7807.588712377488;7828.491148075357;7830.530168189927;7949.443538952218;834.7328854766416;902.4224496322358;915.54680433186;969.8593703912893;1003.4731765822855;26566.73433265681;26618.20145395641;26638;27020.459590808074;27186.592201117;1051.8106740786732;1076.8546246256813;1080.9405482698528;1098.906592939593;1102.6747109602686;14067.788983165261;14176.85592792643;14240;14345.211013394155;14415.639609009859;253145;257205;258001;259074;259502;46677.29984050242;47499.28751068737;47507.28739068917;47510.52489475061;47565.5243447568;1172.4899668644166;1174.8413964114907;1177.181858608259;1185.82805493203;1191.368574655434;21997.560048799256;25051.24846254615;26219.606705899045;29527;30285.697143028287;40476.59523404846;40899;40937.795311023256;40977.385339220535;41004.589954100076;197347;198563;198599;198935;285514;25559.361015974748;28685.713142868302;29244.853775730986;29334.853325733235;29638.851805740833;34163.316733665684;37639.24721505609;38157.80921095377;38163;38223.42664860085;31962.52056219205;31978;32124.678753213102;32875.835620821745;33235.667643324225;31770.6822931777;32504.187395315308;32564.83717581397;32900.59218082613;33330.666693333726;32338.676613233565;32492.83753581217;32500.512492312162;32660;32698.34603307873;28528.714712852605;29645.25886852846;34504.82747586246;35811;36186.276274473836;23631.291061268188;23856.284311470685;24007.159749409384;24161.15435959733;24231 12:42:27 INFO - 2015-12-10 12:42:27,164 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.096269590757;335.5151805640849;337.2428897125952;337.50386931211125;341.7402773891843;14700.191489468089;15098.396064157434;16427.917860410696;16431.753523697153;16605.66788664226;14136;14993.17537535435;15051.24743762813;15067.62330941727;15495.457658981937;3767.9058023549355;4843.443004054544;4969.180085285923;4971.304017437544;4971.45314015458;3881.7476864003893;5486.780528778864;5635.887282254353;5650.265465489501;5657.915131273014;5475.835724928239;5509.614326997112;5567.721613919308;5575.386707462176;5575.470330318613;3683.686886614641;3785.4889589905288;5390.487903649187;5534.4742249486235;5547.223388725582;4793.880152996168;4818.831340903052;4819.855404337875;4827.806887724522;4859.854204373874;19222.231110755554;19833.206671733256;20029.098690558814;20182.889941053236;20196.495087622927;1855.6010457751647;1868.4301288107122;1902.6860568006261;1926.6917293233016;1979.3270288101971;12642.810357844639;12745;12803.5518756844;13145;13167.078304518687;1704.1564425609279;1729.8962062276178;1746.3162086817977;1776.3427531813184;1782.3494424535081;51765.2235216472;51832.2225166619;51875;52776;53358.73320633411;9366.718998430058;9568.425894446356;9807.31348805591;9809.21526277896;9859.950700246452;12357.814632780515;12433.502659893504;12436.564720234748;12439.191452555555;12441.626751197478;6476.773312934025;6683.598984060972;6691.832704182434;6905.75829845963;7041.92958070423;6379.681015949277;6407.871842563216;6416.165898433267;6457.199160006741;6464.515161362822;4148;4188.267053265728;4207.389928460418;4208.9789551052045;4213.768242746678;1719.8796084274231;1743.921523531444;1747.6155245845894;1760.9647807043787;1792.507060558357;377.45269359428937;378.7329932397653;392.3800395375357;764.7208768799348;918.4535201555065;8470.280026197843;9857.901420985841;10593.523291451904;11024.062954648783;11088.168387370819;397.68582819572794;408.6118187721617;409.2245195354786;411.8208579268028;420.7181188603643;5535.723213839292;5675.035244008528;5694.345150307768;5733.312002559636;5769.711514424262;314448;435912;443750;485201;501376;70301;73179.90230146552;73761;74095.62952185313;74938.62530687312;1006.6577363696232;1021.0402221911379;1029.0789743179962;1033.4109557552274;1035.140833108518;14530.709385812435;14642.341094650554;14793.11241325524;14947.327370268582;15012.549623511311;33891.830540848125;33927.830360849024;34471.138221544665;35071.12322191965;35145.47281790724;42469;45468.772656136505;46182;46198.53801461942;47796.04407911892;8400.49597024156;8631.827363452821;8664.91335086641;8721.520316382659;9167.220786232978;10717.464126793786;10725.946370268099;10831.566737330733;10841.67474975752;15442.2278886053;12861.099723019299;13105.737885242432;13119.491258505012;13166.47334106625;13890.791638125234;13154.276514791778;13351.332433378486;13420.194788312732;13521.661958451117;13798.17210967305;13283;14277.500287490304;14406.135631862122;14794.852051479347;14811;9060.592273347847;9065.954670226607;9118.088191180828;9222.44665320083;9362.859557106785;10532.473376331305;13159.802602960772;13348.199108053548;13700.24648644334;13831.239281839595 12:42:27 INFO - 2015-12-10 12:42:27,165 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1416.4900635771128;1664.9084300363481;1692.3399874049114;1713.2632967823838;1729.3774241273143;5809.738561764725;6250.531210159239;6740.123783908091;6964.059851919989;7018.122734658168;6912.896306555405;6913.06673599064;6995.265497122792;7012.894806577905;7026.6486675666265;2063.618230627335;2107.0412962102205;2107.1887323380533;2107.241393098491;2108.5150415404464;2083.073032500538;2094.1309356616985;2103.442587714257;2104.7579528354204;2110;2074.2532688232222;2082.614716277486;2088.5181277002466;2103.621348157331;2103.852730308879;2004.2984955265686;2034.8575599708026;2036;2037.6128535578193;2038.9592208155827;1980.9405717828345;2002.559436923889;2013.2852837242715;2017.152795825742;2019.2629690163133;6972.302769723038;7069.681864316118;7070.681819318143;7078.823029424254;7082.822929426754;4073.714839961204;4116.464859568267;4117.8970525736795;4141.64795992341;4152.273352163359;2565.679290088739;2571.6528268683674;2586.508563372953;2643.444876575921;2679.0623281851194;789.4907784478979;805.2430715127762;818.6397984886631;834.8747687846811;860.0539406652632;9577;9588.472634005127;9593.376430532064;9604.135627793532;9631.614735410576;3844.615538446133;3857.864974725871;3895.4741109949796;3898.571157172709;3909.2963266612282;8228.753137405887;8247.298979586802;8261.958690206511;8265.214804593554;8293.33653307734;4247.214265360918;4250.086231460251;4255.723377980421;4272.764997925144;4277.721948073366;3227.596550431196;3308.5368048473233;3701.3522633539023;3872.0319920019997;3908.355121404993;3310.337932413527;3358.462645976632;3364.8149351785396;3391.9491207631904;3426.1605906553054;1106.4965440724452;1107.9944600277108;1111.2665640677114;1113.5100555755603;1121.8317252412203;886.5257087458308;982.8525721141885;1154.6132045764764;1170.78925793358;1179.0567545963195;6685.732570697215;6727.865442691119;6734.8989765153565;6757.695903684346;6762.289959554176;1024.08856118055;1030.4950574218578;1030.5723124903081;1046.56567524478;1077.8113830079706;4960.156773348539;5005.174146265826;5019.623528235397;5036.471170527115;5039.470855560114;8157.306628936607;8199.22107399796;8328;8469.40714150016;8530;8335.541545215072;8364.707235246737;8411.70559030431;8441;8446.239838414573;6301.810945671546;6382.776602818879;6443.613383197023;6528.771492997722;6560.967195163994;6268.153799237227;6300.306966233619;6300.338464461165;6330.778422755366;6353.047042943411;7355.1541572719825;7369.889451658122;7448.6275686214385;7497;7549.9245007549225;7447.813804654927;7585.393168546613;7608.733694320672;7637.198094200029;7706.653200605874;5036.521530454601;5152.124138896472;5738.741756620879;5807.361190268983;5811.82564523065;6650.235222949423;6786.423154031962;6812.420944219797;6817.693203805741;6823.658817059028;6065.787697430569;6344.936550634435;6378.712957916998;6459.903101453576;6471;6250.187475628321;6314.431701146918;6350.4919606432295;6359;6526.967365163144;6434.967825160844;6569.57297775643;6570.29172415166;6570.868582628225;6573.04690819838;5811.4188581143235;5814.127880817911;5819.243498345188;5819.476247137778;5822.359540450462;5822.796202132905;5920.615160014585;5928.466438020599;5937.762489500545;5941.1385349123275 12:42:27 INFO - 2015-12-10 12:42:27,166 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.2393705892621;304.604014780785;311.73191055692104;313.7662441481097;315.18210244415735;5157.5358217760395;5256.89486210276;5304.549113325367;5312.601554883389;5325.227841962923;5140.8971820563565;5221.791128354861;5224.033553792551;5228.581713462923;5300.655457395266;3875.767453952772;3961.762294262339;4076.4700588923547;4080.489938757655;4086.427900093982;3967;4053.493313335833;4053.574374690659;4064.4512990746316;4075.8777236682945;4014.899627509321;4019.216252830699;4030.556638769733;4040.636342729154;4041.0503531670033;3814.465974763549;3898.4152377143655;3950.762954222756;4019.216252830699;4040;3512.2448673535314;3518.2084031093054;3519.964800351989;3521.8767343142868;3522.2603253316834;5010.599152067863;5028.7737051832755;5032.698038117688;5034.974825125888;5037.974810125963;4611.262198048296;4613.446386433616;4620.514845941195;4621.1219868224925;4621.907561848744;5357.43746906577;5484.177373393983;5485.890282194374;5486.31421072366;5489.917651235235;3808.067023579241;3808.9809550952345;3809.142942837867;3811.866584669523;3817;5731.426857314277;5811.331696854873;5821.155932389822;5824.271966004292;5830.504407125357;3976.602339766;3976.781277029791;3977.204559088194;3979.4030895365927;3980.701447391399;3933.6066393360434;4023.91952160961;4033.334499807499;4033.9596604033586;4037.7173597848455;4623.260278355447;4625.907481850344;4627.444706635225;4632.3977882875015;4633.72197668141;5529.834104976857;5542.86142846424;5545.390007099216;5545.972270138624;5548.361938377138;1401.8037474753542;1425.287356321839;1425.9857401426061;1427.5217802036434;1428.171660436944;943.0899182289124;949.6154057606681;963.9132478077007;968.951552422376;972.0619602084023;4843.07981483517;4847.80608775645;4848.151573474628;4860.149473842063;4864.513548645107;5712.885742285131;5716.79991200306;5718.79984200551;5725.198472213893;5727.255456790591;4841.080194762983;4850.369451971221;4853.223484242575;4859.611231101503;4861.562459378602;2833.7874659400627;2884.4952133376573;3057.8165310081467;3078.7844850860674;3079.445699774017;5316.202569614588;5358.356997160287;5430.91853622196;5471.042567550663;5485.945140548623;5938.346781853993;5943.197668314722;5947.078202878474;5949.077892926603;5951.732172052268;5467.644603100785;5476.3702174250475;5476.616636835463;5477.397486276506;5480.369422677138;5614.382417934105;5761.366249712612;5767.826965191051;5771.942280577308;5784.971075144597;5677.091665333527;5679.119736440858;5680.488756011979;5682.715864206856;5682.801101961411;5466.726663666721;5475.698836564027;5475.945240547543;5480.424555421783;5483.479069488392;3945.191235796712;3980.980095099506;3980.980095099622;3983.083890705096;3986.4219688145636;5630.268065151504;5761.078227483583;5761.193432919478;5766.4233576642;5772.04761214395;5531.419200983839;5535.169724541351;5548.0845660465575;5549.44505549458;5549.556035517229;5528.391876893619;5539.9169012464035;5542.140968149944;5546.528545073714;5554.777808887599;5272;5374.355077390738;5408.432114627907;5417.5665946723375;5430.5384042356845;5594.664320140804;5598.916016259841;5600.85997850057;5602.047651899105;5602.551795856403;5196.662216955886;5268.078086334799;5301.496357845998;5459.535939445192;5459.672419654833 12:42:27 INFO - 2015-12-10 12:42:27,166 DEBUG : BROWSER_OUTPUT: |5;yui.html;673.6530686696351;688.0882830249917;736.5543845973186;753.6420200404812;813.6541969662895;11027.669169924906;11245;11263.831042534368;11276.943615281913;11278.661640150798;9745.853812192823;10869.83695244572;10964.0680542154;11246.268992515481;11402.600908968188;813.8087549425895;831.3764676492631;831.7629475599456;831.9376046796484;832.4422636833306;819.5328662662284;824.6618886256636;826.9710560130396;827.4538804389105;827.5448503323179;849.9192576705203;861.0915484164204;861.5046348349692;861.5735211070529;861.6725644255174;855.2132038524572;855.9400841941067;856.8928883889514;857.648364170687;857.7083791510854;631.9842003949892;632.2349956552576;633.0283015571076;633.1547384242042;633.5470138850698;10952.945235273852;11092.057175140122;11102.722431939186;11103.333799972028;11103.44482775858;9007.729768106967;9040.638374465014;9127.132922372364;9373.43759374433;9447.622095116187;8612.956935215283;8735.694250701195;8806.471611703255;9013.864792028126;9647.662331818423;3199.488081906907;3228.2413632796274;3242.675732426762;3245.140037889961;3324.7838890472044;35222;35676.28647427037;35774.28451430957;39501;40161.799191003855;8878.600462979182;9024.36829421934;9095.863562046574;9357.20463760588;9754.219662426989;15952.521424357055;16139.515814525583;16142.273597688132;16173.110478923772;16189;6120.816375508742;6121;6346.746130154835;6356.936430635635;6428.132202152743;3597.244578638515;3642.4718415830084;3653.1597732521136;3670;3673.779573225615;2704.8241864278757;2762.502749505068;2770.4459108178444;2770.7783377329765;2772.7088655691264;489.35649620748603;491.1944411165691;504.6114491841335;505.06058730760753;509.5083244668912;375.16900066353156;411.24331230535955;412.1016184717345;415.2442554550749;456.33375272103103;6664.200295964515;7067.187273463617;7101.502894797418;7118.644067796693;7161.427085833121;382.1783166192652;383.3827537664358;409.13876290408854;410.69198101423933;437.2042881954875;3494.3710132175943;3508.893898914423;3594.658507441789;3647.744657873923;3797.487339209227;44345;49745;49771.751141244065;49795.751021244665;49890.25164622533;43658.56341436609;43785;44027;44074.11851762947;44438;35892;38814;41355.37966930499;45867.31199032017;46400.53599463962;7401.703931842666;7748.496347737379;7777.183395743592;8047.436679432383;8134.349252059703;29760;29842.253943651584;29998.55002175013;31708.84145579257;33516;39537.209255815294;40076.799616001736;40118.799406002785;40141.59858401495;40155.799221003705;8510.721380771227;9510.286728495252;9618.711438656852;9832.55753491109;9868.950655246677;9896.851547226654;10186.898131018595;10188.235882309005;10269.640562580274;10546.20903432261;10222.335548189343;10222.488875556044;10285.125764309818;10403.347611855419;10429.374237545771;10224.539895704562;10228.232882533692;10241.334313269614;10244.897551024394;10258.794824103326;10285.9485702571;10310.845337320095;10319.226058045526;10323.32898361604;10358.171346292429;8857.114288571349;8879.334049946408;8942.46345219289;8977.551122443982;9045.185933266037;8579.2707619853;8931.151540603632;8976.506292153734;9003.189712925869;9023.909760902307 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: __startTimestamp1449780147156__endTimestamp 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:42:27 INFO - 2015-12-10 12:42:27,167 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:42:27 INFO - 2015-12-10 12:42:27,168 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,168 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4575.86 Median:4693.04 stddev:469.83 (10.0%) stddev-sans-first:445.36 12:42:27 INFO - 2015-12-10 12:42:27,169 DEBUG : BROWSER_OUTPUT: Values: 2614.3 2657.2 2686.8 2694.6 2703.2 4499.3 4591.6 4631.0 4673.6 4682.2 4568.2 4630.0 4637.2 4652.2 4666.3 4297.9 4311.4 4313.4 4351.2 4357.9 4098.5 4326.0 4333.7 4380.1 4399.9 4159.8 4225.4 4266.6 4276.9 4282.2 4251.0 4328.1 4334.2 4367.9 4382.0 4117.6 4296.5 4301.8 4302.9 4362.4 4480.8 4480.8 4523.2 4615.2 4643.5 4954.4 4971.3 4984.8 5015.0 5022.9 4750.3 5013.8 5013.9 5015.9 5017.1 4513.0 4564.4 4605.6 4620.8 4628.5 5071.9 5074.1 5074.7 5081.8 5125.6 4741.0 4881.4 4882.8 4884.6 4929.6 4859.5 4917.6 4949.9 4983.7 4988.8 4908.5 4925.6 4933.7 4936.6 4985.4 4813.7 4920.2 4932.1 4932.5 4980.4 4100.0 4106.3 4154.8 4165.3 4199.8 3603.7 3616.3 3618.2 3628.9 3642.1 4090.0 4252.2 4256.4 4295.5 4307.4 4853.6 4857.8 4893.0 4904.8 4909.4 4253.8 4286.2 4295.7 4302.4 4338.7 4411.3 4412.0 4413.3 4416.2 4464.1 4577.9 4685.3 4728.4 4729.2 4751.2 4946.0 4949.0 4954.9 4985.9 4990.2 4688.3 4693.0 4696.3 4707.2 4739.8 4663.5 4773.6 4906.9 4926.1 4969.5 4873.7 4921.9 4992.8 4998.7 5045.2 4801.1 4816.8 4822.7 4828.5 4868.2 4648.6 4778.9 4808.1 4819.4 4866.2 4624.4 4688.0 4701.9 4783.2 4822.5 4867.4 4870.4 4876.6 4878.3 4879.3 4755.9 4767.6 4768.7 4769.7 4798.7 12:42:27 INFO - 2015-12-10 12:42:27,169 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,169 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39745.99 Median:31970.26 stddev:59642.47 (186.6%) stddev-sans-first:59737.22 12:42:27 INFO - 2015-12-10 12:42:27,169 DEBUG : BROWSER_OUTPUT: Values: 563.5 577.3 583.9 587.6 592.2 26900.2 35791.8 36789.8 36836.6 36996.3 40374.4 40956.8 40958.0 40961.6 41110.6 6928.0 7049.3 7984.0 8131.3 8144.5 9985.5 10186.9 10199.3 10200.4 10209.4 9942.4 10035.7 10053.1 10058.8 10059.9 7270.8 7448.0 10039.6 10145.8 10366.7 10022.5 10167.2 10169.7 10172.2 10185.3 37204.3 37662.8 37699.6 37735.2 37756.0 2807.2 2814.2 2899.5 2994.1 3383.5 28025.6 28054.0 28114.6 28252.4 28450.1 3209.6 3559.7 3570.4 3586.9 3692.5 207182.0 209124.0 209608.0 209609.0 209747.0 53425.5 54430.0 56811.7 57210.4 57225.1 65410.3 66739.3 66977.0 67099.7 67109.7 13907.8 13997.4 14006.9 14039.3 14052.7 9673.7 9697.9 9710.9 9719.2 9719.6 19552.5 19904.7 19927.0 19934.2 19940.1 7612.6 7807.6 7828.5 7830.5 7949.4 834.7 902.4 915.5 969.9 1003.5 26566.7 26618.2 26638.0 27020.5 27186.6 1051.8 1076.9 1080.9 1098.9 1102.7 14067.8 14176.9 14240.0 14345.2 14415.6 253145.0 257205.0 258001.0 259074.0 259502.0 46677.3 47499.3 47507.3 47510.5 47565.5 1172.5 1174.8 1177.2 1185.8 1191.4 21997.6 25051.2 26219.6 29527.0 30285.7 40476.6 40899.0 40937.8 40977.4 41004.6 197347.0 198563.0 198599.0 198935.0 285514.0 25559.4 28685.7 29244.9 29334.9 29638.9 34163.3 37639.2 38157.8 38163.0 38223.4 31962.5 31978.0 32124.7 32875.8 33235.7 31770.7 32504.2 32564.8 32900.6 33330.7 32338.7 32492.8 32500.5 32660.0 32698.3 28528.7 29645.3 34504.8 35811.0 36186.3 23631.3 23856.3 24007.2 24161.2 24231.0 12:42:27 INFO - 2015-12-10 12:42:27,169 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,170 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24776.58 Median:2072.68 stddev:72219.52 (3484.4%) stddev-sans-first:72398.79 12:42:27 INFO - 2015-12-10 12:42:27,170 DEBUG : BROWSER_OUTPUT: Values: 334.1 335.5 337.2 337.5 341.7 14700.2 15098.4 16427.9 16431.8 16605.7 14136.0 14993.2 15051.2 15067.6 15495.5 3767.9 4843.4 4969.2 4971.3 4971.5 3881.7 5486.8 5635.9 5650.3 5657.9 5475.8 5509.6 5567.7 5575.4 5575.5 3683.7 3785.5 5390.5 5534.5 5547.2 4793.9 4818.8 4819.9 4827.8 4859.9 19222.2 19833.2 20029.1 20182.9 20196.5 1855.6 1868.4 1902.7 1926.7 1979.3 12642.8 12745.0 12803.6 13145.0 13167.1 1704.2 1729.9 1746.3 1776.3 1782.3 51765.2 51832.2 51875.0 52776.0 53358.7 9366.7 9568.4 9807.3 9809.2 9860.0 12357.8 12433.5 12436.6 12439.2 12441.6 6476.8 6683.6 6691.8 6905.8 7041.9 6379.7 6407.9 6416.2 6457.2 6464.5 4148.0 4188.3 4207.4 4209.0 4213.8 1719.9 1743.9 1747.6 1761.0 1792.5 377.5 378.7 392.4 764.7 918.5 8470.3 9857.9 10593.5 11024.1 11088.2 397.7 408.6 409.2 411.8 420.7 5535.7 5675.0 5694.3 5733.3 5769.7 314448.0 435912.0 443750.0 485201.0 501376.0 70301.0 73179.9 73761.0 74095.6 74938.6 1006.7 1021.0 1029.1 1033.4 1035.1 14530.7 14642.3 14793.1 14947.3 15012.5 33891.8 33927.8 34471.1 35071.1 35145.5 42469.0 45468.8 46182.0 46198.5 47796.0 8400.5 8631.8 8664.9 8721.5 9167.2 10717.5 10725.9 10831.6 10841.7 15442.2 12861.1 13105.7 13119.5 13166.5 13890.8 13154.3 13351.3 13420.2 13521.7 13798.2 13283.0 14277.5 14406.1 14794.9 14811.0 9060.6 9066.0 9118.1 9222.4 9362.9 10532.5 13159.8 13348.2 13700.2 13831.2 12:42:27 INFO - 2015-12-10 12:42:27,170 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,170 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4884.64 Median:5924.54 stddev:2514.91 (42.4%) stddev-sans-first:2508.45 12:42:27 INFO - 2015-12-10 12:42:27,171 DEBUG : BROWSER_OUTPUT: Values: 1416.5 1664.9 1692.3 1713.3 1729.4 5809.7 6250.5 6740.1 6964.1 7018.1 6912.9 6913.1 6995.3 7012.9 7026.6 2063.6 2107.0 2107.2 2107.2 2108.5 2083.1 2094.1 2103.4 2104.8 2110.0 2074.3 2082.6 2088.5 2103.6 2103.9 2004.3 2034.9 2036.0 2037.6 2039.0 1980.9 2002.6 2013.3 2017.2 2019.3 6972.3 7069.7 7070.7 7078.8 7082.8 4073.7 4116.5 4117.9 4141.6 4152.3 2565.7 2571.7 2586.5 2643.4 2679.1 789.5 805.2 818.6 834.9 860.1 9577.0 9588.5 9593.4 9604.1 9631.6 3844.6 3857.9 3895.5 3898.6 3909.3 8228.8 8247.3 8262.0 8265.2 8293.3 4247.2 4250.1 4255.7 4272.8 4277.7 3227.6 3308.5 3701.4 3872.0 3908.4 3310.3 3358.5 3364.8 3391.9 3426.2 1106.5 1108.0 1111.3 1113.5 1121.8 886.5 982.9 1154.6 1170.8 1179.1 6685.7 6727.9 6734.9 6757.7 6762.3 1024.1 1030.5 1030.6 1046.6 1077.8 4960.2 5005.2 5019.6 5036.5 5039.5 8157.3 8199.2 8328.0 8469.4 8530.0 8335.5 8364.7 8411.7 8441.0 8446.2 6301.8 6382.8 6443.6 6528.8 6561.0 6268.2 6300.3 6300.3 6330.8 6353.0 7355.2 7369.9 7448.6 7497.0 7549.9 7447.8 7585.4 7608.7 7637.2 7706.7 5036.5 5152.1 5738.7 5807.4 5811.8 6650.2 6786.4 6812.4 6817.7 6823.7 6065.8 6344.9 6378.7 6459.9 6471.0 6250.2 6314.4 6350.5 6359.0 6527.0 6435.0 6569.6 6570.3 6570.9 6573.0 5811.4 5814.1 5819.2 5819.5 5822.4 5822.8 5920.6 5928.5 5937.8 5941.1 12:42:27 INFO - 2015-12-10 12:42:27,171 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,172 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4580.02 Median:5242.74 stddev:1356.97 (25.9%) stddev-sans-first:1322.22 12:42:27 INFO - 2015-12-10 12:42:27,172 DEBUG : BROWSER_OUTPUT: Values: 301.2 304.6 311.7 313.8 315.2 5157.5 5256.9 5304.5 5312.6 5325.2 5140.9 5221.8 5224.0 5228.6 5300.7 3875.8 3961.8 4076.5 4080.5 4086.4 3967.0 4053.5 4053.6 4064.5 4075.9 4014.9 4019.2 4030.6 4040.6 4041.1 3814.5 3898.4 3950.8 4019.2 4040.0 3512.2 3518.2 3520.0 3521.9 3522.3 5010.6 5028.8 5032.7 5035.0 5038.0 4611.3 4613.4 4620.5 4621.1 4621.9 5357.4 5484.2 5485.9 5486.3 5489.9 3808.1 3809.0 3809.1 3811.9 3817.0 5731.4 5811.3 5821.2 5824.3 5830.5 3976.6 3976.8 3977.2 3979.4 3980.7 3933.6 4023.9 4033.3 4034.0 4037.7 4623.3 4625.9 4627.4 4632.4 4633.7 5529.8 5542.9 5545.4 5546.0 5548.4 1401.8 1425.3 1426.0 1427.5 1428.2 943.1 949.6 963.9 969.0 972.1 4843.1 4847.8 4848.2 4860.1 4864.5 5712.9 5716.8 5718.8 5725.2 5727.3 4841.1 4850.4 4853.2 4859.6 4861.6 2833.8 2884.5 3057.8 3078.8 3079.4 5316.2 5358.4 5430.9 5471.0 5485.9 5938.3 5943.2 5947.1 5949.1 5951.7 5467.6 5476.4 5476.6 5477.4 5480.4 5614.4 5761.4 5767.8 5771.9 5785.0 5677.1 5679.1 5680.5 5682.7 5682.8 5466.7 5475.7 5475.9 5480.4 5483.5 3945.2 3981.0 3981.0 3983.1 3986.4 5630.3 5761.1 5761.2 5766.4 5772.0 5531.4 5535.2 5548.1 5549.4 5549.6 5528.4 5539.9 5542.1 5546.5 5554.8 5272.0 5374.4 5408.4 5417.6 5430.5 5594.7 5598.9 5600.9 5602.0 5602.6 5196.7 5268.1 5301.5 5459.5 5459.7 12:42:27 INFO - 2015-12-10 12:42:27,172 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,172 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11891.19 Median:22447.17 stddev:13656.33 (60.8%) stddev-sans-first:13668.65 12:42:27 INFO - 2015-12-10 12:42:27,172 DEBUG : BROWSER_OUTPUT: Values: 673.7 688.1 736.6 753.6 813.7 11027.7 11245.0 11263.8 11276.9 11278.7 9745.9 10869.8 10964.1 11246.3 11402.6 813.8 831.4 831.8 831.9 832.4 819.5 824.7 827.0 827.5 827.5 849.9 861.1 861.5 861.6 861.7 855.2 855.9 856.9 857.6 857.7 632.0 632.2 633.0 633.2 633.5 10952.9 11092.1 11102.7 11103.3 11103.4 9007.7 9040.6 9127.1 9373.4 9447.6 8613.0 8735.7 8806.5 9013.9 9647.7 3199.5 3228.2 3242.7 3245.1 3324.8 35222.0 35676.3 35774.3 39501.0 40161.8 8878.6 9024.4 9095.9 9357.2 9754.2 15952.5 16139.5 16142.3 16173.1 16189.0 6120.8 6121.0 6346.7 6356.9 6428.1 3597.2 3642.5 3653.2 3670.0 3673.8 2704.8 2762.5 2770.4 2770.8 2772.7 489.4 491.2 504.6 505.1 509.5 375.2 411.2 412.1 415.2 456.3 6664.2 7067.2 7101.5 7118.6 7161.4 382.2 383.4 409.1 410.7 437.2 3494.4 3508.9 3594.7 3647.7 3797.5 44345.0 49745.0 49771.8 49795.8 49890.3 43658.6 43785.0 44027.0 44074.1 44438.0 35892.0 38814.0 41355.4 45867.3 46400.5 7401.7 7748.5 7777.2 8047.4 8134.3 29760.0 29842.3 29998.6 31708.8 33516.0 39537.2 40076.8 40118.8 40141.6 40155.8 8510.7 9510.3 9618.7 9832.6 9869.0 9896.9 10186.9 10188.2 10269.6 10546.2 10222.3 10222.5 10285.1 10403.3 10429.4 10224.5 10228.2 10241.3 10244.9 10258.8 10285.9 10310.8 10319.2 10323.3 10358.2 8857.1 8879.3 8942.5 8977.6 9045.2 8579.3 8931.2 8976.5 9003.2 9023.9 12:42:27 INFO - 2015-12-10 12:42:27,172 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:42:27 INFO - 2015-12-10 12:42:27,172 DEBUG : BROWSER_OUTPUT: 12:42:27 INFO - 2015-12-10 12:42:27,867 INFO : Browser exited with error code: 0 12:42:27 INFO - 2015-12-10 12:42:27,888 INFO : Completed test dromaeo_css (00:18:37) 12:42:27 INFO - 2015-12-10 12:42:27,888 INFO : Starting test kraken 12:42:27 INFO - 2015-12-10 12:42:27,888 DEBUG : operating with platform_type : linux_ 12:42:27 INFO - 2015-12-10 12:42:27,889 INFO : Initialising browser for kraken test... 12:42:27 INFO - 2015-12-10 12:42:27,895 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2gBWH3/profile http://localhost:42018/getInfo.html 12:42:32 INFO - 2015-12-10 12:42:32,417 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:42:32 INFO - 2015-12-10 12:42:32,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:42:32 INFO - 2015-12-10 12:42:32,418 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:42:32 INFO - 2015-12-10 12:42:32,418 DEBUG : BROWSER_OUTPUT: __metrics 12:42:32 INFO - 2015-12-10 12:42:32,559 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] 12:42:32 INFO - 2015-12-10 12:42:32,620 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] 12:42:32 ERROR - 2015-12-10 12:42:32,635 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 12:42:33 INFO - 2015-12-10 12:42:33,465 INFO : Browser initialized. 12:42:33 INFO - 2015-12-10 12:42:33,465 INFO : Running cycle 1/1 for kraken test... 12:42:33 INFO - 2015-12-10 12:42:33,465 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2gBWH3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:42:45 INFO - 2015-12-10 12:42:45,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 141705216 12:42:45 INFO - 2015-12-10 12:42:45,429 DEBUG : BROWSER_OUTPUT: 12:42:48 INFO - 2015-12-10 12:42:48,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42018/tests/kraken/driver.html?testName=audio-beat-detection) 12:42:48 INFO - 2015-12-10 12:42:48,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 179810304 12:42:48 INFO - 2015-12-10 12:42:48,595 DEBUG : BROWSER_OUTPUT: 12:42:51 INFO - 2015-12-10 12:42:51,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42018/tests/kraken/driver.html?testName=audio-dft) 12:42:51 INFO - 2015-12-10 12:42:51,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 166977536 12:42:51 INFO - 2015-12-10 12:42:51,878 DEBUG : BROWSER_OUTPUT: 12:42:54 INFO - 2015-12-10 12:42:54,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42018/tests/kraken/driver.html?testName=audio-fft) 12:42:55 INFO - 2015-12-10 12:42:55,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 154075136 12:42:55 INFO - 2015-12-10 12:42:55,487 DEBUG : BROWSER_OUTPUT: 12:42:57 INFO - 2015-12-10 12:42:57,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42018/tests/kraken/driver.html?testName=audio-oscillator) 12:42:58 INFO - 2015-12-10 12:42:58,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 156459008 12:42:58 INFO - 2015-12-10 12:42:58,106 DEBUG : BROWSER_OUTPUT: 12:43:00 INFO - 2015-12-10 12:43:00,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:43:00 INFO - 2015-12-10 12:43:00,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 158334976 12:43:00 INFO - 2015-12-10 12:43:00,929 DEBUG : BROWSER_OUTPUT: 12:43:03 INFO - 2015-12-10 12:43:03,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42018/tests/kraken/driver.html?testName=imaging-darkroom) 12:43:04 INFO - 2015-12-10 12:43:04,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 158326784 12:43:04 INFO - 2015-12-10 12:43:04,509 DEBUG : BROWSER_OUTPUT: 12:43:07 INFO - 2015-12-10 12:43:07,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42018/tests/kraken/driver.html?testName=imaging-desaturate) 12:43:08 INFO - 2015-12-10 12:43:08,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 158568448 12:43:08 INFO - 2015-12-10 12:43:08,475 DEBUG : BROWSER_OUTPUT: 12:43:11 INFO - 2015-12-10 12:43:11,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42018/tests/kraken/driver.html?testName=json-parse-financial) 12:43:11 INFO - 2015-12-10 12:43:11,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 159727616 12:43:11 INFO - 2015-12-10 12:43:11,875 DEBUG : BROWSER_OUTPUT: 12:43:13 INFO - 2015-12-10 12:43:13,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:43:14 INFO - 2015-12-10 12:43:14,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 170348544 12:43:14 INFO - 2015-12-10 12:43:14,190 DEBUG : BROWSER_OUTPUT: 12:43:16 INFO - 2015-12-10 12:43:16,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:43:16 INFO - 2015-12-10 12:43:16,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 170090496 12:43:16 INFO - 2015-12-10 12:43:16,657 DEBUG : BROWSER_OUTPUT: 12:43:18 INFO - 2015-12-10 12:43:18,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:43:19 INFO - 2015-12-10 12:43:19,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 179961856 12:43:19 INFO - 2015-12-10 12:43:19,390 DEBUG : BROWSER_OUTPUT: 12:43:21 INFO - 2015-12-10 12:43:21,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:43:22 INFO - 2015-12-10 12:43:22,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 187617280 12:43:22 INFO - 2015-12-10 12:43:22,475 DEBUG : BROWSER_OUTPUT: 12:43:25 INFO - 2015-12-10 12:43:25,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:43:25 INFO - 2015-12-10 12:43:25,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 184373248 12:43:25 INFO - 2015-12-10 12:43:25,635 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42018/tests/kraken/driver.html?testName=ai-astar) 12:43:27 INFO - 2015-12-10 12:43:27,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 244117504 12:43:27 INFO - 2015-12-10 12:43:27,619 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,622 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:43:27 INFO - 2015-12-10 12:43:27,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:43:27 INFO - 2015-12-10 12:43:27,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:43:27 INFO - 2015-12-10 12:43:27,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:43:27 INFO - 2015-12-10 12:43:27,623 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;107;110;112;111;101;113;111;118 12:43:27 INFO - 2015-12-10 12:43:27,623 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;136;152;166;130;154;149;130;168;136 12:43:27 INFO - 2015-12-10 12:43:27,624 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;163;161;164;162;163;162;162;159 12:43:27 INFO - 2015-12-10 12:43:27,624 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;84;94;72;78;75;115;95;72 12:43:27 INFO - 2015-12-10 12:43:27,624 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;140;95;95;94;136;95;95;126 12:43:27 INFO - 2015-12-10 12:43:27,624 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;111;110;111;110;110;110 12:43:27 INFO - 2015-12-10 12:43:27,624 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;147;146;147;146;147;145 12:43:27 INFO - 2015-12-10 12:43:27,625 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 12:43:27 INFO - 2015-12-10 12:43:27,625 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;71;70;71;71;71;71;71;68 12:43:27 INFO - 2015-12-10 12:43:27,625 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;68;68;69;68 12:43:27 INFO - 2015-12-10 12:43:27,625 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;85;84;84;85;84;83;85;85 12:43:27 INFO - 2015-12-10 12:43:27,625 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;126;117;118;120;126;125;123;121;121 12:43:27 INFO - 2015-12-10 12:43:27,625 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;155;144;146;145;134;148;146;136;133 12:43:27 INFO - 2015-12-10 12:43:27,625 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;67;68;69;67;68;68;68 12:43:27 INFO - 2015-12-10 12:43:27,626 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:43:27 INFO - 2015-12-10 12:43:27,626 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:43:27 INFO - 2015-12-10 12:43:27,626 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 12:43:27 INFO - 2015-12-10 12:43:27,626 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:43:27 INFO - 2015-12-10 12:43:27,626 DEBUG : BROWSER_OUTPUT: __startTimestamp1449780207621__endTimestamp 12:43:27 INFO - 2015-12-10 12:43:27,626 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,630 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:43:27 INFO - 2015-12-10 12:43:27,630 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:43:27 INFO - 2015-12-10 12:43:27,630 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,630 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:4.38 (3.9%) stddev-sans-first:4.61 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 107.0 110.0 112.0 111.0 101.0 113.0 111.0 118.0 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.70 Median:153.00 stddev:14.05 (9.2%) stddev-sans-first:14.58 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: Values: 156.0 136.0 152.0 166.0 130.0 154.0 149.0 130.0 168.0 136.0 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 163.0 161.0 164.0 162.0 163.0 162.0 162.0 159.0 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.80 Median:76.50 stddev:14.47 (18.9%) stddev-sans-first:14.71 12:43:27 INFO - 2015-12-10 12:43:27,631 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 84.0 94.0 72.0 78.0 75.0 115.0 95.0 72.0 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:19.28 (20.3%) stddev-sans-first:19.92 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 140.0 95.0 95.0 94.0 136.0 95.0 95.0 126.0 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 111.0 110.0 111.0 110.0 110.0 110.0 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 145.0 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,632 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.50 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 70.0 71.0 71.0 71.0 71.0 71.0 68.0 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:0.79 (0.9%) stddev-sans-first:0.83 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 85.0 84.0 84.0 85.0 84.0 83.0 85.0 85.0 12:43:27 INFO - 2015-12-10 12:43:27,633 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,634 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.00 stddev:3.27 (2.7%) stddev-sans-first:3.33 12:43:27 INFO - 2015-12-10 12:43:27,634 DEBUG : BROWSER_OUTPUT: Values: 119.0 126.0 117.0 118.0 120.0 126.0 125.0 123.0 121.0 121.0 12:43:27 INFO - 2015-12-10 12:43:27,634 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,634 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:145.50 stddev:7.20 (4.9%) stddev-sans-first:7.26 12:43:27 INFO - 2015-12-10 12:43:27,634 DEBUG : BROWSER_OUTPUT: Values: 136.0 155.0 144.0 146.0 145.0 134.0 148.0 146.0 136.0 133.0 12:43:27 INFO - 2015-12-10 12:43:27,634 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2015-12-10 12:43:27,635 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.71 12:43:27 INFO - 2015-12-10 12:43:27,635 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 67.0 68.0 69.0 67.0 68.0 68.0 68.0 12:43:27 INFO - 2015-12-10 12:43:27,635 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:43:27 INFO - 2015-12-10 12:43:27,635 DEBUG : BROWSER_OUTPUT: 12:43:28 INFO - 2015-12-10 12:43:28,595 INFO : Browser exited with error code: 0 12:43:28 INFO - 2015-12-10 12:43:28,651 INFO : Completed test kraken (00:01:00) 12:43:28 INFO - 2015-12-10 12:43:28,651 INFO : Starting test v8_7 12:43:28 INFO - 2015-12-10 12:43:28,651 DEBUG : operating with platform_type : linux_ 12:43:28 INFO - 2015-12-10 12:43:28,651 INFO : Initialising browser for v8_7 test... 12:43:28 INFO - 2015-12-10 12:43:28,657 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMc99SP/profile http://localhost:42018/getInfo.html 12:43:33 INFO - 2015-12-10 12:43:33,250 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:43:33 INFO - 2015-12-10 12:43:33,251 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:43:33 INFO - 2015-12-10 12:43:33,251 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:43:33 INFO - 2015-12-10 12:43:33,251 DEBUG : BROWSER_OUTPUT: __metrics 12:43:33 INFO - 2015-12-10 12:43:33,368 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] 12:43:33 INFO - 2015-12-10 12:43:33,449 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] 12:43:33 INFO - 2015-12-10 12:43:33,772 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:43:34 INFO - 2015-12-10 12:43:34,478 INFO : Browser initialized. 12:43:34 INFO - 2015-12-10 12:43:34,479 INFO : Running cycle 1/1 for v8_7 test... 12:43:34 INFO - 2015-12-10 12:43:34,479 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMc99SP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:43:46 INFO - 2015-12-10 12:43:46,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 139747328 12:43:46 INFO - 2015-12-10 12:43:46,535 DEBUG : BROWSER_OUTPUT: 12:44:07 INFO - 2015-12-10 12:44:07,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42018/tests/v8_7/run.html (next: http://localhost:42018/tests/v8_7/run.html) 12:44:08 INFO - 2015-12-10 12:44:08,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 441184256 12:44:08 INFO - 2015-12-10 12:44:08,161 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,161 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:44:08 INFO - 2015-12-10 12:44:08,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:44:08 INFO - 2015-12-10 12:44:08,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:44:08 INFO - 2015-12-10 12:44:08,162 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:44:08 INFO - 2015-12-10 12:44:08,162 DEBUG : BROWSER_OUTPUT: |0;Richards;167.5603217158177 12:44:08 INFO - 2015-12-10 12:44:08,162 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.6665428889714 12:44:08 INFO - 2015-12-10 12:44:08,162 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 12:44:08 INFO - 2015-12-10 12:44:08,162 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 12:44:08 INFO - 2015-12-10 12:44:08,162 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2012.0724346076458 12:44:08 INFO - 2015-12-10 12:44:08,162 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 12:44:08 INFO - 2015-12-10 12:44:08,163 DEBUG : BROWSER_OUTPUT: |6;Boyer;11858.823529411764 12:44:08 INFO - 2015-12-10 12:44:08,163 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 12:44:08 INFO - 2015-12-10 12:44:08,163 DEBUG : BROWSER_OUTPUT: |8;Splay;624.2197253433209 12:44:08 INFO - 2015-12-10 12:44:08,163 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 12:44:08 INFO - 2015-12-10 12:44:08,163 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:44:08 INFO - 2015-12-10 12:44:08,163 DEBUG : BROWSER_OUTPUT: __startTimestamp1449780248154__endTimestamp 12:44:08 INFO - 2015-12-10 12:44:08,163 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,164 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:44:08 INFO - 2015-12-10 12:44:08,164 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:44:08 INFO - 2015-12-10 12:44:08,164 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,164 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.56 Median:167.56 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,164 DEBUG : BROWSER_OUTPUT: Values: 167.6 12:44:08 INFO - 2015-12-10 12:44:08,164 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,164 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.67 Median:185.67 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: Values: 185.7 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: Values: 281.0 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: Values: 5122.4 12:44:08 INFO - 2015-12-10 12:44:08,165 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2012.07 Median:2012.07 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: Values: 2012.1 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: Values: 791.1 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11858.82 Median:11858.82 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,166 DEBUG : BROWSER_OUTPUT: Values: 11858.8 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: Values: 27216.2 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:624.22 Median:624.22 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: Values: 624.2 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: Values: 4826.9 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:44:08 INFO - 2015-12-10 12:44:08,167 DEBUG : BROWSER_OUTPUT: 12:44:09 INFO - 2015-12-10 12:44:09,067 INFO : Browser exited with error code: 0 12:44:09 INFO - 2015-12-10 12:44:09,082 INFO : Completed test v8_7 (00:00:40) 12:44:09 INFO - 2015-12-10 12:44:09,219 INFO : Completed test suite (00:20:18) 12:44:09 INFO - 2015-12-10 12:44:09,220 DEBUG : Working with test: dromaeo_css 12:44:09 INFO - 2015-12-10 12:44:09,220 DEBUG : Generating results file: dromaeo_css 12:44:09 INFO - 2015-12-10 12:44:09,221 DEBUG : Working with test: kraken 12:44:09 INFO - 2015-12-10 12:44:09,221 DEBUG : Generating results file: kraken 12:44:09 INFO - 2015-12-10 12:44:09,221 INFO : javascript benchmark 12:44:09 INFO - 2015-12-10 12:44:09,221 DEBUG : Working with test: v8_7 12:44:09 INFO - 2015-12-10 12:44:09,221 DEBUG : Generating results file: v8_7 12:44:09 INFO - 2015-12-10 12:44:09,222 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:44:09 INFO - 2015-12-10 12:44:09,277 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:44:09 INFO - 2015-12-10 12:44:09,277 DEBUG : process_Request line: dromaeo_css 6198.53 graph.html#tests=[[72,132,35]] 12:44:09 INFO - 2015-12-10 12:44:09,277 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:44:09 INFO - 2015-12-10 12:44:09,305 DEBUG : process_Request line: kraken 1515.70 graph.html#tests=[[232,132,35]] 12:44:09 INFO - 2015-12-10 12:44:09,305 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:44:09 INFO - 2015-12-10 12:44:09,334 DEBUG : process_Request line: v8_7 19739.70 graph.html#tests=[[230,132,35]] 12:44:09 INFO - 2015-12-10 12:44:09,335 INFO : javascript benchmark 12:44:09 INFO - 2015-12-10 12:44:09,339 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.320276728051, 2657.2426858345375, 2686.8253563518356, 2694.5553983592704, 2703.189043287013, 4499.257622492293, 4591.563801438862, 4630.958034442248, 4673.579377855992, 4682.157211701892, 4568.154891345095, 4629.953700462995, 4637.165310244155, 4652.162610730067, 4666.276727107295, 4297.914041719164, 4311.417958575584, 4313.439252897135, 4351.173277077361, 4357.912841743163, 4098.4876890388705, 4326.0, 4333.739975601458, 4380.1458715550325, 4399.912001759979, 4159.750414975111, 4225.3873188387815, 4266.57334266574, 4276.893077673052, 4282.164977829309, 4250.978745106286, 4328.069465064995, 4334.154839806239, 4367.934480982788, 4381.9561804381865, 4117.649999750025, 4296.5059018213, 4301.78491075445, 4302.870913872589, 4362.389265502832, 4480.775961201927, 4480.798364073592, 4523.208438523278, 4615.169269531483, 4643.512431194744, 4954.43024052235, 4971.254311853215, 4984.750762461862, 5014.974925125388, 5022.949770502285, 4750.2874568814605, 5013.849584512434, 5013.874653133665, 5015.924761128586, 5017.071841709296, 4512.9774351128035, 4564.360989461478, 4605.608523275526, 4620.768961551977, 4628.490866004737, 5071.8985620287385, 5074.06129865976, 5074.67014644047, 5081.8475445736685, 5125.564327032244, 4740.976295118502, 4881.414230292387, 4882.829100981448, 4884.609231261491, 4929.556339929423, 4859.465458799529, 4917.557419832232, 4949.851504454872, 4983.6760610560195, 4988.80044798204, 4908.460069392364, 4925.630577706686, 4933.703977761345, 4936.6297527685565, 4985.4266759323145, 4813.687110337817, 4920.237363208708, 4932.062908047459, 4932.506749325111, 4980.427250866124, 4100.01599616096, 4106.342985122366, 4154.750714957052, 4165.291900376943, 4199.811008504625, 3603.747737658391, 3616.27674465108, 3618.16782140104, 3628.872989445357, 3642.1076836175307, 4089.9591004090175, 4252.234597772369, 4256.382824490432, 4295.484541854935, 4307.418498502725, 4853.563179313879, 4857.781399837016, 4892.951070489321, 4904.828331008469, 4909.361782968192, 4253.829846806155, 4286.185624731291, 4295.742255464682, 4302.440682711227, 4338.652907767434, 4411.316245981878, 4411.977940110279, 4413.293872980308, 4416.205083085076, 4464.107178564235, 4577.908441831145, 4685.297205419214, 4728.38530990969, 4729.196036673842, 4751.192297309466, 4945.950540494549, 4948.950510494849, 4954.851354459372, 4985.900281994267, 4990.201567749288, 4688.296755486705, 4693.037927224979, 4696.2955556666775, 4707.199776038014, 4739.7867095981455, 4663.463701674215, 4773.618110551078, 4906.852794416173, 4926.088673595396, 4969.45336013031, 4873.6832105913, 4921.876953076058, 4992.775325110451, 4998.725070121178, 5045.2432135180015, 4801.135795556834, 4816.759162041954, 4822.662413631012, 4828.493008234085, 4868.196747536616, 4648.628109751144, 4778.904421911612, 4808.08646357191, 4819.445763737215, 4866.197077482176, 4624.421947256593, 4688.038952014897, 4701.882452938704, 4783.210770223013, 4822.517748225149, 4867.415910090812, 4870.439899411613, 4876.585490233228, 4878.292647566012, 4879.268109783561, 4755.857324280277, 4767.6424268179335, 4768.666193366431, 4769.689970151929, 4798.712077275374], "unit": "ms", "name": "dojo.html", "value": 4547.081556898652}, {"lowerIsBetter": false, "replicates": [563.4994663102325, 577.321647064699, 583.8948989181948, 587.5886879184571, 592.2182718811171, 26900.19299421018, 35791.82104089479, 36789.81605091978, 36836.63163368365, 36996.26007479849, 40374.39438408426, 40956.79521602395, 40958.0, 40961.59038409615, 41110.58889411105, 6928.0, 7049.259827718092, 7984.041914970212, 8131.268185863271, 8144.51132932023, 9985.500724963722, 10186.949065254663, 10199.337043092175, 10200.387976721384, 10209.438480883548, 9942.353747006422, 10035.749106272366, 10053.09522143007, 10058.798824023515, 10059.949700251489, 7270.78187654366, 7448.031755871756, 10039.648612298572, 10145.797084058315, 10366.688999330032, 10022.54898529568, 10167.23745719074, 10169.745756356077, 10172.186225101974, 10185.28702990791, 37204.25591488182, 37662.81168594167, 37699.623003769884, 37735.24529509395, 37756.0, 2807.1578526441986, 2814.183886672883, 2899.4635992341487, 2994.116735563014, 3383.4924761285756, 28025.57961630577, 28054.0, 28114.578281325797, 28252.434951301064, 28450.146495605164, 3209.646938836726, 3559.697425718817, 3570.410882204433, 3586.8923932282073, 3692.5199724035974, 207182.0, 209124.0, 209608.0, 209609.0, 209746.95126524422, 53425.46574534283, 54430.0, 56811.71594142003, 57210.42789572134, 57225.14162287569, 65410.345896541374, 66739.32824702225, 66977.0, 67099.66450167718, 67109.66445167742, 13907.791383129059, 13997.3701183447, 14006.859931400759, 14039.298035098203, 14052.718945621235, 9673.661421850202, 9697.854532182022, 9710.902890971141, 9719.17387022111, 9719.61121555144, 19552.51118722015, 19904.70142947857, 19927.003649817452, 19934.202631894852, 19940.102695378744, 7612.581308028111, 7807.588712377488, 7828.491148075357, 7830.530168189927, 7949.443538952218, 834.7328854766416, 902.4224496322358, 915.54680433186, 969.8593703912893, 1003.4731765822855, 26566.73433265681, 26618.20145395641, 26638.0, 27020.459590808074, 27186.592201117, 1051.8106740786732, 1076.8546246256813, 1080.9405482698528, 1098.906592939593, 1102.6747109602686, 14067.788983165261, 14176.85592792643, 14240.0, 14345.211013394155, 14415.639609009859, 253145.0, 257205.0, 258001.0, 259074.0, 259502.0, 46677.29984050242, 47499.28751068737, 47507.28739068917, 47510.52489475061, 47565.5243447568, 1172.4899668644166, 1174.8413964114907, 1177.181858608259, 1185.82805493203, 1191.368574655434, 21997.560048799256, 25051.24846254615, 26219.606705899045, 29527.0, 30285.697143028287, 40476.59523404846, 40899.0, 40937.795311023256, 40977.385339220535, 41004.589954100076, 197347.0, 198563.0, 198599.0, 198935.0, 285514.0, 25559.361015974748, 28685.713142868302, 29244.853775730986, 29334.853325733235, 29638.851805740833, 34163.316733665684, 37639.24721505609, 38157.80921095377, 38163.0, 38223.42664860085, 31962.52056219205, 31978.0, 32124.678753213102, 32875.835620821745, 33235.667643324225, 31770.6822931777, 32504.187395315308, 32564.83717581397, 32900.59218082613, 33330.666693333726, 32338.676613233565, 32492.83753581217, 32500.512492312162, 32660.0, 32698.34603307873, 28528.714712852605, 29645.25886852846, 34504.82747586246, 35811.0, 36186.276274473836, 23631.291061268188, 23856.284311470685, 24007.159749409384, 24161.15435959733, 24231.0], "unit": "ms", "name": "ext.html", "value": 17338.09349196551}, {"lowerIsBetter": false, "replicates": [334.096269590757, 335.5151805640849, 337.2428897125952, 337.50386931211125, 341.7402773891843, 14700.191489468089, 15098.396064157434, 16427.917860410696, 16431.753523697153, 16605.66788664226, 14136.0, 14993.17537535435, 15051.24743762813, 15067.62330941727, 15495.457658981937, 3767.9058023549355, 4843.443004054544, 4969.180085285923, 4971.304017437544, 4971.45314015458, 3881.7476864003893, 5486.780528778864, 5635.887282254353, 5650.265465489501, 5657.915131273014, 5475.835724928239, 5509.614326997112, 5567.721613919308, 5575.386707462176, 5575.470330318613, 3683.686886614641, 3785.4889589905288, 5390.487903649187, 5534.4742249486235, 5547.223388725582, 4793.880152996168, 4818.831340903052, 4819.855404337875, 4827.806887724522, 4859.854204373874, 19222.231110755554, 19833.206671733256, 20029.098690558814, 20182.889941053236, 20196.495087622927, 1855.6010457751647, 1868.4301288107122, 1902.6860568006261, 1926.6917293233016, 1979.3270288101971, 12642.810357844639, 12745.0, 12803.5518756844, 13145.0, 13167.078304518687, 1704.1564425609279, 1729.8962062276178, 1746.3162086817977, 1776.3427531813184, 1782.3494424535081, 51765.2235216472, 51832.2225166619, 51875.0, 52776.0, 53358.73320633411, 9366.718998430058, 9568.425894446356, 9807.31348805591, 9809.21526277896, 9859.950700246452, 12357.814632780515, 12433.502659893504, 12436.564720234748, 12439.191452555555, 12441.626751197478, 6476.773312934025, 6683.598984060972, 6691.832704182434, 6905.75829845963, 7041.92958070423, 6379.681015949277, 6407.871842563216, 6416.165898433267, 6457.199160006741, 6464.515161362822, 4148.0, 4188.267053265728, 4207.389928460418, 4208.9789551052045, 4213.768242746678, 1719.8796084274231, 1743.921523531444, 1747.6155245845894, 1760.9647807043787, 1792.507060558357, 377.45269359428937, 378.7329932397653, 392.3800395375357, 764.7208768799348, 918.4535201555065, 8470.280026197843, 9857.901420985841, 10593.523291451904, 11024.062954648783, 11088.168387370819, 397.68582819572794, 408.6118187721617, 409.2245195354786, 411.8208579268028, 420.7181188603643, 5535.723213839292, 5675.035244008528, 5694.345150307768, 5733.312002559636, 5769.711514424262, 314448.0, 435912.0, 443750.0, 485201.0, 501376.0, 70301.0, 73179.90230146552, 73761.0, 74095.62952185313, 74938.62530687312, 1006.6577363696232, 1021.0402221911379, 1029.0789743179962, 1033.4109557552274, 1035.140833108518, 14530.709385812435, 14642.341094650554, 14793.11241325524, 14947.327370268582, 15012.549623511311, 33891.830540848125, 33927.830360849024, 34471.138221544665, 35071.12322191965, 35145.47281790724, 42469.0, 45468.772656136505, 46182.0, 46198.53801461942, 47796.04407911892, 8400.49597024156, 8631.827363452821, 8664.91335086641, 8721.520316382659, 9167.220786232978, 10717.464126793786, 10725.946370268099, 10831.566737330733, 10841.67474975752, 15442.2278886053, 12861.099723019299, 13105.737885242432, 13119.491258505012, 13166.47334106625, 13890.791638125234, 13154.276514791778, 13351.332433378486, 13420.194788312732, 13521.661958451117, 13798.17210967305, 13283.0, 14277.500287490304, 14406.135631862122, 14794.852051479347, 14811.0, 9060.592273347847, 9065.954670226607, 9118.088191180828, 9222.44665320083, 9362.859557106785, 10532.473376331305, 13159.802602960772, 13348.199108053548, 13700.24648644334, 13831.239281839595], "unit": "ms", "name": "jquery.html", "value": 7812.900052864653}, {"lowerIsBetter": false, "replicates": [1416.4900635771128, 1664.9084300363481, 1692.3399874049114, 1713.2632967823838, 1729.3774241273143, 5809.738561764725, 6250.531210159239, 6740.123783908091, 6964.059851919989, 7018.122734658168, 6912.896306555405, 6913.06673599064, 6995.265497122792, 7012.894806577905, 7026.6486675666265, 2063.618230627335, 2107.0412962102205, 2107.1887323380533, 2107.241393098491, 2108.5150415404464, 2083.073032500538, 2094.1309356616985, 2103.442587714257, 2104.7579528354204, 2110.0, 2074.2532688232222, 2082.614716277486, 2088.5181277002466, 2103.621348157331, 2103.852730308879, 2004.2984955265686, 2034.8575599708026, 2036.0, 2037.6128535578193, 2038.9592208155827, 1980.9405717828345, 2002.559436923889, 2013.2852837242715, 2017.152795825742, 2019.2629690163133, 6972.302769723038, 7069.681864316118, 7070.681819318143, 7078.823029424254, 7082.822929426754, 4073.714839961204, 4116.464859568267, 4117.8970525736795, 4141.64795992341, 4152.273352163359, 2565.679290088739, 2571.6528268683674, 2586.508563372953, 2643.444876575921, 2679.0623281851194, 789.4907784478979, 805.2430715127762, 818.6397984886631, 834.8747687846811, 860.0539406652632, 9577.0, 9588.472634005127, 9593.376430532064, 9604.135627793532, 9631.614735410576, 3844.615538446133, 3857.864974725871, 3895.4741109949796, 3898.571157172709, 3909.2963266612282, 8228.753137405887, 8247.298979586802, 8261.958690206511, 8265.214804593554, 8293.33653307734, 4247.214265360918, 4250.086231460251, 4255.723377980421, 4272.764997925144, 4277.721948073366, 3227.596550431196, 3308.5368048473233, 3701.3522633539023, 3872.0319920019997, 3908.355121404993, 3310.337932413527, 3358.462645976632, 3364.8149351785396, 3391.9491207631904, 3426.1605906553054, 1106.4965440724452, 1107.9944600277108, 1111.2665640677114, 1113.5100555755603, 1121.8317252412203, 886.5257087458308, 982.8525721141885, 1154.6132045764764, 1170.78925793358, 1179.0567545963195, 6685.732570697215, 6727.865442691119, 6734.8989765153565, 6757.695903684346, 6762.289959554176, 1024.08856118055, 1030.4950574218578, 1030.5723124903081, 1046.56567524478, 1077.8113830079706, 4960.156773348539, 5005.174146265826, 5019.623528235397, 5036.471170527115, 5039.470855560114, 8157.306628936607, 8199.22107399796, 8328.0, 8469.40714150016, 8530.0, 8335.541545215072, 8364.707235246737, 8411.70559030431, 8441.0, 8446.239838414573, 6301.810945671546, 6382.776602818879, 6443.613383197023, 6528.771492997722, 6560.967195163994, 6268.153799237227, 6300.306966233619, 6300.338464461165, 6330.778422755366, 6353.047042943411, 7355.1541572719825, 7369.889451658122, 7448.6275686214385, 7497.0, 7549.9245007549225, 7447.813804654927, 7585.393168546613, 7608.733694320672, 7637.198094200029, 7706.653200605874, 5036.521530454601, 5152.124138896472, 5738.741756620879, 5807.361190268983, 5811.82564523065, 6650.235222949423, 6786.423154031962, 6812.420944219797, 6817.693203805741, 6823.658817059028, 6065.787697430569, 6344.936550634435, 6378.712957916998, 6459.903101453576, 6471.0, 6250.187475628321, 6314.431701146918, 6350.4919606432295, 6359.0, 6526.967365163144, 6434.967825160844, 6569.57297775643, 6570.29172415166, 6570.868582628225, 6573.04690819838, 5811.4188581143235, 5814.127880817911, 5819.243498345188, 5819.476247137778, 5822.359540450462, 5822.796202132905, 5920.615160014585, 5928.466438020599, 5937.762489500545, 5941.1385349123275], "unit": "ms", "name": "mootools.html", "value": 4034.552721634694}, {"lowerIsBetter": false, "replicates": [301.2393705892621, 304.604014780785, 311.73191055692104, 313.7662441481097, 315.18210244415735, 5157.5358217760395, 5256.89486210276, 5304.549113325367, 5312.601554883389, 5325.227841962923, 5140.8971820563565, 5221.791128354861, 5224.033553792551, 5228.581713462923, 5300.655457395266, 3875.767453952772, 3961.762294262339, 4076.4700588923547, 4080.489938757655, 4086.427900093982, 3967.0, 4053.493313335833, 4053.574374690659, 4064.4512990746316, 4075.8777236682945, 4014.899627509321, 4019.216252830699, 4030.556638769733, 4040.636342729154, 4041.0503531670033, 3814.465974763549, 3898.4152377143655, 3950.762954222756, 4019.216252830699, 4040.0, 3512.2448673535314, 3518.2084031093054, 3519.964800351989, 3521.8767343142868, 3522.2603253316834, 5010.599152067863, 5028.7737051832755, 5032.698038117688, 5034.974825125888, 5037.974810125963, 4611.262198048296, 4613.446386433616, 4620.514845941195, 4621.1219868224925, 4621.907561848744, 5357.43746906577, 5484.177373393983, 5485.890282194374, 5486.31421072366, 5489.917651235235, 3808.067023579241, 3808.9809550952345, 3809.142942837867, 3811.866584669523, 3817.0, 5731.426857314277, 5811.331696854873, 5821.155932389822, 5824.271966004292, 5830.504407125357, 3976.602339766, 3976.781277029791, 3977.204559088194, 3979.4030895365927, 3980.701447391399, 3933.6066393360434, 4023.91952160961, 4033.334499807499, 4033.9596604033586, 4037.7173597848455, 4623.260278355447, 4625.907481850344, 4627.444706635225, 4632.3977882875015, 4633.72197668141, 5529.834104976857, 5542.86142846424, 5545.390007099216, 5545.972270138624, 5548.361938377138, 1401.8037474753542, 1425.287356321839, 1425.9857401426061, 1427.5217802036434, 1428.171660436944, 943.0899182289124, 949.6154057606681, 963.9132478077007, 968.951552422376, 972.0619602084023, 4843.07981483517, 4847.80608775645, 4848.151573474628, 4860.149473842063, 4864.513548645107, 5712.885742285131, 5716.79991200306, 5718.79984200551, 5725.198472213893, 5727.255456790591, 4841.080194762983, 4850.369451971221, 4853.223484242575, 4859.611231101503, 4861.562459378602, 2833.7874659400627, 2884.4952133376573, 3057.8165310081467, 3078.7844850860674, 3079.445699774017, 5316.202569614588, 5358.356997160287, 5430.91853622196, 5471.042567550663, 5485.945140548623, 5938.346781853993, 5943.197668314722, 5947.078202878474, 5949.077892926603, 5951.732172052268, 5467.644603100785, 5476.3702174250475, 5476.616636835463, 5477.397486276506, 5480.369422677138, 5614.382417934105, 5761.366249712612, 5767.826965191051, 5771.942280577308, 5784.971075144597, 5677.091665333527, 5679.119736440858, 5680.488756011979, 5682.715864206856, 5682.801101961411, 5466.726663666721, 5475.698836564027, 5475.945240547543, 5480.424555421783, 5483.479069488392, 3945.191235796712, 3980.980095099506, 3980.980095099622, 3983.083890705096, 3986.4219688145636, 5630.268065151504, 5761.078227483583, 5761.193432919478, 5766.4233576642, 5772.04761214395, 5531.419200983839, 5535.169724541351, 5548.0845660465575, 5549.44505549458, 5549.556035517229, 5528.391876893619, 5539.9169012464035, 5542.140968149944, 5546.528545073714, 5554.777808887599, 5272.0, 5374.355077390738, 5408.432114627907, 5417.5665946723375, 5430.5384042356845, 5594.664320140804, 5598.916016259841, 5600.85997850057, 5602.047651899105, 5602.551795856403, 5196.662216955886, 5268.078086334799, 5301.496357845998, 5459.535939445192, 5459.672419654833], "unit": "ms", "name": "prototype.html", "value": 4147.198983594263}, {"lowerIsBetter": false, "replicates": [673.6530686696351, 688.0882830249917, 736.5543845973186, 753.6420200404812, 813.6541969662895, 11027.669169924906, 11245.0, 11263.831042534368, 11276.943615281913, 11278.661640150798, 9745.853812192823, 10869.83695244572, 10964.0680542154, 11246.268992515481, 11402.600908968188, 813.8087549425895, 831.3764676492631, 831.7629475599456, 831.9376046796484, 832.4422636833306, 819.5328662662284, 824.6618886256636, 826.9710560130396, 827.4538804389105, 827.5448503323179, 849.9192576705203, 861.0915484164204, 861.5046348349692, 861.5735211070529, 861.6725644255174, 855.2132038524572, 855.9400841941067, 856.8928883889514, 857.648364170687, 857.7083791510854, 631.9842003949892, 632.2349956552576, 633.0283015571076, 633.1547384242042, 633.5470138850698, 10952.945235273852, 11092.057175140122, 11102.722431939186, 11103.333799972028, 11103.44482775858, 9007.729768106967, 9040.638374465014, 9127.132922372364, 9373.43759374433, 9447.622095116187, 8612.956935215283, 8735.694250701195, 8806.471611703255, 9013.864792028126, 9647.662331818423, 3199.488081906907, 3228.2413632796274, 3242.675732426762, 3245.140037889961, 3324.7838890472044, 35222.0, 35676.28647427037, 35774.28451430957, 39501.0, 40161.799191003855, 8878.600462979182, 9024.36829421934, 9095.863562046574, 9357.20463760588, 9754.219662426989, 15952.521424357055, 16139.515814525583, 16142.273597688132, 16173.110478923772, 16189.0, 6120.816375508742, 6121.0, 6346.746130154835, 6356.936430635635, 6428.132202152743, 3597.244578638515, 3642.4718415830084, 3653.1597732521136, 3670.0, 3673.779573225615, 2704.8241864278757, 2762.502749505068, 2770.4459108178444, 2770.7783377329765, 2772.7088655691264, 489.35649620748603, 491.1944411165691, 504.6114491841335, 505.06058730760753, 509.5083244668912, 375.16900066353156, 411.24331230535955, 412.1016184717345, 415.2442554550749, 456.33375272103103, 6664.200295964515, 7067.187273463617, 7101.502894797418, 7118.644067796693, 7161.427085833121, 382.1783166192652, 383.3827537664358, 409.13876290408854, 410.69198101423933, 437.2042881954875, 3494.3710132175943, 3508.893898914423, 3594.658507441789, 3647.744657873923, 3797.487339209227, 44345.0, 49745.0, 49771.751141244065, 49795.751021244665, 49890.25164622533, 43658.56341436609, 43785.0, 44027.0, 44074.11851762947, 44438.0, 35892.0, 38814.0, 41355.37966930499, 45867.31199032017, 46400.53599463962, 7401.703931842666, 7748.496347737379, 7777.183395743592, 8047.436679432383, 8134.349252059703, 29760.0, 29842.253943651584, 29998.55002175013, 31708.84145579257, 33516.0, 39537.209255815294, 40076.799616001736, 40118.799406002785, 40141.59858401495, 40155.799221003705, 8510.721380771227, 9510.286728495252, 9618.711438656852, 9832.55753491109, 9868.950655246677, 9896.851547226654, 10186.898131018595, 10188.235882309005, 10269.640562580274, 10546.20903432261, 10222.335548189343, 10222.488875556044, 10285.125764309818, 10403.347611855419, 10429.374237545771, 10224.539895704562, 10228.232882533692, 10241.334313269614, 10244.897551024394, 10258.794824103326, 10285.9485702571, 10310.845337320095, 10319.226058045526, 10323.32898361604, 10358.171346292429, 8857.114288571349, 8879.334049946408, 8942.46345219289, 8977.551122443982, 9045.185933266037, 8579.2707619853, 8931.151540603632, 8976.506292153734, 9003.189712925869, 9023.909760902307], "unit": "ms", "name": "yui.html", "value": 5502.86310644149}], "name": "dromaeo_css", "value": 6198.5302812451055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 107.0, 110.0, 112.0, 111.0, 101.0, 113.0, 111.0, 118.0], "unit": "ms", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [156.0, 136.0, 152.0, 166.0, 130.0, 154.0, 149.0, 130.0, 168.0, 136.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 161.0, 164.0, 162.0, 163.0, 162.0, 162.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 84.0, 94.0, 72.0, 78.0, 75.0, 115.0, 95.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 140.0, 95.0, 95.0, 94.0, 136.0, 95.0, 95.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 71.0, 71.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 70.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 85.0, 84.0, 84.0, 85.0, 84.0, 83.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [119.0, 126.0, 117.0, 118.0, 120.0, 126.0, 125.0, 123.0, 121.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [136.0, 155.0, 144.0, 146.0, 145.0, 134.0, 148.0, 146.0, 136.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 67.0, 68.0, 69.0, 67.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1515.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.5603217158177], "unit": "score", "name": "Richards", "value": 210.68233600000002}, {"lowerIsBetter": false, "replicates": [185.6665428889714], "unit": "score", "name": "DeltaBlue", "value": 356.111548}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [2012.0724346076458], "unit": "score", "name": "RayTrace", "value": 367.77453300000013}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [11858.823529411764], "unit": "score", "name": "Boyer", "value": 56.19975694444442}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [624.2197253433209], "unit": "score", "name": "Splay", "value": 130.54858199999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19739.700556203898}]} 12:44:09 INFO - RETURN: dromaeo_css: 6198.53 12:44:09 INFO - RETURN: kraken: 1515.70 12:44:09 INFO - RETURN: v8_7: 19739.70 12:44:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19739.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6198.53"}}} 12:44:09 INFO - Return code: 0 12:44:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:44:09 ERROR - # TBPL SUCCESS # 12:44:09 INFO - Running post-action listener: _resource_record_post_action 12:44:09 INFO - Running post-run listener: _resource_record_post_run 12:44:10 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 507785216; Read time: 0; Write time: 460440 12:44:10 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232038400; Read time: 0; Write time: 331764 12:44:10 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 275746816; Read time: 0; Write time: 128676 12:44:10 INFO - Running post-run listener: _upload_blobber_files 12:44:10 INFO - Blob upload gear active. 12:44:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:44:10 INFO - Copying logs to upload dir... 12:44:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.032369 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-10 12:44:10.613024) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:44:10.616811) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009933 build_url: 'https://queue.taskcluster.net/v1/task/pthj8n_QSwq8HEoTOUagyw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 12:44:10.668881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:44:10.669224) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449778649.70482-2033429765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 12:44:10.719291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 12:44:10.719680) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 12:44:10.719978) ========= ========= Total master_lag: 0.24 =========