builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1449572377.65 results: success (0) buildid: 20151208021525 builduid: 83690e1bffe3428a98519ae8ba91a49a revision: 396725444e10c322b95becb2619e6837c9308b09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.653601) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.654046) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.654386) ========= 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=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005768 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.723701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.724053) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.793278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.793599) ========= 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=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.854862) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.855180) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.855572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:37.855892) ========= 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=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-08 02:59:37-- 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% 229M=0s 2015-12-08 02:59:38 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.237325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:38.110639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:38.110973) ========= 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=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015603 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:38.201762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 02:59:38.202126) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 396725444e10c322b95becb2619e6837c9308b09 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 396725444e10c322b95becb2619e6837c9308b09 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-08 02:59:38,356 truncating revision to first 12 chars 2015-12-08 02:59:38,356 Setting DEBUG logging. 2015-12-08 02:59:38,356 attempt 1/10 2015-12-08 02:59:38,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/396725444e10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-08 02:59:39,595 unpacking tar archive at: fx-team-396725444e10/testing/mozharness/ program finished with exit code 0 elapsedTime=1.515754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 02:59:39.730898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.731218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.739187) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.739465) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 02:59:39.739870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-08 02:59:39.740182) ========= /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=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:40 INFO - MultiFileLogger online at 20151208 02:59:40 in /builds/slave/test 02:59:40 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 02:59:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:40 INFO - {'append_to_log': False, 02:59:40 INFO - 'base_work_dir': '/builds/slave/test', 02:59:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:59:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:40 INFO - 'branch': 'Fx-Team-Non-PGO', 02:59:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:40 INFO - 'config_files': ('talos/linux_config.py',), 02:59:40 INFO - 'default_actions': ('clobber', 02:59:40 INFO - 'read-buildbot-config', 02:59:40 INFO - 'download-and-extract', 02:59:40 INFO - 'populate-webroot', 02:59:40 INFO - 'create-virtualenv', 02:59:40 INFO - 'install', 02:59:40 INFO - 'run-tests'), 02:59:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:40 INFO - 'download_minidump_stackwalk': True, 02:59:40 INFO - 'download_symbols': 'ondemand', 02:59:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:40 INFO - 'installer_path': 'installer.exe', 02:59:40 INFO - 'log_level': 'info', 02:59:40 INFO - 'log_name': 'talos', 02:59:40 INFO - 'log_to_console': True, 02:59:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:40 INFO - 'opt_config_files': (), 02:59:40 INFO - 'pip_index': False, 02:59:40 INFO - 'sps_profile': False, 02:59:40 INFO - 'sps_profile_interval': 0, 02:59:40 INFO - 'suite': 'dromaeojs', 02:59:40 INFO - 'system_bits': '64', 02:59:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:40 INFO - 'title': 'talos-linux64-ix-045', 02:59:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:40 INFO - 'use_talos_json': True, 02:59:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:40 INFO - 'work_dir': 'build'} 02:59:40 INFO - ##### 02:59:40 INFO - ##### Running clobber step. 02:59:40 INFO - ##### 02:59:40 INFO - Running pre-action listener: _resource_record_pre_action 02:59:40 INFO - Running main action method: clobber 02:59:40 INFO - rmtree: /builds/slave/test/build 02:59:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:40 INFO - Running post-action listener: _resource_record_post_action 02:59:40 INFO - ##### 02:59:40 INFO - ##### Running read-buildbot-config step. 02:59:40 INFO - ##### 02:59:40 INFO - Running pre-action listener: _resource_record_pre_action 02:59:40 INFO - Running main action method: read_buildbot_config 02:59:40 INFO - Using buildbot properties: 02:59:40 INFO - { 02:59:40 INFO - "properties": { 02:59:40 INFO - "buildnumber": 2197, 02:59:40 INFO - "product": "firefox", 02:59:40 INFO - "script_repo_revision": "production", 02:59:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:59:40 INFO - "repository": "", 02:59:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:59:40 INFO - "buildid": "20151208021525", 02:59:40 INFO - "slavename": "talos-linux64-ix-045", 02:59:40 INFO - "pgo_build": "False", 02:59:40 INFO - "basedir": "/builds/slave/test", 02:59:40 INFO - "project": "", 02:59:40 INFO - "platform": "ubuntu64_hw", 02:59:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:59:40 INFO - "slavebuilddir": "test", 02:59:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:59:40 INFO - "branch": "fx-team", 02:59:40 INFO - "repo_path": "integration/fx-team", 02:59:40 INFO - "stage_platform": "linux64", 02:59:40 INFO - "builduid": "83690e1bffe3428a98519ae8ba91a49a", 02:59:40 INFO - "revision": "396725444e10c322b95becb2619e6837c9308b09" 02:59:40 INFO - }, 02:59:40 INFO - "sourcestamp": { 02:59:40 INFO - "repository": "", 02:59:40 INFO - "hasPatch": false, 02:59:40 INFO - "project": "", 02:59:40 INFO - "branch": "fx-team-linux64-talos", 02:59:40 INFO - "changes": [ 02:59:40 INFO - { 02:59:40 INFO - "category": null, 02:59:40 INFO - "files": [ 02:59:40 INFO - { 02:59:40 INFO - "url": null, 02:59:40 INFO - "name": "https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:59:40 INFO - } 02:59:40 INFO - ], 02:59:40 INFO - "repository": "", 02:59:40 INFO - "rev": "396725444e10c322b95becb2619e6837c9308b09", 02:59:40 INFO - "who": "cbook@mozilla.com", 02:59:40 INFO - "when": 1449572278, 02:59:40 INFO - "number": 7044683, 02:59:40 INFO - "comments": "Bug 951714 - DevTools Themes: Update network panel table headers to match new theme. r=vporof", 02:59:40 INFO - "project": "", 02:59:40 INFO - "at": "Tue 08 Dec 2015 02:57:58", 02:59:40 INFO - "branch": "fx-team-linux64-talos", 02:59:40 INFO - "revlink": "", 02:59:40 INFO - "properties": [ 02:59:40 INFO - [ 02:59:40 INFO - "buildid", 02:59:40 INFO - "20151208021525", 02:59:40 INFO - "Change" 02:59:40 INFO - ], 02:59:40 INFO - [ 02:59:40 INFO - "builduid", 02:59:40 INFO - "83690e1bffe3428a98519ae8ba91a49a", 02:59:40 INFO - "Change" 02:59:40 INFO - ], 02:59:40 INFO - [ 02:59:40 INFO - "pgo_build", 02:59:40 INFO - "False", 02:59:40 INFO - "Change" 02:59:40 INFO - ] 02:59:40 INFO - ], 02:59:40 INFO - "revision": "396725444e10c322b95becb2619e6837c9308b09" 02:59:40 INFO - } 02:59:40 INFO - ], 02:59:40 INFO - "revision": "396725444e10c322b95becb2619e6837c9308b09" 02:59:40 INFO - } 02:59:40 INFO - } 02:59:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:59:40 INFO - Running post-action listener: _resource_record_post_action 02:59:40 INFO - ##### 02:59:40 INFO - ##### Running download-and-extract step. 02:59:40 INFO - ##### 02:59:40 INFO - Running pre-action listener: _resource_record_pre_action 02:59:40 INFO - Running main action method: download_and_extract 02:59:40 INFO - mkdir: /builds/slave/test/build/tests 02:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:40 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json 02:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json 02:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:59:43 INFO - Downloaded 1302 bytes. 02:59:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:59:43 INFO - Using the following test package requirements: 02:59:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:59:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:43 INFO - u'jsshell-linux-x86_64.zip'], 02:59:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:59:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:59:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:59:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:59:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:59:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:59:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:59:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:43 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:45 INFO - Downloaded 21860240 bytes. 02:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:59:46 INFO - Return code: 0 02:59:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:46 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:59:48 INFO - Downloaded 21860240 bytes. 02:59:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 02:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:59:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:59:50 INFO - Return code: 0 02:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:50 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:59:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:59:51 INFO - Downloaded 11132074 bytes. 02:59:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 02:59:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:59:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:59:51 INFO - Return code: 0 02:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:51 INFO - https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:59:53 INFO - Downloaded 57728835 bytes. 02:59:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:53 INFO - mkdir: /builds/slave/test/properties 02:59:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:53 INFO - Contents: 02:59:53 INFO - build_url:https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:59:53 INFO - Running post-action listener: _resource_record_post_action 02:59:53 INFO - Running post-action listener: set_extra_try_arguments 02:59:53 INFO - ##### 02:59:53 INFO - ##### Running populate-webroot step. 02:59:53 INFO - ##### 02:59:53 INFO - Running pre-action listener: _resource_record_pre_action 02:59:53 INFO - Running main action method: populate_webroot 02:59:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:59:53 INFO - '../fennec_ids.txt'], 02:59:53 INFO - 'tests': ['tcheck2']}, 02:59:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:53 INFO - '--tppagecycles', 02:59:53 INFO - '7'], 02:59:53 INFO - 'tests': ['tsvgm']}}, 02:59:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:59:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:59:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:59:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'tests': ['damp', 'tps']}, 02:59:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['damp', 'tps']}, 02:59:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:59:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:53 INFO - 'other': {'tests': ['a11yr', 02:59:53 INFO - 'ts_paint', 02:59:53 INFO - 'tpaint', 02:59:53 INFO - 'sessionrestore', 02:59:53 INFO - 'sessionrestore_no_auto_restore']}, 02:59:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['a11yr', 02:59:53 INFO - 'ts_paint', 02:59:53 INFO - 'tpaint', 02:59:53 INFO - 'sessionrestore', 02:59:53 INFO - 'sessionrestore_no_auto_restore']}, 02:59:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['a11yr', 02:59:53 INFO - 'ts_paint', 02:59:53 INFO - 'tpaint', 02:59:53 INFO - 'sessionrestore', 02:59:53 INFO - 'sessionrestore_no_auto_restore']}, 02:59:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['a11yr', 02:59:53 INFO - 'ts_paint', 02:59:53 INFO - 'tpaint', 02:59:53 INFO - 'sessionrestore', 02:59:53 INFO - 'sessionrestore_no_auto_restore']}, 02:59:53 INFO - 'other_l64': {'tests': ['a11yr', 02:59:53 INFO - 'ts_paint', 02:59:53 INFO - 'tpaint', 02:59:53 INFO - 'sessionrestore', 02:59:53 INFO - 'sessionrestore_no_auto_restore']}, 02:59:53 INFO - 'other_nol64': {'tests': ['a11yr', 02:59:53 INFO - 'ts_paint', 02:59:53 INFO - 'tpaint', 02:59:53 INFO - 'sessionrestore', 02:59:53 INFO - 'sessionrestore_no_auto_restore']}, 02:59:53 INFO - 'svgr': {'tests': ['tsvgx', 02:59:53 INFO - 'tsvgr_opacity', 02:59:53 INFO - 'tart', 02:59:53 INFO - 'tscrollx', 02:59:53 INFO - 'cart']}, 02:59:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['tsvgx', 02:59:53 INFO - 'tsvgr_opacity', 02:59:53 INFO - 'tart', 02:59:53 INFO - 'tscrollx', 02:59:53 INFO - 'cart']}, 02:59:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'tests': ['tp5o']}, 02:59:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'talos_options': ['--e10s'], 02:59:53 INFO - 'tests': ['tp5o']}, 02:59:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'talos_options': ['--xperf_path', 02:59:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:53 INFO - 'tests': ['tp5n']}, 02:59:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:59:53 INFO - 'talos_options': ['--e10s', 02:59:53 INFO - '--xperf_path', 02:59:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:53 INFO - 'tests': ['tp5n']}}, 02:59:53 INFO - 'talos.zip': {'path': '', 02:59:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:53 INFO - Running post-action listener: _resource_record_post_action 02:59:53 INFO - ##### 02:59:53 INFO - ##### Running create-virtualenv step. 02:59:53 INFO - ##### 02:59:53 INFO - Running pre-action listener: _resource_record_pre_action 02:59:53 INFO - Running main action method: create_virtualenv 02:59:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:59:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:53 INFO - Using real prefix '/usr' 02:59:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:56 INFO - Installing pip.................done. 02:59:56 INFO - Return code: 0 02:59:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:56 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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:59:56 INFO - Using env: {'DISPLAY': ':0', 02:59:56 INFO - 'HOME': '/home/cltbld', 02:59:56 INFO - 'LANG': 'en_US.UTF-8', 02:59:56 INFO - 'LANGUAGE': 'en_US:en', 02:59:56 INFO - 'LOGNAME': 'cltbld', 02:59:56 INFO - 'MAIL': '/var/mail/cltbld', 02:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:56 INFO - 'MOZ_NO_REMOTE': '1', 02:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:56 INFO - 'NO_EM_RESTART': '1', 02:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:56 INFO - 'PWD': '/builds/slave/test', 02:59:56 INFO - 'SHELL': '/bin/bash', 02:59:56 INFO - 'SHLVL': '1', 02:59:56 INFO - 'TERM': 'linux', 02:59:56 INFO - 'TMOUT': '86400', 02:59:56 INFO - 'USER': 'cltbld', 02:59:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 02:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:56 INFO - '_': '/tools/buildbot/bin/python'} 02:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:59:57 INFO - Cleaning up... 02:59:57 INFO - Return code: 0 02:59:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:59:57 INFO - Using env: {'DISPLAY': ':0', 02:59:57 INFO - 'HOME': '/home/cltbld', 02:59:57 INFO - 'LANG': 'en_US.UTF-8', 02:59:57 INFO - 'LANGUAGE': 'en_US:en', 02:59:57 INFO - 'LOGNAME': 'cltbld', 02:59:57 INFO - 'MAIL': '/var/mail/cltbld', 02:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:57 INFO - 'MOZ_NO_REMOTE': '1', 02:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:57 INFO - 'NO_EM_RESTART': '1', 02:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:57 INFO - 'PWD': '/builds/slave/test', 02:59:57 INFO - 'SHELL': '/bin/bash', 02:59:57 INFO - 'SHLVL': '1', 02:59:57 INFO - 'TERM': 'linux', 02:59:57 INFO - 'TMOUT': '86400', 02:59:57 INFO - 'USER': 'cltbld', 02:59:57 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 02:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:57 INFO - '_': '/tools/buildbot/bin/python'} 02:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:57 INFO - Downloading/unpacking psutil>=0.7.1 02:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:59:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:59 INFO - Installing collected packages: psutil 02:59:59 INFO - Running setup.py install for psutil 02:59:59 INFO - building 'psutil._psutil_linux' extension 02:59:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:00:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:00:00 INFO - building 'psutil._psutil_posix' extension 03:00:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:00:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:01 INFO - Successfully installed psutil 03:00:01 INFO - Cleaning up... 03:00:01 INFO - Return code: 0 03:00:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:00:01 INFO - Using env: {'DISPLAY': ':0', 03:00:01 INFO - 'HOME': '/home/cltbld', 03:00:01 INFO - 'LANG': 'en_US.UTF-8', 03:00:01 INFO - 'LANGUAGE': 'en_US:en', 03:00:01 INFO - 'LOGNAME': 'cltbld', 03:00:01 INFO - 'MAIL': '/var/mail/cltbld', 03:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:01 INFO - 'MOZ_NO_REMOTE': '1', 03:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:01 INFO - 'NO_EM_RESTART': '1', 03:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:01 INFO - 'PWD': '/builds/slave/test', 03:00:01 INFO - 'SHELL': '/bin/bash', 03:00:01 INFO - 'SHLVL': '1', 03:00:01 INFO - 'TERM': 'linux', 03:00:01 INFO - 'TMOUT': '86400', 03:00:01 INFO - 'USER': 'cltbld', 03:00:01 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:01 INFO - '_': '/tools/buildbot/bin/python'} 03:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:00:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:00:03 INFO - Installing collected packages: mozsystemmonitor 03:00:03 INFO - Running setup.py install for mozsystemmonitor 03:00:03 INFO - Successfully installed mozsystemmonitor 03:00:03 INFO - Cleaning up... 03:00:03 INFO - Return code: 0 03:00:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:03 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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:00:03 INFO - Using env: {'DISPLAY': ':0', 03:00:03 INFO - 'HOME': '/home/cltbld', 03:00:03 INFO - 'LANG': 'en_US.UTF-8', 03:00:03 INFO - 'LANGUAGE': 'en_US:en', 03:00:03 INFO - 'LOGNAME': 'cltbld', 03:00:03 INFO - 'MAIL': '/var/mail/cltbld', 03:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:03 INFO - 'MOZ_NO_REMOTE': '1', 03:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:03 INFO - 'NO_EM_RESTART': '1', 03:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:03 INFO - 'PWD': '/builds/slave/test', 03:00:03 INFO - 'SHELL': '/bin/bash', 03:00:03 INFO - 'SHLVL': '1', 03:00:03 INFO - 'TERM': 'linux', 03:00:03 INFO - 'TMOUT': '86400', 03:00:03 INFO - 'USER': 'cltbld', 03:00:03 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:03 INFO - '_': '/tools/buildbot/bin/python'} 03:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:05 INFO - Downloading docopt-0.6.1.tar.gz 03:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:06 INFO - Running setup.py install for blobuploader 03:00:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:06 INFO - Running setup.py install for requests 03:00:06 INFO - Running setup.py install for docopt 03:00:06 INFO - Successfully installed blobuploader requests docopt 03:00:06 INFO - Cleaning up... 03:00:06 INFO - Return code: 0 03:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:06 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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:06 INFO - Using env: {'DISPLAY': ':0', 03:00:06 INFO - 'HOME': '/home/cltbld', 03:00:06 INFO - 'LANG': 'en_US.UTF-8', 03:00:06 INFO - 'LANGUAGE': 'en_US:en', 03:00:06 INFO - 'LOGNAME': 'cltbld', 03:00:06 INFO - 'MAIL': '/var/mail/cltbld', 03:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:06 INFO - 'MOZ_NO_REMOTE': '1', 03:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:06 INFO - 'NO_EM_RESTART': '1', 03:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:06 INFO - 'PWD': '/builds/slave/test', 03:00:06 INFO - 'SHELL': '/bin/bash', 03:00:06 INFO - 'SHLVL': '1', 03:00:06 INFO - 'TERM': 'linux', 03:00:06 INFO - 'TMOUT': '86400', 03:00:06 INFO - 'USER': 'cltbld', 03:00:06 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:06 INFO - '_': '/tools/buildbot/bin/python'} 03:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:06 INFO - Running setup.py (path:/tmp/pip-QsPdnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:06 INFO - Running setup.py (path:/tmp/pip-Pmemc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:06 INFO - Running setup.py (path:/tmp/pip-XEoePi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:07 INFO - Running setup.py (path:/tmp/pip-Df7LBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:07 INFO - Running setup.py (path:/tmp/pip-rVu4gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:07 INFO - Running setup.py (path:/tmp/pip-fP60ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:07 INFO - Running setup.py (path:/tmp/pip-pCRmY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:07 INFO - Running setup.py (path:/tmp/pip-whpvp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:07 INFO - Running setup.py (path:/tmp/pip-7VQv9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:07 INFO - Running setup.py (path:/tmp/pip-7D7PnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:07 INFO - Running setup.py (path:/tmp/pip-prCOc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:07 INFO - Running setup.py (path:/tmp/pip-VzgG71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:07 INFO - Running setup.py (path:/tmp/pip-5n5hF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:07 INFO - Running setup.py (path:/tmp/pip-7RlIou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:07 INFO - Running setup.py (path:/tmp/pip-MvJci0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:07 INFO - Running setup.py (path:/tmp/pip-ELj5Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:07 INFO - Running setup.py (path:/tmp/pip-c8MeCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:08 INFO - Running setup.py install for manifestparser 03:00:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Running setup.py install for mozcrash 03:00:08 INFO - Running setup.py install for mozdebug 03:00:08 INFO - Running setup.py install for mozdevice 03:00:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Running setup.py install for mozfile 03:00:08 INFO - Running setup.py install for mozhttpd 03:00:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Running setup.py install for mozinfo 03:00:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Running setup.py install for mozInstall 03:00:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:08 INFO - Running setup.py install for mozleak 03:00:08 INFO - Running setup.py install for mozlog 03:00:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Running setup.py install for moznetwork 03:00:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Running setup.py install for mozprocess 03:00:09 INFO - Running setup.py install for mozprofile 03:00:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Running setup.py install for mozrunner 03:00:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Running setup.py install for mozscreenshot 03:00:09 INFO - Running setup.py install for moztest 03:00:09 INFO - Running setup.py install for mozversion 03:00:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:09 INFO - Cleaning up... 03:00:09 INFO - Return code: 0 03:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:09 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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:09 INFO - Using env: {'DISPLAY': ':0', 03:00:09 INFO - 'HOME': '/home/cltbld', 03:00:09 INFO - 'LANG': 'en_US.UTF-8', 03:00:09 INFO - 'LANGUAGE': 'en_US:en', 03:00:09 INFO - 'LOGNAME': 'cltbld', 03:00:09 INFO - 'MAIL': '/var/mail/cltbld', 03:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:09 INFO - 'MOZ_NO_REMOTE': '1', 03:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:09 INFO - 'NO_EM_RESTART': '1', 03:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:09 INFO - 'PWD': '/builds/slave/test', 03:00:09 INFO - 'SHELL': '/bin/bash', 03:00:09 INFO - 'SHLVL': '1', 03:00:09 INFO - 'TERM': 'linux', 03:00:09 INFO - 'TMOUT': '86400', 03:00:09 INFO - 'USER': 'cltbld', 03:00:09 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:09 INFO - '_': '/tools/buildbot/bin/python'} 03:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:10 INFO - Running setup.py (path:/tmp/pip-K9eOKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:10 INFO - Running setup.py (path:/tmp/pip-_BJ4Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:10 INFO - Running setup.py (path:/tmp/pip-RUk_4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:10 INFO - Running setup.py (path:/tmp/pip-VlV0X7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:10 INFO - Running setup.py (path:/tmp/pip-YA_qUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:10 INFO - Running setup.py (path:/tmp/pip-41tBGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:10 INFO - Running setup.py (path:/tmp/pip-z7prlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:10 INFO - Running setup.py (path:/tmp/pip-xOqp3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:10 INFO - Running setup.py (path:/tmp/pip-fyCsqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:10 INFO - Running setup.py (path:/tmp/pip-76Yf1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:10 INFO - Running setup.py (path:/tmp/pip-cVgKke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:10 INFO - Running setup.py (path:/tmp/pip-_NBXRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:10 INFO - Running setup.py (path:/tmp/pip-UeGaPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:11 INFO - Running setup.py (path:/tmp/pip-0PpKmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:11 INFO - Running setup.py (path:/tmp/pip-VesK6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:11 INFO - Running setup.py (path:/tmp/pip-I6FqCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:11 INFO - Running setup.py (path:/tmp/pip-GSYYAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:12 INFO - Downloading blessings-1.5.1.tar.gz 03:00:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:13 INFO - Installing collected packages: blessings 03:00:13 INFO - Running setup.py install for blessings 03:00:13 INFO - Successfully installed blessings 03:00:13 INFO - Cleaning up... 03:00:13 INFO - Return code: 0 03:00:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:13 INFO - Reading from file tmpfile_stdout 03:00:13 INFO - Current package versions: 03:00:13 INFO - argparse == 1.2.1 03:00:13 INFO - blessings == 1.5.1 03:00:13 INFO - blobuploader == 1.2.4 03:00:13 INFO - docopt == 0.6.1 03:00:13 INFO - manifestparser == 1.1 03:00:13 INFO - mozInstall == 1.12 03:00:13 INFO - mozcrash == 0.16 03:00:13 INFO - mozdebug == 0.1 03:00:13 INFO - mozdevice == 0.47 03:00:13 INFO - mozfile == 1.2 03:00:13 INFO - mozhttpd == 0.7 03:00:13 INFO - mozinfo == 0.9 03:00:13 INFO - mozleak == 0.1 03:00:13 INFO - mozlog == 3.1 03:00:13 INFO - moznetwork == 0.27 03:00:13 INFO - mozprocess == 0.22 03:00:13 INFO - mozprofile == 0.27 03:00:13 INFO - mozrunner == 6.11 03:00:13 INFO - mozscreenshot == 0.1 03:00:13 INFO - mozsystemmonitor == 0.0 03:00:13 INFO - moztest == 0.7 03:00:13 INFO - mozversion == 1.4 03:00:13 INFO - psutil == 3.1.1 03:00:13 INFO - requests == 1.2.3 03:00:13 INFO - wsgiref == 0.1.2 03:00:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:13 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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:00:13 INFO - Using env: {'DISPLAY': ':0', 03:00:13 INFO - 'HOME': '/home/cltbld', 03:00:13 INFO - 'LANG': 'en_US.UTF-8', 03:00:13 INFO - 'LANGUAGE': 'en_US:en', 03:00:13 INFO - 'LOGNAME': 'cltbld', 03:00:13 INFO - 'MAIL': '/var/mail/cltbld', 03:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:13 INFO - 'MOZ_NO_REMOTE': '1', 03:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:13 INFO - 'NO_EM_RESTART': '1', 03:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:13 INFO - 'PWD': '/builds/slave/test', 03:00:13 INFO - 'SHELL': '/bin/bash', 03:00:13 INFO - 'SHLVL': '1', 03:00:13 INFO - 'TERM': 'linux', 03:00:13 INFO - 'TMOUT': '86400', 03:00:13 INFO - 'USER': 'cltbld', 03:00:13 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:13 INFO - '_': '/tools/buildbot/bin/python'} 03:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:13 INFO - Cleaning up... 03:00:13 INFO - Return code: 0 03:00:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:13 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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:00:13 INFO - Using env: {'DISPLAY': ':0', 03:00:13 INFO - 'HOME': '/home/cltbld', 03:00:13 INFO - 'LANG': 'en_US.UTF-8', 03:00:13 INFO - 'LANGUAGE': 'en_US:en', 03:00:13 INFO - 'LOGNAME': 'cltbld', 03:00:13 INFO - 'MAIL': '/var/mail/cltbld', 03:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:13 INFO - 'MOZ_NO_REMOTE': '1', 03:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:13 INFO - 'NO_EM_RESTART': '1', 03:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:13 INFO - 'PWD': '/builds/slave/test', 03:00:13 INFO - 'SHELL': '/bin/bash', 03:00:13 INFO - 'SHLVL': '1', 03:00:13 INFO - 'TERM': 'linux', 03:00:13 INFO - 'TMOUT': '86400', 03:00:13 INFO - 'USER': 'cltbld', 03:00:13 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:13 INFO - '_': '/tools/buildbot/bin/python'} 03:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:13 INFO - Downloading/unpacking jsonschema 03:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:00:15 INFO - Downloading/unpacking functools32 (from jsonschema) 03:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:15 INFO - warning: no files found matching '*.txt' 03:00:15 INFO - no previously-included directories found matching 'build' 03:00:15 INFO - no previously-included directories found matching 'dist' 03:00:15 INFO - no previously-included directories found matching '.git*' 03:00:15 INFO - Installing collected packages: jsonschema, functools32 03:00:15 INFO - Running setup.py install for functools32 03:00:15 INFO - warning: no files found matching '*.txt' 03:00:15 INFO - no previously-included directories found matching 'build' 03:00:15 INFO - no previously-included directories found matching 'dist' 03:00:15 INFO - no previously-included directories found matching '.git*' 03:00:16 INFO - Successfully installed jsonschema functools32 03:00:16 INFO - Cleaning up... 03:00:16 INFO - Return code: 0 03:00:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:16 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 0x7ff1c9184f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, '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': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:00:16 INFO - Using env: {'DISPLAY': ':0', 03:00:16 INFO - 'HOME': '/home/cltbld', 03:00:16 INFO - 'LANG': 'en_US.UTF-8', 03:00:16 INFO - 'LANGUAGE': 'en_US:en', 03:00:16 INFO - 'LOGNAME': 'cltbld', 03:00:16 INFO - 'MAIL': '/var/mail/cltbld', 03:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:16 INFO - 'MOZ_NO_REMOTE': '1', 03:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:16 INFO - 'NO_EM_RESTART': '1', 03:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:16 INFO - 'PWD': '/builds/slave/test', 03:00:16 INFO - 'SHELL': '/bin/bash', 03:00:16 INFO - 'SHLVL': '1', 03:00:16 INFO - 'TERM': 'linux', 03:00:16 INFO - 'TMOUT': '86400', 03:00:16 INFO - 'USER': 'cltbld', 03:00:16 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:16 INFO - '_': '/tools/buildbot/bin/python'} 03:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:16 INFO - Downloading/unpacking flake8 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:00:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:00:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:00:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:00:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:00:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:18 INFO - no previously-included directories found matching 'docs/_build' 03:00:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:00:18 INFO - Running setup.py install for pep8 03:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:18 INFO - no previously-included directories found matching 'docs/_build' 03:00:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:00:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:00:18 INFO - Cleaning up... 03:00:18 INFO - Return code: 0 03:00:18 INFO - Running post-action listener: _resource_record_post_action 03:00:18 INFO - Running post-action listener: _start_resource_monitoring 03:00:18 INFO - Starting resource monitoring. 03:00:18 INFO - ##### 03:00:18 INFO - ##### Running install step. 03:00:18 INFO - ##### 03:00:18 INFO - Running pre-action listener: _resource_record_pre_action 03:00:18 INFO - Running main action method: install 03:00:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:19 INFO - Reading from file tmpfile_stdout 03:00:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:19 INFO - Reading from file tmpfile_stdout 03:00:19 INFO - Output received: 03:00:19 INFO - Usage: mozinstall [options] installer 03:00:19 INFO - Options: 03:00:19 INFO - -h, --help show this help message and exit 03:00:19 INFO - -d DEST, --destination=DEST 03:00:19 INFO - Directory to install application into. [default: 03:00:19 INFO - "/builds/slave/test"] 03:00:19 INFO - --app=APP Application being installed. [default: firefox] 03:00:19 INFO - mkdir: /builds/slave/test/build/application 03:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:00:33 INFO - Reading from file tmpfile_stdout 03:00:33 INFO - Output received: 03:00:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:33 INFO - Running post-action listener: _resource_record_post_action 03:00:33 INFO - ##### 03:00:33 INFO - ##### Running run-tests step. 03:00:33 INFO - ##### 03:00:33 INFO - Running pre-action listener: _resource_record_pre_action 03:00:33 INFO - Running main action method: run_tests 03:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:33 INFO - Python 2.7.3 03:00:33 INFO - Return code: 0 03:00:33 INFO - grabbing minidump binary from tooltool 03:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:33 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 0x1b680b0>, '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 0x1b68fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b69440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:00:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:00:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:33 INFO - Return code: 0 03:00:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:00:34 INFO - Return code: 0 03:00:34 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/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test/build 03:00:34 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/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 03:00:34 INFO - Using env: {'DISPLAY': ':0', 03:00:34 INFO - 'HOME': '/home/cltbld', 03:00:34 INFO - 'LANG': 'en_US.UTF-8', 03:00:34 INFO - 'LANGUAGE': 'en_US:en', 03:00:34 INFO - 'LOGNAME': 'cltbld', 03:00:34 INFO - 'MAIL': '/var/mail/cltbld', 03:00:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:34 INFO - 'MOZ_NO_REMOTE': '1', 03:00:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:34 INFO - 'NO_EM_RESTART': '1', 03:00:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:34 INFO - 'PWD': '/builds/slave/test', 03:00:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:34 INFO - 'SHELL': '/bin/bash', 03:00:34 INFO - 'SHLVL': '1', 03:00:34 INFO - 'TERM': 'linux', 03:00:34 INFO - 'TMOUT': '86400', 03:00:34 INFO - 'USER': 'cltbld', 03:00:34 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514', 03:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:34 INFO - '_': '/tools/buildbot/bin/python'} 03:00:34 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/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 03:00:34 INFO - mozversion INFO | application_buildid: 20151208021525 03:00:34 INFO - mozversion INFO | application_changeset: 396725444e10c322b95becb2619e6837c9308b09 03:00:34 INFO - mozversion INFO | application_display_name: Nightly 03:00:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:35 INFO - mozversion INFO | application_name: Firefox 03:00:35 INFO - mozversion INFO | application_remotingname: firefox 03:00:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:00:35 INFO - mozversion INFO | application_vendor: Mozilla 03:00:35 INFO - mozversion INFO | application_version: 45.0a1 03:00:35 INFO - mozversion INFO | platform_buildid: 20151208021525 03:00:35 INFO - mozversion INFO | platform_changeset: 396725444e10c322b95becb2619e6837c9308b09 03:00:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:00:35 INFO - mozversion INFO | platform_version: 45.0a1 03:00:35 INFO - 2015-12-08 03:00:34,999 DEBUG : using testdate: 1449572434 03:00:35 INFO - 2015-12-08 03:00:34,999 DEBUG : actual date: 1449572434 03:00:35 INFO - 2015-12-08 03:00:35,078 INFO : starting webserver on 'localhost:43448' 03:00:35 INFO - 2015-12-08 03:00:35,079 INFO : Starting test suite talos-linux64-ix-045 03:00:35 INFO - 2015-12-08 03:00:35,079 INFO : Starting test dromaeo_css 03:00:35 INFO - 2015-12-08 03:00:35,079 DEBUG : operating with platform_type : linux_ 03:00:35 INFO - 2015-12-08 03:00:35,080 INFO : Initialising browser for dromaeo_css test... 03:00:35 INFO - 2015-12-08 03:00:35,095 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEQanjQ/profile http://localhost:43448/getInfo.html 03:00:42 INFO - 2015-12-08 03:00:42,390 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:00:42 INFO - 2015-12-08 03:00:42,390 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:00:42 INFO - 2015-12-08 03:00:42,390 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:00:42 INFO - 2015-12-08 03:00:42,390 DEBUG : BROWSER_OUTPUT: __metrics 03:00:42 INFO - 2015-12-08 03:00:42,515 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:00:42 INFO - 2015-12-08 03:00:42,583 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] 03:00:43 INFO - 2015-12-08 03:00:43,815 INFO : Browser initialized. 03:00:43 INFO - 2015-12-08 03:00:43,816 INFO : Running cycle 1/1 for dromaeo_css test... 03:00:43 INFO - 2015-12-08 03:00:43,816 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEQanjQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:00:55 INFO - 2015-12-08 03:00:55,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 142626816 03:00:55 INFO - 2015-12-08 03:00:55,793 DEBUG : BROWSER_OUTPUT: 03:01:47 INFO - 2015-12-08 03:01:47,046 DEBUG : BROWSER_OUTPUT: 1449572507045 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:03:59 INFO - 2015-12-08 03:03:59,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43448/tests/dromaeo/cssquery-ext.html) 03:04:00 INFO - 2015-12-08 03:04:00,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 223391744 03:04:00 INFO - 2015-12-08 03:04:00,290 DEBUG : BROWSER_OUTPUT: 03:07:02 INFO - 2015-12-08 03:07:02,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/dromaeo/cssquery-ext.html (next: http://localhost:43448/tests/dromaeo/cssquery-jquery.html) 03:07:03 INFO - 2015-12-08 03:07:03,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 220225536 03:07:03 INFO - 2015-12-08 03:07:03,252 DEBUG : BROWSER_OUTPUT: 03:10:05 INFO - 2015-12-08 03:10:05,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43448/tests/dromaeo/cssquery-mootools.html) 03:10:05 INFO - 2015-12-08 03:10:05,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 218791936 03:10:05 INFO - 2015-12-08 03:10:05,936 DEBUG : BROWSER_OUTPUT: 03:13:07 INFO - 2015-12-08 03:13:07,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43448/tests/dromaeo/cssquery-prototype.html) 03:13:08 INFO - 2015-12-08 03:13:08,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 203141120 03:13:08 INFO - 2015-12-08 03:13:08,439 DEBUG : BROWSER_OUTPUT: 03:16:11 INFO - 2015-12-08 03:16:11,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43448/tests/dromaeo/cssquery-yui.html) 03:16:11 INFO - 2015-12-08 03:16:11,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 204693504 03:16:11 INFO - 2015-12-08 03:16:11,813 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/dromaeo/cssquery-yui.html (next: http://localhost:43448/tests/dromaeo/cssquery-dojo.html) 03:19:14 INFO - 2015-12-08 03:19:14,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 252076032 03:19:14 INFO - 2015-12-08 03:19:14,707 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,707 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:19:14 INFO - 2015-12-08 03:19:14,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:19:14 INFO - 2015-12-08 03:19:14,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:19:14 INFO - 2015-12-08 03:19:14,707 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:19:14 INFO - 2015-12-08 03:19:14,707 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2588.961165582516;2657.189557185059;2666.6133410655443;2682.886602060144;2694.178275625934;4384.364267181257;4504.527024662412;4611.723296602202;4629.074185162964;4630.560096790808;4591.862244132682;4607.79264933078;4687.132880417125;4716.434027916646;4751.358566593509;4081.5132034611042;4304.634106100977;4310.3534469829465;4367.2575662137515;4395.340698895159;4333.068390296085;4356.586124318184;4389.100234451929;4399.1641588098155;4432.047109871377;4129.050318426749;4140.275451795938;4227.281362168439;4227.556106608792;4233.936490952638;4275.636570891478;4275.87172384829;4286.849960251377;4310.094880075188;4312.417823593806;4222;4229.788510574459;4253.149370125956;4272.46594175728;4284.121755040209;4382.05785756064;4499.932501012488;4500.8649740507835;4520.706154099973;4612.953870461286;5018.548330650259;5062.898742025176;5065.848024559269;5068.467810879878;5070.69575825448;5090.299702242891;5093.541581257705;5101.693898366073;5102.234664800272;5129.666571672867;4404.14119246747;4482.372467854503;4510.774461276923;4641.976790116028;4693.9530604693855;5178.482151784791;5183.118869792069;5192.221166825007;5220.895582088337;5236.293100431393;4968.751562421937;4974.925376119289;4980.252962055648;4986.750662466935;5024.995000999815;4789.521047895252;4857;4857.125717370907;4878.487758785347;5051.646384753032;4979.228219625964;4986.177280748636;4987.0524600325825;4998.725070121178;4998.90002199954;4964.230544265644;4965.90068198634;4969.35398398206;4975.328330675385;5023.924641130386;4050.23045621331;4131.215069136854;4138.8551400700835;4139.068709540329;4266.189424009428;3625.148090198801;3673.9529234168135;3695.3533131702384;3702.129999450127;3707.2400157967554;4304.806283717177;4337.349397590387;4339.7396156230725;4342.392065110887;4372;4781.2111001685025;4881.219004959189;5049.368828896388;5063.215201643751;5129.487051294916;4182.142660754538;4209.936850947238;4227.915441691149;4265.402843601898;4388.824447022147;4529.13946350199;4557.1797076526545;4578.084383123389;4593.954060459353;4600.125976064604;4831.4685384608365;4834.661573689878;4838.419389673261;4845.53967373099;4892.3884514435695;4781.928271075867;4856.417229932431;4890.584300334369;5082.745862706924;5098.898022039464;4673.883152921068;4751.61987041029;4760.666753327234;4792.880177995578;4805.543473370024;4934.161192597196;4945.876353091202;4949.257611358325;4990.825321113889;4996.925046124238;4807.230843065093;5015.2978582997675;5016.423111342242;5016.824411145592;5071.492850715046;4748.358971538798;4750.239961606127;4781.808727650855;4807.4471435785335;4846.684965477232;4862.82980095695;4895.681780684244;4902.068606964665;4902.754862256944;4903.215485522299;4620.422447194101;4807.326974223682;4822.13201623697;4824.589909857701;4866.829660961849;4863.148948933852;4864.221724524059;4893.09477746618;4917.508249175054;4963.801447942186;4814.446338671098;4845.030993801324;4847.394075740533;4848.490908454703;4895.559399654048 03:19:14 INFO - 2015-12-08 03:19:14,707 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.1765337247208;531.1448567805833;532.3186321508471;564.5681053993693;564.7966731976488;26413.867930660344;26963.865180674093;32046;32761;32833.17917052075;38320.808395958054;38475.03812404684;38691.61308386915;38728.41907371385;38907.416388754194;6725.7309707611885;7692.7692169235015;7856.764297071097;7866.52800831949;7881.881771773428;6860.931390686104;6964.930350696479;6972.2330543640155;6975.128108986377;9911.454869982148;9905.752356191117;10010.749731256705;10019.59921603135;10022.198224142052;10022.799544009153;9917.454540000297;10020.198384129251;10024;10024.398536087785;10024.89975100247;6921.826954326132;7229.7469588564145;7232.1321441426835;7234.168070671887;10031.398116113056;34755.652443475745;34996.300073998376;35075.82462087673;35686.82156589226;35696.46455303173;2679.289988153141;2719.225020869043;2747.973678868332;3303.9834800826084;3450.0684815100035;25774.48451030969;25953;26025.869870650524;26052.869735651202;26677;3274.5743053403144;3347.933041339184;3370.25854312051;3427.246005878703;3449.896033269355;207336;210146;210649.9467502668;210972;211328;53698.73150634222;53796.462035379926;54062.45937540653;54122;54628.18057729137;58685;58958.70520647369;59133.70433147807;59236.7038164815;59263;12993.285369304778;13262.27057511846;13367.331633418291;13534.729305413837;13562.389692463863;10201.234907381977;10237.23220758446;10249.180065594735;10250.538725757358;10407.427591482541;18842.3405180818;18959.715604265948;19109.331173408864;19291.61416771657;19350.61298774045;7461.477696561297;7853.371730261565;7857.607119643995;7884.842303153905;7948.364130869517;833.8707500337457;845.9196376344238;880.1990188928045;882.3250213586612;893.78102364921;25990;26127.869360653454;26159.73840261573;26250.474990500465;26253.34366640849;860.6772460327377;916.6368087901636;973.8539219117189;1006.3509036671306;1105.535675016495;12446;14712.264386780618;15563.922180389025;16130.11284379347;16193.271302791403;309188;309982;310884;311248;316513;46612;46715.5328446718;46741;47128.764356178;47214.76392618015;1195.748892732536;1212.090931801149;1226.270369130366;1237.2576454127632;1242.490578862662;25672.229833105037;26474.205773826816;26492.602610960465;26909.192724218305;26937.191884243504;38553.614463855;39246.41130383104;39254.2149157021;39274;39300.606993930836;249644;252274;253126;253384;254079;23869.64195537103;24269;27130.1860944172;28227.858860705564;28936;31749.84125079452;31819.681803182597;32063.67936320607;43513.292515107096;44880.551194487634;31077.844610776803;31796.841015794773;32263;32607.510887337183;32681.836590816893;31883;31998.68001319957;36124.27751445009;38029.42955855609;38565.22869542649;32089.35821283608;37809.810950945066;38034;38827.417588735625;38893.80553097217;26974.730252698006;33034;34802.651973479944;34828;34872.47691284582;23068.769312306664;23750.168744094564;23778.881105594362;23815;23886.402839929142 03:19:14 INFO - 2015-12-08 03:19:14,708 DEBUG : BROWSER_OUTPUT: |2;jquery.html;282.92078218098925;283.24656413938925;285.58447458947234;290.2468095292716;290.5017894311256;12159.696007599814;12566.497340106385;15526.068435893854;15765.378541012788;16076.196190190487;11592.072634189266;13586.25275609841;14364.928175359135;15124.621884452894;15161.241937903116;4779.307000484928;4909.140900342443;4940.654154209206;6314.589551679149;6540.542162048659;4066.5120185577625;4157.833686652531;6407.871842563146;6438.163038804949;6468.353164683541;6554.147960765094;6567.507436942225;6583.5062370322175;6583.5062370322175;6593.406593406592;6407.743690252384;6603.207615086172;6603.999999999976;6606.966965165144;6610.570312929668;6125.111858780497;6285.43431091204;6295.0872123542285;6310.116583678288;6323.620582765049;21466.677999830015;21550.629430762605;21642.891785541127;22019.66970495444;22144;1833.2300433817695;2006.7591888973416;2017.314113201504;2053.1992522916075;2082.666773316262;13725.45098196071;13829.446822127104;13882.236476993761;13957.302134893316;14488.058276212012;1712.3578658003248;1817.391173956726;1843.2811203630595;1952.80471952805;1957.109515170594;58037.419625803625;63987.360126398606;66655;66684.3331566683;67121.328786712;15431.845681543266;15540.766888496682;15561.610959725871;15600.687986240438;15734.68530629381;23024;23068.19261325879;23198.3040508785;23271.534569308857;23315.417114572272;7972.920270797334;7991.8401631967035;8038.8794168087525;8094.554799486084;8322.334213262924;6614.867702646016;6673.599584024974;6691.598504089673;6743.629100399525;6745.156855393076;7534.208908064684;7554.131274903457;7560.017197764256;7602.239776022354;7604.467687261838;2570.7943364530793;2938.63268085613;2946.219251898249;3018.788684792087;3106.9223269418444;802.9638666260032;864.9913500865036;891.3270480786964;895.3553441522093;994.8706668133096;13099.2140471572;15385.461508847136;15421.460248891459;16570.420035298706;17100;823.972640137393;852.1819053708509;855.5636625321007;877.2981614708208;886.2865393358279;8563.95718021406;8635.654573816977;8734.86897696535;8814.086585438918;8861.379703420698;317246;317576;320007;320883;398235;66060;72757;72897;74270;74934.62532687302;986.8963758805365;1007.6876168387677;1017.4099022567042;1017.6285655735603;1040.552562398176;13820.516281930084;14353.784693229401;14356.282185890872;14390.856091439371;14397.208153551655;30769.230769230948;31264.531032034083;31322.21694457657;32258.516122257715;32343.676563234065;41992.79003604963;43234;44883;45140.774296129624;46595.76702116468;7839.7802154046385;8576.871346929925;8591.957040214758;8623.525706086226;8647.351448641502;14070.226137562533;14334.928325358724;14902.329395177027;14934.327955241823;16045.518634440985;12787.296698681661;13141.802872957105;13411.731765364833;13428.261445620194;13643.454261829416;12496;12707.428165732379;12994.805077924028;13337.133086349357;13673.79489307681;13339.333033348099;14305.356258968579;14369;14660.413583456542;14753.483628072965;8527.147285271423;8721.694740684046;8750.51872147038;9138.680146195116;9154.679586214717;13046.934765326112;13745.931270343584;13923.651908702364;13945;14226.430942762174 03:19:14 INFO - 2015-12-08 03:19:14,710 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1396.1204441202042;1602.7996500437446;1672.2224165762918;1687.1226961979771;1721.1996421663932;6013.909791353128;6676.365745254199;6850.999999999994;6898.724051037965;6952.304769523045;6900.896486552706;7078.327558881911;7085.89371159433;7086.57480551166;7090.893636595455;1997.5106099005764;2032.19728207358;2035.2876493227327;2035.928742494013;2036.0634108310196;2026.6959956006642;2054.9930534038363;2059.618970490464;2074.025208152166;2074.439901226668;2000.5498762778332;2004.4387571480008;2024.0790440349606;2035.053700029486;2035.389383185046;1996.4010796760986;2016.1632922337212;2027.4627223785708;2034.7863474335204;2035.053700029486;2019.2225992992658;2026.6453370660076;2070.9378718638463;2073.7718850926385;2074.2532688232222;7020.192677842062;7090.432765378758;7093.184283807376;7103.644817759143;7106.147262328554;4029.37544680575;4091.6931230157857;4094.1811637672286;4103.035786590149;4110.116324990141;2693.407450360937;2721.7142200068906;2737.9589306160424;2764.2536515141;2770.2381844992588;832.9167083291622;838.8573942429801;839.7480755773305;858.536390349217;861.814709837388;9177.898652161717;9195.40229885062;9214.999999999933;9217.585208665627;9224.53877306132;3634.2913131939017;3668.7798732075626;3724.8696295630066;3725.3108174987715;3728.0493474163914;7968.163342848918;7969.3226075784205;7973.401994850409;7975.481593696507;7986.081600616004;4062.207869465485;4066.044479547304;4066.512018557792;4070.8371665133654;4130.56629053951;3133.38898914714;3220.9677903221136;3651.5253017107607;3751.9062023449633;3776.0182352587976;3376.44288692363;3391.101358140095;3403.5235067090625;3425.4861770734587;3434.639362866913;1062.0919114157439;1070.1973519860105;1070.8072546941626;1076.8492411062457;1079.578964203961;1177.8527684039495;1180.5053078135384;1196.342011893455;1197.6407077876602;1209.4134344842744;6572.14562106923;6580.11168492257;6662.866742665216;6682.498812588978;6693;396.29855156373634;408.4118868828877;410.30043775362935;411.71797318836093;414.04975581041583;5094.847154585368;5150.922736158961;5156.767945442389;5158.200478925773;5161.716105614152;8526.232639062515;8534.274586660204;8670.479771213748;8751.868721969175;8774.824503509893;8697.91302086971;8711.0417854036;8760.211580957744;8772.868406973901;8806.383553151347;6773;6799.252082270947;6835.316468353125;6906.412954898889;6916.619585922823;6484.935150648622;6492.675366231575;6497;6497.252815926229;6506.869862602627;7627.733029343946;7722;7742.148363680103;7807.765767026998;7848.450608457353;7873.133955265031;8024.277814996678;8034.397420193626;8039.919600803917;8151.5924203790755;5153.0466863630345;5234.13636749932;5812.564057695774;6272.623642581277;6336.144620476177;6600.735970561123;6616.603003819786;6633.104530888461;6641.833954151185;6657.101291325609;6213.502919766317;6219.378062193744;6305;6310.085037669421;6329.588576742682;6148.292946311231;6178.783742568989;6196.504279657526;6276.184096067482;6299.244090709144;6099.969500152471;6129.724162412791;6141.416565426277;6142.539309551891;6163.753449861955;5820.1560773688425;5856.882862342644;5877.118432235199;5937.079752638348;5952.077427998667;5840.182374467493;5971.671558064349;6014.969925150346;6015.368386319374;6015.428534289235 03:19:14 INFO - 2015-12-08 03:19:14,711 DEBUG : BROWSER_OUTPUT: |4;prototype.html;246.92962505685878;250.85074380743458;251.4254927490684;256.86514579845567;262.56807551577646;5296.470352964701;5363;5395.757190926408;5407.864803379913;5425.6202065855405;5038.546530812227;5047.596192304616;5273.446288139748;5294.52349288564;5322.866928326794;4028.9194216115807;4029.879103626896;4038.899027524306;4047.575004624516;4054.736442131267;4008.2584721826556;4011.2980228460046;4020.1959608078355;4027.456293400383;4042.090529630824;3783.2622638585485;3852;3883.8834834954996;3939.231849789292;3956.090099277168;3947.6447119759073;3952.486176797027;3958.6437220650278;3960.920781584381;3963.8612648557305;3395.3548825723033;3397.3545026444895;3408.608010078823;3410.1474631342167;3431.3823511767873;5110.28456016158;5134.871628209325;5148.897022059576;5149.356330458692;5155.639105262633;4314.288142456491;4420.46954365475;4434;4583;4585.495595484494;5404.837854864321;5412.431694672042;5431.8098866539485;5431.972840135813;5568.248286481355;3632.963670363289;3698.7595806272507;3698.7965661888584;3741.6071312512067;3741.8774367689857;5837.766489340422;5874.765009399619;5876.294844618673;5877.647341159502;5880.529557635379;3596;3759.9848041028768;3780.4707340972286;3816.427535869642;3817.408301713239;3807.4098514730263;3807.562130354989;3811.7522361046445;3814.6948244140403;3816.904577385588;4405.823767049346;4413.823447062082;4416.227160246944;4470.731756094645;4499.347594598765;5571.052921003439;5604.187392828017;5610.663360198401;5612.691301978431;5614.85962850932;1318.2815365625756;1344.1800501693958;1344.7243315120377;1344.8789608935242;1346.8047133165637;858.9441686290371;863.119617989647;868.9913100869037;869.6651789061257;871.5729292646557;4805.27920811874;4850.296706977469;4854.878628034327;4861.683990540603;4869.293952376956;5703.258576385127;5707.086866101404;5729.083346664514;5775.740091695884;5784.942150578525;4889.682170658896;4903.705777653352;4911.336969509142;4913.361263035854;4916.729579873141;3036.6052413186144;3089.119600913729;3113.875444982221;3115.6417012043453;3118.6725393833776;5402;5459;5459.672419654833;5461.0716178249795;5465.262189604432;5917.911231331534;5920.822375328747;5927.703614819242;5928.762849486058;5939.732712027969;5350.6254562180275;5429.158480435539;5464.617476776667;5468.535174510212;5492.890142197213;5864.413558644102;5874.118882167709;5881.470667639933;5882.058870580858;5886.6173698709445;5720.656760594377;5735.139729040678;5736.885262294814;5737.311522617312;5743.167240749985;5425.240466334637;5546.862893106984;5551.472610102034;5559.749811258584;5561.749721262634;3738.457923601117;3757.210985693035;3759.981200093982;3762;3770.227103443842;5892.705364731661;5897.233359663216;5900.675462849413;5904.9704751475965;5907.350191478848;5671.064274394678;5673.092305231144;5678.630888992202;5680.77276908919;5682.3465301489205;5536.501714845684;5666.688332141772;5668.744906479136;5686.289213848269;5697.886042279214;5569.721513924206;5573.888522229451;5577.832665020056;5579.46995035471;5581.10702287632;5712.371639119777;5727.914081288867;5734.7132643368495;5734.885302293847;5735.3977832327;5440.891182176255;5590.720463976866;5593.8321850344555;5598.496135347676;5604.775808967595 03:19:14 INFO - 2015-12-08 03:19:14,711 DEBUG : BROWSER_OUTPUT: |5;yui.html;674.3290426026103;711.3135823929906;758.6017340896029;770.803445121494;783.1346362269695;10690.625828096017;11140.3315801052;11161.665150045512;11177.273477223975;11302.717432064203;11293.20947533673;12630.684232894182;12922;13064.869351306485;13142.277174755385;624.6377101281269;631.649434563817;778.4589710151461;793.7182300283403;794.408165916393;780.683823051665;789.7393860026177;796.0566728426804;796.3549524884833;796.8645330293864;826.6734639817269;832.1304237072274;833.154348336436;834.1908348901586;835.5696816139692;648.6011103171539;658.4633523678187;801.8676918308472;822.596927505518;830.9875351869697;609.5093449772976;614.8862460444832;617.8084793713963;619.5817822969477;620.1596836286811;11028.834567481494;11274.210805243636;11305.886941130566;11315.717107072307;11322.150838687132;10653.733656658567;11198.608048718337;11349.148813838996;11393.601223957121;11658.183927125105;9133.634654613808;9237.722868313962;9469.905300946972;9595.664151754725;9802.215822734164;3179.666135055832;3205.3812824523466;3214.4214041472524;3248.626407963091;3270.427675156838;39429;39916.40125398121;39959.8002009991;40074.79962600197;40109.79945100285;8959.686410975584;8985.236254918274;9011.098890110936;9075.954620226856;9085.636574537077;16039.67920641604;16065.678686426207;16066.116363600115;16070.75893861593;16106.516804495885;6467.2562655294305;6469.385408386196;6493.090967264587;6591;6706.798796036127;3631.963680363215;3640.7087433005295;3673.2653469306247;3674.8713795017047;3708.870189543353;2635.5387807133675;2695.7304269572887;2698.743619356158;2701.311165652746;2702.972970270272;469.28199854223095;473.9336492890998;475.7930300319303;477.7897725001058;481.37421352241944;442.47124686000564;541.2260467531468;581.764385423904;589.2457654202627;592.9940700593025;7524.586147761816;7557.395408367317;7605.695772169051;7627.466077374531;7681.692732290646;423.1769208888682;439.2795814863562;465.4159030416873;525.684589246449;525.6924699051021;3613.1509095362567;3669.376206044979;3685.3919103348185;3699.611540788232;3797.8290976906105;50049.74975125174;50540;50873.491265087614;51207.74396127996;51303.230451543255;44438.77780611076;45499.31751023737;47745;48419.757901210265;48477.75761121242;39240.215195696495;40708.389374159415;40727.389089163684;41772;41779.7911010443;7591.506552074097;7980.880286795818;8074.555899425588;8231.547264900488;8254.669813207645;30232.54651180278;30334.393312133194;30685.693143068285;30690.07929762111;30776;35764.284714305046;35914.46128308025;37310.6268937318;37739;37823.43264850974;9928.255380846322;10032.498375081072;10153.187744980532;10168.865461697063;10326.432046237229;11109.777804444027;11263.718407039889;11410.828837567276;11423.828642570203;11665.59170429031;9899.802003959736;10613.204009699459;10958.780824383308;10975.780484390427;11346.489407976496;9961.452120133463;10245.641402550875;10293.897061029294;10294.3823370598;10376.792464150523;10426.165906727596;10774.622888198875;10830.458477075957;10854.620088296871;11176.55293788272;9005.684801031932;9207.907920920705;9245.815083698153;9614.230861531201;9630.422174669542;9143.13140251675;9162;9277.536123193948;9323.86014209801;9336.859947100935 03:19:14 INFO - 2015-12-08 03:19:14,711 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:19:14 INFO - 2015-12-08 03:19:14,711 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:19:14 INFO - 2015-12-08 03:19:14,711 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,978 03:19:14 INFO - 2015-12-08 03:19:14,711 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: __startTimestamp1449573554701__endTimestamp 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4613.19 Median:4781.81 stddev:492.84 (10.3%) stddev-sans-first:468.07 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: Values: 2589.0 2657.2 2666.6 2682.9 2694.2 4384.4 4504.5 4611.7 4629.1 4630.6 4591.9 4607.8 4687.1 4716.4 4751.4 4081.5 4304.6 4310.4 4367.3 4395.3 4333.1 4356.6 4389.1 4399.2 4432.0 4129.1 4140.3 4227.3 4227.6 4233.9 4275.6 4275.9 4286.8 4310.1 4312.4 4222.0 4229.8 4253.1 4272.5 4284.1 4382.1 4499.9 4500.9 4520.7 4613.0 5018.5 5062.9 5065.8 5068.5 5070.7 5090.3 5093.5 5101.7 5102.2 5129.7 4404.1 4482.4 4510.8 4642.0 4694.0 5178.5 5183.1 5192.2 5220.9 5236.3 4968.8 4974.9 4980.3 4986.8 5025.0 4789.5 4857.0 4857.1 4878.5 5051.6 4979.2 4986.2 4987.1 4998.7 4998.9 4964.2 4965.9 4969.4 4975.3 5023.9 4050.2 4131.2 4138.9 4139.1 4266.2 3625.1 3674.0 3695.4 3702.1 3707.2 4304.8 4337.3 4339.7 4342.4 4372.0 4781.2 4881.2 5049.4 5063.2 5129.5 4182.1 4209.9 4227.9 4265.4 4388.8 4529.1 4557.2 4578.1 4594.0 4600.1 4831.5 4834.7 4838.4 4845.5 4892.4 4781.9 4856.4 4890.6 5082.7 5098.9 4673.9 4751.6 4760.7 4792.9 4805.5 4934.2 4945.9 4949.3 4990.8 4996.9 4807.2 5015.3 5016.4 5016.8 5071.5 4748.4 4750.2 4781.8 4807.4 4846.7 4862.8 4895.7 4902.1 4902.8 4903.2 4620.4 4807.3 4822.1 4824.6 4866.8 4863.1 4864.2 4893.1 4917.5 4963.8 4814.4 4845.0 4847.4 4848.5 4895.6 03:19:14 INFO - 2015-12-08 03:19:14,712 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,713 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41634.76 Median:32176.18 stddev:68338.36 (212.4%) stddev-sans-first:68460.36 03:19:14 INFO - 2015-12-08 03:19:14,713 DEBUG : BROWSER_OUTPUT: Values: 526.2 531.1 532.3 564.6 564.8 26413.9 26963.9 32046.0 32761.0 32833.2 38320.8 38475.0 38691.6 38728.4 38907.4 6725.7 7692.8 7856.8 7866.5 7881.9 6860.9 6964.9 6972.2 6975.1 9911.5 9905.8 10010.7 10019.6 10022.2 10022.8 9917.5 10020.2 10024.0 10024.4 10024.9 6921.8 7229.7 7232.1 7234.2 10031.4 34755.7 34996.3 35075.8 35686.8 35696.5 2679.3 2719.2 2748.0 3304.0 3450.1 25774.5 25953.0 26025.9 26052.9 26677.0 3274.6 3347.9 3370.3 3427.2 3449.9 207336.0 210146.0 210649.9 210972.0 211328.0 53698.7 53796.5 54062.5 54122.0 54628.2 58685.0 58958.7 59133.7 59236.7 59263.0 12993.3 13262.3 13367.3 13534.7 13562.4 10201.2 10237.2 10249.2 10250.5 10407.4 18842.3 18959.7 19109.3 19291.6 19350.6 7461.5 7853.4 7857.6 7884.8 7948.4 833.9 845.9 880.2 882.3 893.8 25990.0 26127.9 26159.7 26250.5 26253.3 860.7 916.6 973.9 1006.4 1105.5 12446.0 14712.3 15563.9 16130.1 16193.3 309188.0 309982.0 310884.0 311248.0 316513.0 46612.0 46715.5 46741.0 47128.8 47214.8 1195.7 1212.1 1226.3 1237.3 1242.5 25672.2 26474.2 26492.6 26909.2 26937.2 38553.6 39246.4 39254.2 39274.0 39300.6 249644.0 252274.0 253126.0 253384.0 254079.0 23869.6 24269.0 27130.2 28227.9 28936.0 31749.8 31819.7 32063.7 43513.3 44880.6 31077.8 31796.8 32263.0 32607.5 32681.8 31883.0 31998.7 36124.3 38029.4 38565.2 32089.4 37809.8 38034.0 38827.4 38893.8 26974.7 33034.0 34802.7 34828.0 34872.5 23068.8 23750.2 23778.9 23815.0 23886.4 03:19:14 INFO - 2015-12-08 03:19:14,713 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,713 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23276.45 Median:31293.37 stddev:55384.54 (177.0%) stddev-sans-first:55513.00 03:19:14 INFO - 2015-12-08 03:19:14,714 DEBUG : BROWSER_OUTPUT: Values: 282.9 283.2 285.6 290.2 290.5 12159.7 12566.5 15526.1 15765.4 16076.2 11592.1 13586.3 14364.9 15124.6 15161.2 4779.3 4909.1 4940.7 6314.6 6540.5 4066.5 4157.8 6407.9 6438.2 6468.4 6554.1 6567.5 6583.5 6583.5 6593.4 6407.7 6603.2 6604.0 6607.0 6610.6 6125.1 6285.4 6295.1 6310.1 6323.6 21466.7 21550.6 21642.9 22019.7 22144.0 1833.2 2006.8 2017.3 2053.2 2082.7 13725.5 13829.4 13882.2 13957.3 14488.1 1712.4 1817.4 1843.3 1952.8 1957.1 58037.4 63987.4 66655.0 66684.3 67121.3 15431.8 15540.8 15561.6 15600.7 15734.7 23024.0 23068.2 23198.3 23271.5 23315.4 7972.9 7991.8 8038.9 8094.6 8322.3 6614.9 6673.6 6691.6 6743.6 6745.2 7534.2 7554.1 7560.0 7602.2 7604.5 2570.8 2938.6 2946.2 3018.8 3106.9 803.0 865.0 891.3 895.4 994.9 13099.2 15385.5 15421.5 16570.4 17100.0 824.0 852.2 855.6 877.3 886.3 8564.0 8635.7 8734.9 8814.1 8861.4 317246.0 317576.0 320007.0 320883.0 398235.0 66060.0 72757.0 72897.0 74270.0 74934.6 986.9 1007.7 1017.4 1017.6 1040.6 13820.5 14353.8 14356.3 14390.9 14397.2 30769.2 31264.5 31322.2 32258.5 32343.7 41992.8 43234.0 44883.0 45140.8 46595.8 7839.8 8576.9 8592.0 8623.5 8647.4 14070.2 14334.9 14902.3 14934.3 16045.5 12787.3 13141.8 13411.7 13428.3 13643.5 12496.0 12707.4 12994.8 13337.1 13673.8 13339.3 14305.4 14369.0 14660.4 14753.5 8527.1 8721.7 8750.5 9138.7 9154.7 13046.9 13745.9 13923.7 13945.0 14226.4 03:19:14 INFO - 2015-12-08 03:19:14,714 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,714 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4888.87 Median:6014.44 stddev:2571.35 (42.8%) stddev-sans-first:2565.17 03:19:14 INFO - 2015-12-08 03:19:14,714 DEBUG : BROWSER_OUTPUT: Values: 1396.1 1602.8 1672.2 1687.1 1721.2 6013.9 6676.4 6851.0 6898.7 6952.3 6900.9 7078.3 7085.9 7086.6 7090.9 1997.5 2032.2 2035.3 2035.9 2036.1 2026.7 2055.0 2059.6 2074.0 2074.4 2000.5 2004.4 2024.1 2035.1 2035.4 1996.4 2016.2 2027.5 2034.8 2035.1 2019.2 2026.6 2070.9 2073.8 2074.3 7020.2 7090.4 7093.2 7103.6 7106.1 4029.4 4091.7 4094.2 4103.0 4110.1 2693.4 2721.7 2738.0 2764.3 2770.2 832.9 838.9 839.7 858.5 861.8 9177.9 9195.4 9215.0 9217.6 9224.5 3634.3 3668.8 3724.9 3725.3 3728.0 7968.2 7969.3 7973.4 7975.5 7986.1 4062.2 4066.0 4066.5 4070.8 4130.6 3133.4 3221.0 3651.5 3751.9 3776.0 3376.4 3391.1 3403.5 3425.5 3434.6 1062.1 1070.2 1070.8 1076.8 1079.6 1177.9 1180.5 1196.3 1197.6 1209.4 6572.1 6580.1 6662.9 6682.5 6693.0 396.3 408.4 410.3 411.7 414.0 5094.8 5150.9 5156.8 5158.2 5161.7 8526.2 8534.3 8670.5 8751.9 8774.8 8697.9 8711.0 8760.2 8772.9 8806.4 6773.0 6799.3 6835.3 6906.4 6916.6 6484.9 6492.7 6497.0 6497.3 6506.9 7627.7 7722.0 7742.1 7807.8 7848.5 7873.1 8024.3 8034.4 8039.9 8151.6 5153.0 5234.1 5812.6 6272.6 6336.1 6600.7 6616.6 6633.1 6641.8 6657.1 6213.5 6219.4 6305.0 6310.1 6329.6 6148.3 6178.8 6196.5 6276.2 6299.2 6100.0 6129.7 6141.4 6142.5 6163.8 5820.2 5856.9 5877.1 5937.1 5952.1 5840.2 5971.7 6015.0 6015.4 6015.4 03:19:14 INFO - 2015-12-08 03:19:14,714 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,714 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4583.02 Median:5336.75 stddev:1416.22 (26.5%) stddev-sans-first:1382.29 03:19:14 INFO - 2015-12-08 03:19:14,715 DEBUG : BROWSER_OUTPUT: Values: 246.9 250.9 251.4 256.9 262.6 5296.5 5363.0 5395.8 5407.9 5425.6 5038.5 5047.6 5273.4 5294.5 5322.9 4028.9 4029.9 4038.9 4047.6 4054.7 4008.3 4011.3 4020.2 4027.5 4042.1 3783.3 3852.0 3883.9 3939.2 3956.1 3947.6 3952.5 3958.6 3960.9 3963.9 3395.4 3397.4 3408.6 3410.1 3431.4 5110.3 5134.9 5148.9 5149.4 5155.6 4314.3 4420.5 4434.0 4583.0 4585.5 5404.8 5412.4 5431.8 5432.0 5568.2 3633.0 3698.8 3698.8 3741.6 3741.9 5837.8 5874.8 5876.3 5877.6 5880.5 3596.0 3760.0 3780.5 3816.4 3817.4 3807.4 3807.6 3811.8 3814.7 3816.9 4405.8 4413.8 4416.2 4470.7 4499.3 5571.1 5604.2 5610.7 5612.7 5614.9 1318.3 1344.2 1344.7 1344.9 1346.8 858.9 863.1 869.0 869.7 871.6 4805.3 4850.3 4854.9 4861.7 4869.3 5703.3 5707.1 5729.1 5775.7 5784.9 4889.7 4903.7 4911.3 4913.4 4916.7 3036.6 3089.1 3113.9 3115.6 3118.7 5402.0 5459.0 5459.7 5461.1 5465.3 5917.9 5920.8 5927.7 5928.8 5939.7 5350.6 5429.2 5464.6 5468.5 5492.9 5864.4 5874.1 5881.5 5882.1 5886.6 5720.7 5735.1 5736.9 5737.3 5743.2 5425.2 5546.9 5551.5 5559.7 5561.7 3738.5 3757.2 3760.0 3762.0 3770.2 5892.7 5897.2 5900.7 5905.0 5907.4 5671.1 5673.1 5678.6 5680.8 5682.3 5536.5 5666.7 5668.7 5686.3 5697.9 5569.7 5573.9 5577.8 5579.5 5581.1 5712.4 5727.9 5734.7 5734.9 5735.4 5440.9 5590.7 5593.8 5598.5 5604.8 03:19:14 INFO - 2015-12-08 03:19:14,715 DEBUG : BROWSER_OUTPUT: 03:19:14 INFO - 2015-12-08 03:19:14,715 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12220.73 Median:44969.05 stddev:13869.09 (30.8%) stddev-sans-first:13880.89 03:19:14 INFO - 2015-12-08 03:19:14,715 DEBUG : BROWSER_OUTPUT: Values: 674.3 711.3 758.6 770.8 783.1 10690.6 11140.3 11161.7 11177.3 11302.7 11293.2 12630.7 12922.0 13064.9 13142.3 624.6 631.6 778.5 793.7 794.4 780.7 789.7 796.1 796.4 796.9 826.7 832.1 833.2 834.2 835.6 648.6 658.5 801.9 822.6 831.0 609.5 614.9 617.8 619.6 620.2 11028.8 11274.2 11305.9 11315.7 11322.2 10653.7 11198.6 11349.1 11393.6 11658.2 9133.6 9237.7 9469.9 9595.7 9802.2 3179.7 3205.4 3214.4 3248.6 3270.4 39429.0 39916.4 39959.8 40074.8 40109.8 8959.7 8985.2 9011.1 9076.0 9085.6 16039.7 16065.7 16066.1 16070.8 16106.5 6467.3 6469.4 6493.1 6591.0 6706.8 3632.0 3640.7 3673.3 3674.9 3708.9 2635.5 2695.7 2698.7 2701.3 2703.0 469.3 473.9 475.8 477.8 481.4 442.5 541.2 581.8 589.2 593.0 7524.6 7557.4 7605.7 7627.5 7681.7 423.2 439.3 465.4 525.7 525.7 3613.2 3669.4 3685.4 3699.6 3797.8 50049.7 50540.0 50873.5 51207.7 51303.2 44438.8 45499.3 47745.0 48419.8 48477.8 39240.2 40708.4 40727.4 41772.0 41779.8 7591.5 7980.9 8074.6 8231.5 8254.7 30232.5 30334.4 30685.7 30690.1 30776.0 35764.3 35914.5 37310.6 37739.0 37823.4 9928.3 10032.5 10153.2 10168.9 10326.4 11109.8 11263.7 11410.8 11423.8 11665.6 9899.8 10613.2 10958.8 10975.8 11346.5 9961.5 10245.6 10293.9 10294.4 10376.8 10426.2 10774.6 10830.5 10854.6 11176.6 9005.7 9207.9 9245.8 9614.2 9630.4 9143.1 9162.0 9277.5 9323.9 9336.9 03:19:14 INFO - 2015-12-08 03:19:14,715 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:19:14 INFO - 2015-12-08 03:19:14,715 DEBUG : BROWSER_OUTPUT: 03:19:15 INFO - 2015-12-08 03:19:15,477 INFO : Browser exited with error code: 0 03:19:15 INFO - 2015-12-08 03:19:15,496 INFO : Completed test dromaeo_css (00:18:40) 03:19:15 INFO - 2015-12-08 03:19:15,496 INFO : Starting test kraken 03:19:15 INFO - 2015-12-08 03:19:15,496 DEBUG : operating with platform_type : linux_ 03:19:15 INFO - 2015-12-08 03:19:15,496 INFO : Initialising browser for kraken test... 03:19:15 INFO - 2015-12-08 03:19:15,502 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TNYaT/profile http://localhost:43448/getInfo.html 03:19:19 INFO - 2015-12-08 03:19:19,449 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:19:19 INFO - 2015-12-08 03:19:19,449 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:19:19 INFO - 2015-12-08 03:19:19,449 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:19:19 INFO - 2015-12-08 03:19:19,449 DEBUG : BROWSER_OUTPUT: __metrics 03:19:19 INFO - 2015-12-08 03:19:19,525 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:19:19 INFO - 2015-12-08 03:19:19,581 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] 03:19:20 INFO - 2015-12-08 03:19:20,721 INFO : Browser initialized. 03:19:20 INFO - 2015-12-08 03:19:20,722 INFO : Running cycle 1/1 for kraken test... 03:19:20 INFO - 2015-12-08 03:19:20,722 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5TNYaT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:19:32 INFO - 2015-12-08 03:19:32,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 142446592 03:19:32 INFO - 2015-12-08 03:19:32,781 DEBUG : BROWSER_OUTPUT: 03:19:35 INFO - 2015-12-08 03:19:35,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43448/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:35 INFO - 2015-12-08 03:19:35,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 177750016 03:19:35 INFO - 2015-12-08 03:19:35,990 DEBUG : BROWSER_OUTPUT: 03:19:38 INFO - 2015-12-08 03:19:38,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43448/tests/kraken/driver.html?testName=audio-dft) 03:19:39 INFO - 2015-12-08 03:19:39,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 167768064 03:19:39 INFO - 2015-12-08 03:19:39,316 DEBUG : BROWSER_OUTPUT: 03:19:42 INFO - 2015-12-08 03:19:42,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43448/tests/kraken/driver.html?testName=audio-fft) 03:19:42 INFO - 2015-12-08 03:19:42,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 153899008 03:19:42 INFO - 2015-12-08 03:19:42,934 DEBUG : BROWSER_OUTPUT: 03:19:44 INFO - 2015-12-08 03:19:44,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43448/tests/kraken/driver.html?testName=audio-oscillator) 03:19:45 INFO - 2015-12-08 03:19:45,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 157306880 03:19:45 INFO - 2015-12-08 03:19:45,556 DEBUG : BROWSER_OUTPUT: 03:19:47 INFO - 2015-12-08 03:19:47,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:48 INFO - 2015-12-08 03:19:48,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 156979200 03:19:48 INFO - 2015-12-08 03:19:48,367 DEBUG : BROWSER_OUTPUT: 03:19:51 INFO - 2015-12-08 03:19:51,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43448/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:51 INFO - 2015-12-08 03:19:51,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 158466048 03:19:51 INFO - 2015-12-08 03:19:51,928 DEBUG : BROWSER_OUTPUT: 03:19:55 INFO - 2015-12-08 03:19:55,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43448/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:55 INFO - 2015-12-08 03:19:55,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 157818880 03:19:55 INFO - 2015-12-08 03:19:55,857 DEBUG : BROWSER_OUTPUT: 03:19:58 INFO - 2015-12-08 03:19:58,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43448/tests/kraken/driver.html?testName=json-parse-financial) 03:19:59 INFO - 2015-12-08 03:19:59,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 159133696 03:19:59 INFO - 2015-12-08 03:19:59,322 DEBUG : BROWSER_OUTPUT: 03:20:01 INFO - 2015-12-08 03:20:01,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:01 INFO - 2015-12-08 03:20:01,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 169078784 03:20:01 INFO - 2015-12-08 03:20:01,703 DEBUG : BROWSER_OUTPUT: 03:20:03 INFO - 2015-12-08 03:20:03,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:04 INFO - 2015-12-08 03:20:04,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 167612416 03:20:04 INFO - 2015-12-08 03:20:04,196 DEBUG : BROWSER_OUTPUT: 03:20:06 INFO - 2015-12-08 03:20:06,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:07 INFO - 2015-12-08 03:20:07,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 175214592 03:20:07 INFO - 2015-12-08 03:20:07,253 DEBUG : BROWSER_OUTPUT: 03:20:09 INFO - 2015-12-08 03:20:09,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:10 INFO - 2015-12-08 03:20:10,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 183459840 03:20:10 INFO - 2015-12-08 03:20:10,375 DEBUG : BROWSER_OUTPUT: 03:20:12 INFO - 2015-12-08 03:20:12,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:13 INFO - 2015-12-08 03:20:13,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 182091776 03:20:13 INFO - 2015-12-08 03:20:13,527 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43448/tests/kraken/driver.html?testName=ai-astar) 03:20:15 INFO - 2015-12-08 03:20:15,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 240758784 03:20:15 INFO - 2015-12-08 03:20:15,551 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,551 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:20:15 INFO - 2015-12-08 03:20:15,551 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:20:15 INFO - 2015-12-08 03:20:15,551 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:20:15 INFO - 2015-12-08 03:20:15,551 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:20:15 INFO - 2015-12-08 03:20:15,551 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;112;113;112;102;112;111;118 03:20:15 INFO - 2015-12-08 03:20:15,552 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;152;169;130;162;156;139;172;131 03:20:15 INFO - 2015-12-08 03:20:15,552 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;164;161;164;168;160;161;161 03:20:15 INFO - 2015-12-08 03:20:15,552 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;83;93;71;72;71;114;89;72 03:20:15 INFO - 2015-12-08 03:20:15,552 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;127;94;94;94;135;96;95;137 03:20:15 INFO - 2015-12-08 03:20:15,552 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;110;110;111;110;109 03:20:15 INFO - 2015-12-08 03:20:15,552 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;147;147;146;147;146;147;145 03:20:15 INFO - 2015-12-08 03:20:15,553 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;96;95;95;95;95 03:20:15 INFO - 2015-12-08 03:20:15,553 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;80;74;73;74;73;73;73;73;76;72 03:20:15 INFO - 2015-12-08 03:20:15,553 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;68;68;69;68;69 03:20:15 INFO - 2015-12-08 03:20:15,553 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;85;85;86;85;84;86;86;92 03:20:15 INFO - 2015-12-08 03:20:15,553 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;122;131;116;130;121;129;121;121;126 03:20:15 INFO - 2015-12-08 03:20:15,553 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;146;149;146;148;134;150;147;146;136 03:20:15 INFO - 2015-12-08 03:20:15,553 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;71;69;70;69;71;69;68;68 03:20:15 INFO - 2015-12-08 03:20:15,554 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:20:15 INFO - 2015-12-08 03:20:15,554 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:20:15 INFO - 2015-12-08 03:20:15,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 03:20:15 INFO - 2015-12-08 03:20:15,554 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:20:15 INFO - 2015-12-08 03:20:15,554 DEBUG : BROWSER_OUTPUT: __startTimestamp1449573615550__endTimestamp 03:20:15 INFO - 2015-12-08 03:20:15,554 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:4.25 (3.8%) stddev-sans-first:4.51 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 112.0 113.0 112.0 102.0 112.0 111.0 118.0 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:155.00 stddev:15.81 (10.2%) stddev-sans-first:16.69 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 152.0 169.0 130.0 162.0 156.0 139.0 172.0 131.0 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,562 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:161.50 stddev:2.41 (1.5%) stddev-sans-first:2.55 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 164.0 161.0 164.0 168.0 160.0 161.0 161.0 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:73.00 stddev:14.11 (19.3%) stddev-sans-first:14.58 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 83.0 93.0 71.0 72.0 71.0 114.0 89.0 72.0 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.00 stddev:18.81 (20.0%) stddev-sans-first:19.44 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 127.0 94.0 94.0 94.0 135.0 96.0 95.0 137.0 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 110.0 110.0 111.0 110.0 109.0 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 145.0 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:20:15 INFO - 2015-12-08 03:20:15,563 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:73.50 stddev:2.33 (3.2%) stddev-sans-first:1.13 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: Values: 80.0 74.0 73.0 74.0 73.0 73.0 73.0 73.0 76.0 72.0 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 69.0 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:2.21 (2.6%) stddev-sans-first:2.35 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 85.0 85.0 86.0 85.0 84.0 86.0 86.0 92.0 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.50 stddev:4.90 (3.9%) stddev-sans-first:5.11 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 131.0 116.0 130.0 121.0 129.0 121.0 121.0 126.0 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:146.50 stddev:5.75 (3.9%) stddev-sans-first:5.68 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: Values: 138.0 146.0 149.0 146.0 148.0 134.0 150.0 147.0 146.0 136.0 03:20:15 INFO - 2015-12-08 03:20:15,564 DEBUG : BROWSER_OUTPUT: 03:20:15 INFO - 2015-12-08 03:20:15,565 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.07 (1.5%) stddev-sans-first:1.13 03:20:15 INFO - 2015-12-08 03:20:15,565 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 69.0 70.0 69.0 71.0 69.0 68.0 68.0 03:20:15 INFO - 2015-12-08 03:20:15,565 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:20:15 INFO - 2015-12-08 03:20:15,565 DEBUG : BROWSER_OUTPUT: 03:20:16 INFO - 2015-12-08 03:20:16,486 INFO : Browser exited with error code: 0 03:20:16 INFO - 2015-12-08 03:20:16,533 INFO : Completed test kraken (00:01:01) 03:20:16 INFO - 2015-12-08 03:20:16,533 INFO : Starting test v8_7 03:20:16 INFO - 2015-12-08 03:20:16,533 DEBUG : operating with platform_type : linux_ 03:20:16 INFO - 2015-12-08 03:20:16,533 INFO : Initialising browser for v8_7 test... 03:20:16 INFO - 2015-12-08 03:20:16,539 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeKI_E2/profile http://localhost:43448/getInfo.html 03:20:20 INFO - 2015-12-08 03:20:20,433 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:20:20 INFO - 2015-12-08 03:20:20,433 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:20:20 INFO - 2015-12-08 03:20:20,433 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:20:20 INFO - 2015-12-08 03:20:20,433 DEBUG : BROWSER_OUTPUT: __metrics 03:20:20 INFO - 2015-12-08 03:20:20,562 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:20:20 INFO - 2015-12-08 03:20:20,624 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] 03:20:21 INFO - 2015-12-08 03:20:21,658 INFO : Browser initialized. 03:20:21 INFO - 2015-12-08 03:20:21,659 INFO : Running cycle 1/1 for v8_7 test... 03:20:21 INFO - 2015-12-08 03:20:21,659 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeKI_E2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:20:33 INFO - 2015-12-08 03:20:33,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 143323136 03:20:33 INFO - 2015-12-08 03:20:33,653 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43448/tests/v8_7/run.html (next: http://localhost:43448/tests/v8_7/run.html) 03:20:55 INFO - 2015-12-08 03:20:55,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 443326464 03:20:55 INFO - 2015-12-08 03:20:55,338 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,338 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:20:55 INFO - 2015-12-08 03:20:55,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:20:55 INFO - 2015-12-08 03:20:55,339 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:20:55 INFO - 2015-12-08 03:20:55,339 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:20:55 INFO - 2015-12-08 03:20:55,339 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 03:20:55 INFO - 2015-12-08 03:20:55,339 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.87360594795538 03:20:55 INFO - 2015-12-08 03:20:55,339 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 03:20:55 INFO - 2015-12-08 03:20:55,340 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 03:20:55 INFO - 2015-12-08 03:20:55,340 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1994.0239043824702 03:20:55 INFO - 2015-12-08 03:20:55,340 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 03:20:55 INFO - 2015-12-08 03:20:55,340 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 03:20:55 INFO - 2015-12-08 03:20:55,341 DEBUG : BROWSER_OUTPUT: |7;RegExp;27405.405405405407 03:20:55 INFO - 2015-12-08 03:20:55,341 DEBUG : BROWSER_OUTPUT: |8;Splay;605.3268765133172 03:20:55 INFO - 2015-12-08 03:20:55,341 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 03:20:55 INFO - 2015-12-08 03:20:55,341 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:20:55 INFO - 2015-12-08 03:20:55,341 DEBUG : BROWSER_OUTPUT: __startTimestamp1449573655337__endTimestamp 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: Values: 165.8 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.87 Median:185.87 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,342 DEBUG : BROWSER_OUTPUT: Values: 185.9 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: Values: 278.6 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: Values: 5154.6 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,343 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: Values: 1994.0 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: Values: 796.2 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: Values: 11964.3 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27405.41 Median:27405.41 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: Values: 27405.4 03:20:55 INFO - 2015-12-08 03:20:55,344 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,345 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.33 Median:605.33 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,345 DEBUG : BROWSER_OUTPUT: Values: 605.3 03:20:55 INFO - 2015-12-08 03:20:55,345 DEBUG : BROWSER_OUTPUT: 03:20:55 INFO - 2015-12-08 03:20:55,345 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 03:20:55 INFO - 2015-12-08 03:20:55,345 DEBUG : BROWSER_OUTPUT: Values: 4822.1 03:20:55 INFO - 2015-12-08 03:20:55,345 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:20:55 INFO - 2015-12-08 03:20:55,345 DEBUG : BROWSER_OUTPUT: 03:20:56 INFO - 2015-12-08 03:20:56,202 INFO : Browser exited with error code: 0 03:20:56 INFO - 2015-12-08 03:20:56,218 INFO : Completed test v8_7 (00:00:39) 03:20:56 INFO - 2015-12-08 03:20:56,347 INFO : Completed test suite (00:20:21) 03:20:56 INFO - 2015-12-08 03:20:56,347 DEBUG : Working with test: dromaeo_css 03:20:56 INFO - 2015-12-08 03:20:56,347 DEBUG : Generating results file: dromaeo_css 03:20:56 INFO - 2015-12-08 03:20:56,348 DEBUG : Working with test: kraken 03:20:56 INFO - 2015-12-08 03:20:56,349 DEBUG : Generating results file: kraken 03:20:56 INFO - 2015-12-08 03:20:56,349 INFO : javascript benchmark 03:20:56 INFO - 2015-12-08 03:20:56,349 DEBUG : Working with test: v8_7 03:20:56 INFO - 2015-12-08 03:20:56,349 DEBUG : Generating results file: v8_7 03:20:56 INFO - 2015-12-08 03:20:56,349 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:56 INFO - 2015-12-08 03:20:56,519 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 03:20:56 INFO - 2015-12-08 03:20:56,519 DEBUG : process_Request line: dromaeo_css 6331.12 graph.html#tests=[[72,132,35]] 03:20:56 INFO - 2015-12-08 03:20:56,519 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:56 INFO - 2015-12-08 03:20:56,549 DEBUG : process_Request line: kraken 1527.80 graph.html#tests=[[232,132,35]] 03:20:56 INFO - 2015-12-08 03:20:56,550 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:20:56 INFO - 2015-12-08 03:20:56,585 DEBUG : process_Request line: v8_7 19800.23 graph.html#tests=[[230,132,35]] 03:20:56 INFO - 2015-12-08 03:20:56,587 INFO : javascript benchmark 03:20:56 INFO - 2015-12-08 03:20:56,590 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2588.961165582516, 2657.189557185059, 2666.6133410655443, 2682.886602060144, 2694.178275625934, 4384.364267181257, 4504.527024662412, 4611.723296602202, 4629.074185162964, 4630.560096790808, 4591.862244132682, 4607.79264933078, 4687.132880417125, 4716.434027916646, 4751.358566593509, 4081.5132034611042, 4304.634106100977, 4310.3534469829465, 4367.2575662137515, 4395.340698895159, 4333.068390296085, 4356.586124318184, 4389.100234451929, 4399.1641588098155, 4432.047109871377, 4129.050318426749, 4140.275451795938, 4227.281362168439, 4227.556106608792, 4233.936490952638, 4275.636570891478, 4275.87172384829, 4286.849960251377, 4310.094880075188, 4312.417823593806, 4222.0, 4229.788510574459, 4253.149370125956, 4272.46594175728, 4284.121755040209, 4382.05785756064, 4499.932501012488, 4500.8649740507835, 4520.706154099973, 4612.953870461286, 5018.548330650259, 5062.898742025176, 5065.848024559269, 5068.467810879878, 5070.69575825448, 5090.299702242891, 5093.541581257705, 5101.693898366073, 5102.234664800272, 5129.666571672867, 4404.14119246747, 4482.372467854503, 4510.774461276923, 4641.976790116028, 4693.9530604693855, 5178.482151784791, 5183.118869792069, 5192.221166825007, 5220.895582088337, 5236.293100431393, 4968.751562421937, 4974.925376119289, 4980.252962055648, 4986.750662466935, 5024.995000999815, 4789.521047895252, 4857.0, 4857.125717370907, 4878.487758785347, 5051.646384753032, 4979.228219625964, 4986.177280748636, 4987.0524600325825, 4998.725070121178, 4998.90002199954, 4964.230544265644, 4965.90068198634, 4969.35398398206, 4975.328330675385, 5023.924641130386, 4050.23045621331, 4131.215069136854, 4138.8551400700835, 4139.068709540329, 4266.189424009428, 3625.148090198801, 3673.9529234168135, 3695.3533131702384, 3702.129999450127, 3707.2400157967554, 4304.806283717177, 4337.349397590387, 4339.7396156230725, 4342.392065110887, 4372.0, 4781.2111001685025, 4881.219004959189, 5049.368828896388, 5063.215201643751, 5129.487051294916, 4182.142660754538, 4209.936850947238, 4227.915441691149, 4265.402843601898, 4388.824447022147, 4529.13946350199, 4557.1797076526545, 4578.084383123389, 4593.954060459353, 4600.125976064604, 4831.4685384608365, 4834.661573689878, 4838.419389673261, 4845.53967373099, 4892.3884514435695, 4781.928271075867, 4856.417229932431, 4890.584300334369, 5082.745862706924, 5098.898022039464, 4673.883152921068, 4751.61987041029, 4760.666753327234, 4792.880177995578, 4805.543473370024, 4934.161192597196, 4945.876353091202, 4949.257611358325, 4990.825321113889, 4996.925046124238, 4807.230843065093, 5015.2978582997675, 5016.423111342242, 5016.824411145592, 5071.492850715046, 4748.358971538798, 4750.239961606127, 4781.808727650855, 4807.4471435785335, 4846.684965477232, 4862.82980095695, 4895.681780684244, 4902.068606964665, 4902.754862256944, 4903.215485522299, 4620.422447194101, 4807.326974223682, 4822.13201623697, 4824.589909857701, 4866.829660961849, 4863.148948933852, 4864.221724524059, 4893.09477746618, 4917.508249175054, 4963.801447942186, 4814.446338671098, 4845.030993801324, 4847.394075740533, 4848.490908454703, 4895.559399654048], "unit": "ms", "name": "dojo.html", "value": 4582.015961233074}, {"lowerIsBetter": false, "replicates": [526.1765337247208, 531.1448567805833, 532.3186321508471, 564.5681053993693, 564.7966731976488, 26413.867930660344, 26963.865180674093, 32046.0, 32761.0, 32833.17917052075, 38320.808395958054, 38475.03812404684, 38691.61308386915, 38728.41907371385, 38907.416388754194, 6725.7309707611885, 7692.7692169235015, 7856.764297071097, 7866.52800831949, 7881.881771773428, 6860.931390686104, 6964.930350696479, 6972.2330543640155, 6975.128108986377, 9911.454869982148, 9905.752356191117, 10010.749731256705, 10019.59921603135, 10022.198224142052, 10022.799544009153, 9917.454540000297, 10020.198384129251, 10024.0, 10024.398536087785, 10024.89975100247, 6921.826954326132, 7229.7469588564145, 7232.1321441426835, 7234.168070671887, 10031.398116113056, 34755.652443475745, 34996.300073998376, 35075.82462087673, 35686.82156589226, 35696.46455303173, 2679.289988153141, 2719.225020869043, 2747.973678868332, 3303.9834800826084, 3450.0684815100035, 25774.48451030969, 25953.0, 26025.869870650524, 26052.869735651202, 26677.0, 3274.5743053403144, 3347.933041339184, 3370.25854312051, 3427.246005878703, 3449.896033269355, 207336.0, 210146.0, 210649.9467502668, 210972.0, 211328.0, 53698.73150634222, 53796.462035379926, 54062.45937540653, 54122.0, 54628.18057729137, 58685.0, 58958.70520647369, 59133.70433147807, 59236.7038164815, 59263.0, 12993.285369304778, 13262.27057511846, 13367.331633418291, 13534.729305413837, 13562.389692463863, 10201.234907381977, 10237.23220758446, 10249.180065594735, 10250.538725757358, 10407.427591482541, 18842.3405180818, 18959.715604265948, 19109.331173408864, 19291.61416771657, 19350.61298774045, 7461.477696561297, 7853.371730261565, 7857.607119643995, 7884.842303153905, 7948.364130869517, 833.8707500337457, 845.9196376344238, 880.1990188928045, 882.3250213586612, 893.78102364921, 25990.0, 26127.869360653454, 26159.73840261573, 26250.474990500465, 26253.34366640849, 860.6772460327377, 916.6368087901636, 973.8539219117189, 1006.3509036671306, 1105.535675016495, 12446.0, 14712.264386780618, 15563.922180389025, 16130.11284379347, 16193.271302791403, 309188.0, 309982.0, 310884.0, 311248.0, 316513.0, 46612.0, 46715.5328446718, 46741.0, 47128.764356178, 47214.76392618015, 1195.748892732536, 1212.090931801149, 1226.270369130366, 1237.2576454127632, 1242.490578862662, 25672.229833105037, 26474.205773826816, 26492.602610960465, 26909.192724218305, 26937.191884243504, 38553.614463855, 39246.41130383104, 39254.2149157021, 39274.0, 39300.606993930836, 249644.0, 252274.0, 253126.0, 253384.0, 254079.0, 23869.64195537103, 24269.0, 27130.1860944172, 28227.858860705564, 28936.0, 31749.84125079452, 31819.681803182597, 32063.67936320607, 43513.292515107096, 44880.551194487634, 31077.844610776803, 31796.841015794773, 32263.0, 32607.510887337183, 32681.836590816893, 31883.0, 31998.68001319957, 36124.27751445009, 38029.42955855609, 38565.22869542649, 32089.35821283608, 37809.810950945066, 38034.0, 38827.417588735625, 38893.80553097217, 26974.730252698006, 33034.0, 34802.651973479944, 34828.0, 34872.47691284582, 23068.769312306664, 23750.168744094564, 23778.881105594362, 23815.0, 23886.402839929142], "unit": "ms", "name": "ext.html", "value": 16947.44304315845}, {"lowerIsBetter": false, "replicates": [282.92078218098925, 283.24656413938925, 285.58447458947234, 290.2468095292716, 290.5017894311256, 12159.696007599814, 12566.497340106385, 15526.068435893854, 15765.378541012788, 16076.196190190487, 11592.072634189266, 13586.25275609841, 14364.928175359135, 15124.621884452894, 15161.241937903116, 4779.307000484928, 4909.140900342443, 4940.654154209206, 6314.589551679149, 6540.542162048659, 4066.5120185577625, 4157.833686652531, 6407.871842563146, 6438.163038804949, 6468.353164683541, 6554.147960765094, 6567.507436942225, 6583.5062370322175, 6583.5062370322175, 6593.406593406592, 6407.743690252384, 6603.207615086172, 6603.999999999976, 6606.966965165144, 6610.570312929668, 6125.111858780497, 6285.43431091204, 6295.0872123542285, 6310.116583678288, 6323.620582765049, 21466.677999830015, 21550.629430762605, 21642.891785541127, 22019.66970495444, 22144.0, 1833.2300433817695, 2006.7591888973416, 2017.314113201504, 2053.1992522916075, 2082.666773316262, 13725.45098196071, 13829.446822127104, 13882.236476993761, 13957.302134893316, 14488.058276212012, 1712.3578658003248, 1817.391173956726, 1843.2811203630595, 1952.80471952805, 1957.109515170594, 58037.419625803625, 63987.360126398606, 66655.0, 66684.3331566683, 67121.328786712, 15431.845681543266, 15540.766888496682, 15561.610959725871, 15600.687986240438, 15734.68530629381, 23024.0, 23068.19261325879, 23198.3040508785, 23271.534569308857, 23315.417114572272, 7972.920270797334, 7991.8401631967035, 8038.8794168087525, 8094.554799486084, 8322.334213262924, 6614.867702646016, 6673.599584024974, 6691.598504089673, 6743.629100399525, 6745.156855393076, 7534.208908064684, 7554.131274903457, 7560.017197764256, 7602.239776022354, 7604.467687261838, 2570.7943364530793, 2938.63268085613, 2946.219251898249, 3018.788684792087, 3106.9223269418444, 802.9638666260032, 864.9913500865036, 891.3270480786964, 895.3553441522093, 994.8706668133096, 13099.2140471572, 15385.461508847136, 15421.460248891459, 16570.420035298706, 17100.0, 823.972640137393, 852.1819053708509, 855.5636625321007, 877.2981614708208, 886.2865393358279, 8563.95718021406, 8635.654573816977, 8734.86897696535, 8814.086585438918, 8861.379703420698, 317246.0, 317576.0, 320007.0, 320883.0, 398235.0, 66060.0, 72757.0, 72897.0, 74270.0, 74934.62532687302, 986.8963758805365, 1007.6876168387677, 1017.4099022567042, 1017.6285655735603, 1040.552562398176, 13820.516281930084, 14353.784693229401, 14356.282185890872, 14390.856091439371, 14397.208153551655, 30769.230769230948, 31264.531032034083, 31322.21694457657, 32258.516122257715, 32343.676563234065, 41992.79003604963, 43234.0, 44883.0, 45140.774296129624, 46595.76702116468, 7839.7802154046385, 8576.871346929925, 8591.957040214758, 8623.525706086226, 8647.351448641502, 14070.226137562533, 14334.928325358724, 14902.329395177027, 14934.327955241823, 16045.518634440985, 12787.296698681661, 13141.802872957105, 13411.731765364833, 13428.261445620194, 13643.454261829416, 12496.0, 12707.428165732379, 12994.805077924028, 13337.133086349357, 13673.79489307681, 13339.333033348099, 14305.356258968579, 14369.0, 14660.413583456542, 14753.483628072965, 8527.147285271423, 8721.694740684046, 8750.51872147038, 9138.680146195116, 9154.679586214717, 13046.934765326112, 13745.931270343584, 13923.651908702364, 13945.0, 14226.430942762174], "unit": "ms", "name": "jquery.html", "value": 9061.067902138377}, {"lowerIsBetter": false, "replicates": [1396.1204441202042, 1602.7996500437446, 1672.2224165762918, 1687.1226961979771, 1721.1996421663932, 6013.909791353128, 6676.365745254199, 6850.999999999994, 6898.724051037965, 6952.304769523045, 6900.896486552706, 7078.327558881911, 7085.89371159433, 7086.57480551166, 7090.893636595455, 1997.5106099005764, 2032.19728207358, 2035.2876493227327, 2035.928742494013, 2036.0634108310196, 2026.6959956006642, 2054.9930534038363, 2059.618970490464, 2074.025208152166, 2074.439901226668, 2000.5498762778332, 2004.4387571480008, 2024.0790440349606, 2035.053700029486, 2035.389383185046, 1996.4010796760986, 2016.1632922337212, 2027.4627223785708, 2034.7863474335204, 2035.053700029486, 2019.2225992992658, 2026.6453370660076, 2070.9378718638463, 2073.7718850926385, 2074.2532688232222, 7020.192677842062, 7090.432765378758, 7093.184283807376, 7103.644817759143, 7106.147262328554, 4029.37544680575, 4091.6931230157857, 4094.1811637672286, 4103.035786590149, 4110.116324990141, 2693.407450360937, 2721.7142200068906, 2737.9589306160424, 2764.2536515141, 2770.2381844992588, 832.9167083291622, 838.8573942429801, 839.7480755773305, 858.536390349217, 861.814709837388, 9177.898652161717, 9195.40229885062, 9214.999999999933, 9217.585208665627, 9224.53877306132, 3634.2913131939017, 3668.7798732075626, 3724.8696295630066, 3725.3108174987715, 3728.0493474163914, 7968.163342848918, 7969.3226075784205, 7973.401994850409, 7975.481593696507, 7986.081600616004, 4062.207869465485, 4066.044479547304, 4066.512018557792, 4070.8371665133654, 4130.56629053951, 3133.38898914714, 3220.9677903221136, 3651.5253017107607, 3751.9062023449633, 3776.0182352587976, 3376.44288692363, 3391.101358140095, 3403.5235067090625, 3425.4861770734587, 3434.639362866913, 1062.0919114157439, 1070.1973519860105, 1070.8072546941626, 1076.8492411062457, 1079.578964203961, 1177.8527684039495, 1180.5053078135384, 1196.342011893455, 1197.6407077876602, 1209.4134344842744, 6572.14562106923, 6580.11168492257, 6662.866742665216, 6682.498812588978, 6693.0, 396.29855156373634, 408.4118868828877, 410.30043775362935, 411.71797318836093, 414.04975581041583, 5094.847154585368, 5150.922736158961, 5156.767945442389, 5158.200478925773, 5161.716105614152, 8526.232639062515, 8534.274586660204, 8670.479771213748, 8751.868721969175, 8774.824503509893, 8697.91302086971, 8711.0417854036, 8760.211580957744, 8772.868406973901, 8806.383553151347, 6773.0, 6799.252082270947, 6835.316468353125, 6906.412954898889, 6916.619585922823, 6484.935150648622, 6492.675366231575, 6497.0, 6497.252815926229, 6506.869862602627, 7627.733029343946, 7722.0, 7742.148363680103, 7807.765767026998, 7848.450608457353, 7873.133955265031, 8024.277814996678, 8034.397420193626, 8039.919600803917, 8151.5924203790755, 5153.0466863630345, 5234.13636749932, 5812.564057695774, 6272.623642581277, 6336.144620476177, 6600.735970561123, 6616.603003819786, 6633.104530888461, 6641.833954151185, 6657.101291325609, 6213.502919766317, 6219.378062193744, 6305.0, 6310.085037669421, 6329.588576742682, 6148.292946311231, 6178.783742568989, 6196.504279657526, 6276.184096067482, 6299.244090709144, 6099.969500152471, 6129.724162412791, 6141.416565426277, 6142.539309551891, 6163.753449861955, 5820.1560773688425, 5856.882862342644, 5877.118432235199, 5937.079752638348, 5952.077427998667, 5840.182374467493, 5971.671558064349, 6014.969925150346, 6015.368386319374, 6015.428534289235], "unit": "ms", "name": "mootools.html", "value": 3943.9520598065706}, {"lowerIsBetter": false, "replicates": [246.92962505685878, 250.85074380743458, 251.4254927490684, 256.86514579845567, 262.56807551577646, 5296.470352964701, 5363.0, 5395.757190926408, 5407.864803379913, 5425.6202065855405, 5038.546530812227, 5047.596192304616, 5273.446288139748, 5294.52349288564, 5322.866928326794, 4028.9194216115807, 4029.879103626896, 4038.899027524306, 4047.575004624516, 4054.736442131267, 4008.2584721826556, 4011.2980228460046, 4020.1959608078355, 4027.456293400383, 4042.090529630824, 3783.2622638585485, 3852.0, 3883.8834834954996, 3939.231849789292, 3956.090099277168, 3947.6447119759073, 3952.486176797027, 3958.6437220650278, 3960.920781584381, 3963.8612648557305, 3395.3548825723033, 3397.3545026444895, 3408.608010078823, 3410.1474631342167, 3431.3823511767873, 5110.28456016158, 5134.871628209325, 5148.897022059576, 5149.356330458692, 5155.639105262633, 4314.288142456491, 4420.46954365475, 4434.0, 4583.0, 4585.495595484494, 5404.837854864321, 5412.431694672042, 5431.8098866539485, 5431.972840135813, 5568.248286481355, 3632.963670363289, 3698.7595806272507, 3698.7965661888584, 3741.6071312512067, 3741.8774367689857, 5837.766489340422, 5874.765009399619, 5876.294844618673, 5877.647341159502, 5880.529557635379, 3596.0, 3759.9848041028768, 3780.4707340972286, 3816.427535869642, 3817.408301713239, 3807.4098514730263, 3807.562130354989, 3811.7522361046445, 3814.6948244140403, 3816.904577385588, 4405.823767049346, 4413.823447062082, 4416.227160246944, 4470.731756094645, 4499.347594598765, 5571.052921003439, 5604.187392828017, 5610.663360198401, 5612.691301978431, 5614.85962850932, 1318.2815365625756, 1344.1800501693958, 1344.7243315120377, 1344.8789608935242, 1346.8047133165637, 858.9441686290371, 863.119617989647, 868.9913100869037, 869.6651789061257, 871.5729292646557, 4805.27920811874, 4850.296706977469, 4854.878628034327, 4861.683990540603, 4869.293952376956, 5703.258576385127, 5707.086866101404, 5729.083346664514, 5775.740091695884, 5784.942150578525, 4889.682170658896, 4903.705777653352, 4911.336969509142, 4913.361263035854, 4916.729579873141, 3036.6052413186144, 3089.119600913729, 3113.875444982221, 3115.6417012043453, 3118.6725393833776, 5402.0, 5459.0, 5459.672419654833, 5461.0716178249795, 5465.262189604432, 5917.911231331534, 5920.822375328747, 5927.703614819242, 5928.762849486058, 5939.732712027969, 5350.6254562180275, 5429.158480435539, 5464.617476776667, 5468.535174510212, 5492.890142197213, 5864.413558644102, 5874.118882167709, 5881.470667639933, 5882.058870580858, 5886.6173698709445, 5720.656760594377, 5735.139729040678, 5736.885262294814, 5737.311522617312, 5743.167240749985, 5425.240466334637, 5546.862893106984, 5551.472610102034, 5559.749811258584, 5561.749721262634, 3738.457923601117, 3757.210985693035, 3759.981200093982, 3762.0, 3770.227103443842, 5892.705364731661, 5897.233359663216, 5900.675462849413, 5904.9704751475965, 5907.350191478848, 5671.064274394678, 5673.092305231144, 5678.630888992202, 5680.77276908919, 5682.3465301489205, 5536.501714845684, 5666.688332141772, 5668.744906479136, 5686.289213848269, 5697.886042279214, 5569.721513924206, 5573.888522229451, 5577.832665020056, 5579.46995035471, 5581.10702287632, 5712.371639119777, 5727.914081288867, 5734.7132643368495, 5734.885302293847, 5735.3977832327, 5440.891182176255, 5590.720463976866, 5593.8321850344555, 5598.496135347676, 5604.775808967595], "unit": "ms", "name": "prototype.html", "value": 4104.199796889865}, {"lowerIsBetter": false, "replicates": [674.3290426026103, 711.3135823929906, 758.6017340896029, 770.803445121494, 783.1346362269695, 10690.625828096017, 11140.3315801052, 11161.665150045512, 11177.273477223975, 11302.717432064203, 11293.20947533673, 12630.684232894182, 12922.0, 13064.869351306485, 13142.277174755385, 624.6377101281269, 631.649434563817, 778.4589710151461, 793.7182300283403, 794.408165916393, 780.683823051665, 789.7393860026177, 796.0566728426804, 796.3549524884833, 796.8645330293864, 826.6734639817269, 832.1304237072274, 833.154348336436, 834.1908348901586, 835.5696816139692, 648.6011103171539, 658.4633523678187, 801.8676918308472, 822.596927505518, 830.9875351869697, 609.5093449772976, 614.8862460444832, 617.8084793713963, 619.5817822969477, 620.1596836286811, 11028.834567481494, 11274.210805243636, 11305.886941130566, 11315.717107072307, 11322.150838687132, 10653.733656658567, 11198.608048718337, 11349.148813838996, 11393.601223957121, 11658.183927125105, 9133.634654613808, 9237.722868313962, 9469.905300946972, 9595.664151754725, 9802.215822734164, 3179.666135055832, 3205.3812824523466, 3214.4214041472524, 3248.626407963091, 3270.427675156838, 39429.0, 39916.40125398121, 39959.8002009991, 40074.79962600197, 40109.79945100285, 8959.686410975584, 8985.236254918274, 9011.098890110936, 9075.954620226856, 9085.636574537077, 16039.67920641604, 16065.678686426207, 16066.116363600115, 16070.75893861593, 16106.516804495885, 6467.2562655294305, 6469.385408386196, 6493.090967264587, 6591.0, 6706.798796036127, 3631.963680363215, 3640.7087433005295, 3673.2653469306247, 3674.8713795017047, 3708.870189543353, 2635.5387807133675, 2695.7304269572887, 2698.743619356158, 2701.311165652746, 2702.972970270272, 469.28199854223095, 473.9336492890998, 475.7930300319303, 477.7897725001058, 481.37421352241944, 442.47124686000564, 541.2260467531468, 581.764385423904, 589.2457654202627, 592.9940700593025, 7524.586147761816, 7557.395408367317, 7605.695772169051, 7627.466077374531, 7681.692732290646, 423.1769208888682, 439.2795814863562, 465.4159030416873, 525.684589246449, 525.6924699051021, 3613.1509095362567, 3669.376206044979, 3685.3919103348185, 3699.611540788232, 3797.8290976906105, 50049.74975125174, 50540.0, 50873.491265087614, 51207.74396127996, 51303.230451543255, 44438.77780611076, 45499.31751023737, 47745.0, 48419.757901210265, 48477.75761121242, 39240.215195696495, 40708.389374159415, 40727.389089163684, 41772.0, 41779.7911010443, 7591.506552074097, 7980.880286795818, 8074.555899425588, 8231.547264900488, 8254.669813207645, 30232.54651180278, 30334.393312133194, 30685.693143068285, 30690.07929762111, 30776.0, 35764.284714305046, 35914.46128308025, 37310.6268937318, 37739.0, 37823.43264850974, 9928.255380846322, 10032.498375081072, 10153.187744980532, 10168.865461697063, 10326.432046237229, 11109.777804444027, 11263.718407039889, 11410.828837567276, 11423.828642570203, 11665.59170429031, 9899.802003959736, 10613.204009699459, 10958.780824383308, 10975.780484390427, 11346.489407976496, 9961.452120133463, 10245.641402550875, 10293.897061029294, 10294.3823370598, 10376.792464150523, 10426.165906727596, 10774.622888198875, 10830.458477075957, 10854.620088296871, 11176.55293788272, 9005.684801031932, 9207.907920920705, 9245.815083698153, 9614.230861531201, 9630.422174669542, 9143.13140251675, 9162.0, 9277.536123193948, 9323.86014209801, 9336.859947100935], "unit": "ms", "name": "yui.html", "value": 5653.690504417039}], "name": "dromaeo_css", "value": 6331.116449780353}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 112.0, 113.0, 112.0, 102.0, 112.0, 111.0, 118.0], "unit": "ms", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 152.0, 169.0, 130.0, 162.0, 156.0, 139.0, 172.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 164.0, 161.0, 164.0, 168.0, 160.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 83.0, 93.0, 71.0, 72.0, 71.0, 114.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 127.0, 94.0, 94.0, 94.0, 135.0, 96.0, 95.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 147.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, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [80.0, 74.0, 73.0, 74.0, 73.0, 73.0, 73.0, 73.0, 76.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 85.0, 84.0, 86.0, 86.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 131.0, 116.0, 130.0, 121.0, 129.0, 121.0, 121.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 149.0, 146.0, 148.0, 134.0, 150.0, 147.0, 146.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 69.0, 70.0, 69.0, 71.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1527.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [185.87360594795538], "unit": "score", "name": "DeltaBlue", "value": 355.71483999999987}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [27405.405405405407], "unit": "score", "name": "RegExp", "value": 33.241070019723885}, {"lowerIsBetter": false, "replicates": [605.3268765133172], "unit": "score", "name": "Splay", "value": 134.62313200000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19800.228542205805}]} 03:20:56 INFO - RETURN: dromaeo_css: 6331.12 03:20:56 INFO - RETURN: kraken: 1527.80 03:20:56 INFO - RETURN: v8_7: 19800.23 03:20:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19800.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1527.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6331.12"}}} 03:20:56 INFO - Return code: 0 03:20:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:20:56 INFO - # TBPL SUCCESS # 03:20:56 INFO - Running post-action listener: _resource_record_post_action 03:20:56 INFO - Running post-run listener: _resource_record_post_run 03:20:57 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 10416128; Write bytes: 418738176; Read time: 3732; Write time: 388372 03:20:57 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 18423808; Read time: 0; Write time: 22212 03:20:57 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 8654848; Write bytes: 400314368; Read time: 3672; Write time: 366160 03:20:57 INFO - Running post-run listener: _upload_blobber_files 03:20:57 INFO - Blob upload gear active. 03:20:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:20:57 INFO - Copying logs to upload dir... 03:20:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.992555 ========= master_lag: 9.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-08 03:21:07.162390) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 03:21:07.165576) ========= 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=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009849 build_url: 'https://queue.taskcluster.net/v1/task/eEqUOPWbRmuaB14jEh7nZQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 03:21:07.189400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 03:21:07.189726) ========= 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=61fa6ed41387771909ec0f71000001b3-1449562475.11107-1787694514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004885 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 03:21:07.238893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 03:21:07.239214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 03:21:07.239497) ========= ========= Total master_lag: 9.71 =========