builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1449169475.45 results: success (0) buildid: 20151203103325 builduid: 09c9db5ce4f04a3c8a28d3ce9924158b revision: 65b8c89ff1b737c5e58523b6faf89299ca674e4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.449012) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.449497) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.449813) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006325 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.487533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.487875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.515815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.516189) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.565543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.566171) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.566957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.567505) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 11:04:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-03 11:04:36 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.224368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.806043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.806388) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.856127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:35.856507) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 65b8c89ff1b737c5e58523b6faf89299ca674e4e --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 65b8c89ff1b737c5e58523b6faf89299ca674e4e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 11:04:36,238 truncating revision to first 12 chars 2015-12-03 11:04:36,238 Setting DEBUG logging. 2015-12-03 11:04:36,238 attempt 1/10 2015-12-03 11:04:36,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/65b8c89ff1b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 11:04:36,513 unpacking tar archive at: fx-team-65b8c89ff1b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575515 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:36.445318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:36.445638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:36.491227) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:36.491692) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 11:04:36.492185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-03 11:04:36.492533) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:04:36 INFO - MultiFileLogger online at 20151203 11:04:36 in /builds/slave/test 11:04:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:04:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:04:36 INFO - {'append_to_log': False, 11:04:36 INFO - 'base_work_dir': '/builds/slave/test', 11:04:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:04:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:04:36 INFO - 'branch': 'Fx-Team-Non-PGO', 11:04:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:04:36 INFO - 'config_files': ('talos/linux_config.py',), 11:04:36 INFO - 'default_actions': ('clobber', 11:04:36 INFO - 'read-buildbot-config', 11:04:36 INFO - 'download-and-extract', 11:04:36 INFO - 'populate-webroot', 11:04:36 INFO - 'create-virtualenv', 11:04:36 INFO - 'install', 11:04:36 INFO - 'run-tests'), 11:04:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:04:36 INFO - 'download_minidump_stackwalk': True, 11:04:36 INFO - 'download_symbols': 'ondemand', 11:04:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:04:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:04:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:04:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:04:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:04:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:04:36 INFO - 'installer_path': 'installer.exe', 11:04:36 INFO - 'log_level': 'info', 11:04:36 INFO - 'log_name': 'talos', 11:04:36 INFO - 'log_to_console': True, 11:04:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:04:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:04:36 INFO - 'opt_config_files': (), 11:04:36 INFO - 'pip_index': False, 11:04:36 INFO - 'sps_profile': False, 11:04:36 INFO - 'sps_profile_interval': 0, 11:04:36 INFO - 'suite': 'dromaeojs', 11:04:36 INFO - 'system_bits': '64', 11:04:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:04:36 INFO - 'title': 'talos-linux64-ix-018', 11:04:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:04:36 INFO - 'use_talos_json': True, 11:04:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:04:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:04:36 INFO - 'work_dir': 'build'} 11:04:36 INFO - ##### 11:04:36 INFO - ##### Running clobber step. 11:04:36 INFO - ##### 11:04:36 INFO - Running pre-action listener: _resource_record_pre_action 11:04:36 INFO - Running main action method: clobber 11:04:36 INFO - rmtree: /builds/slave/test/build 11:04:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:04:37 INFO - Running post-action listener: _resource_record_post_action 11:04:37 INFO - ##### 11:04:37 INFO - ##### Running read-buildbot-config step. 11:04:37 INFO - ##### 11:04:37 INFO - Running pre-action listener: _resource_record_pre_action 11:04:37 INFO - Running main action method: read_buildbot_config 11:04:37 INFO - Using buildbot properties: 11:04:37 INFO - { 11:04:37 INFO - "properties": { 11:04:37 INFO - "buildnumber": 980, 11:04:37 INFO - "product": "firefox", 11:04:37 INFO - "script_repo_revision": "production", 11:04:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:04:37 INFO - "repository": "", 11:04:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:04:37 INFO - "buildid": "20151203103325", 11:04:37 INFO - "slavename": "talos-linux64-ix-018", 11:04:37 INFO - "pgo_build": "False", 11:04:37 INFO - "basedir": "/builds/slave/test", 11:04:37 INFO - "project": "", 11:04:37 INFO - "platform": "ubuntu64_hw", 11:04:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:04:37 INFO - "slavebuilddir": "test", 11:04:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:04:37 INFO - "branch": "fx-team", 11:04:37 INFO - "repo_path": "integration/fx-team", 11:04:37 INFO - "stage_platform": "linux64", 11:04:37 INFO - "builduid": "09c9db5ce4f04a3c8a28d3ce9924158b", 11:04:37 INFO - "revision": "65b8c89ff1b737c5e58523b6faf89299ca674e4e" 11:04:37 INFO - }, 11:04:37 INFO - "sourcestamp": { 11:04:37 INFO - "repository": "", 11:04:37 INFO - "hasPatch": false, 11:04:37 INFO - "project": "", 11:04:37 INFO - "branch": "fx-team-linux64-talos", 11:04:37 INFO - "changes": [ 11:04:37 INFO - { 11:04:37 INFO - "category": null, 11:04:37 INFO - "files": [ 11:04:37 INFO - { 11:04:37 INFO - "url": null, 11:04:37 INFO - "name": "https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:04:37 INFO - } 11:04:37 INFO - ], 11:04:37 INFO - "repository": "", 11:04:37 INFO - "rev": "65b8c89ff1b737c5e58523b6faf89299ca674e4e", 11:04:37 INFO - "who": "markcapella@twcny.rr.com", 11:04:37 INFO - "when": 1449169459, 11:04:37 INFO - "number": 6740278, 11:04:37 INFO - "comments": "Bug 1215959 - (GeckoCarets2) - Flip on by default in nightly, r=snorp", 11:04:37 INFO - "project": "", 11:04:37 INFO - "at": "Thu 03 Dec 2015 11:04:19", 11:04:37 INFO - "branch": "fx-team-linux64-talos", 11:04:37 INFO - "revlink": "", 11:04:37 INFO - "properties": [ 11:04:37 INFO - [ 11:04:37 INFO - "buildid", 11:04:37 INFO - "20151203103325", 11:04:37 INFO - "Change" 11:04:37 INFO - ], 11:04:37 INFO - [ 11:04:37 INFO - "builduid", 11:04:37 INFO - "09c9db5ce4f04a3c8a28d3ce9924158b", 11:04:37 INFO - "Change" 11:04:37 INFO - ], 11:04:37 INFO - [ 11:04:37 INFO - "pgo_build", 11:04:37 INFO - "False", 11:04:37 INFO - "Change" 11:04:37 INFO - ] 11:04:37 INFO - ], 11:04:37 INFO - "revision": "65b8c89ff1b737c5e58523b6faf89299ca674e4e" 11:04:37 INFO - } 11:04:37 INFO - ], 11:04:37 INFO - "revision": "65b8c89ff1b737c5e58523b6faf89299ca674e4e" 11:04:37 INFO - } 11:04:37 INFO - } 11:04:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:04:37 INFO - Running post-action listener: _resource_record_post_action 11:04:37 INFO - ##### 11:04:37 INFO - ##### Running download-and-extract step. 11:04:37 INFO - ##### 11:04:37 INFO - Running pre-action listener: _resource_record_pre_action 11:04:37 INFO - Running main action method: download_and_extract 11:04:37 INFO - mkdir: /builds/slave/test/build/tests 11:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:37 INFO - https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/test_packages.json 11:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/test_packages.json 11:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:04:40 INFO - Downloaded 1302 bytes. 11:04:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:04:40 INFO - Using the following test package requirements: 11:04:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:04:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:40 INFO - u'jsshell-linux-x86_64.zip'], 11:04:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:04:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:04:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:04:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:04:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:04:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:04: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')]} 11:04:40 INFO - https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:04:45 INFO - Downloaded 21788775 bytes. 11:04: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 11:04:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04: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 11:04:46 INFO - Return code: 0 11:04: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 11:04: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')]} 11:04:46 INFO - https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:04:48 INFO - Downloaded 21788775 bytes. 11:04: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 11:04:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:04: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 11:04:50 INFO - Return code: 0 11:04: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')]} 11:04:50 INFO - https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:04:51 INFO - Downloaded 11132001 bytes. 11:04: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 11:04:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:04: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 11:04:51 INFO - Return code: 0 11:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:51 INFO - https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:04:54 INFO - Downloaded 57686372 bytes. 11:04:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:54 INFO - mkdir: /builds/slave/test/properties 11:04:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:04:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:04:54 INFO - Contents: 11:04:54 INFO - build_url:https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:04:54 INFO - Running post-action listener: _resource_record_post_action 11:04:54 INFO - Running post-action listener: set_extra_try_arguments 11:04:54 INFO - ##### 11:04:54 INFO - ##### Running populate-webroot step. 11:04:54 INFO - ##### 11:04:54 INFO - Running pre-action listener: _resource_record_pre_action 11:04:54 INFO - Running main action method: populate_webroot 11:04:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:04:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:04:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:04:54 INFO - '../fennec_ids.txt'], 11:04:54 INFO - 'tests': ['tcheck2']}, 11:04:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:04:54 INFO - '--tppagecycles', 11:04:54 INFO - '7'], 11:04:54 INFO - 'tests': ['tsvgm']}}, 11:04:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:04:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:04:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:04:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:04:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'tests': ['damp', 'tps']}, 11:04:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['damp', 'tps']}, 11:04:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:04:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:54 INFO - 'other': {'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other_l64': {'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'other_nol64': {'tests': ['a11yr', 11:04:54 INFO - 'ts_paint', 11:04:54 INFO - 'tpaint', 11:04:54 INFO - 'sessionrestore', 11:04:54 INFO - 'sessionrestore_no_auto_restore']}, 11:04:54 INFO - 'svgr': {'tests': ['tsvgx', 11:04:54 INFO - 'tsvgr_opacity', 11:04:54 INFO - 'tart', 11:04:54 INFO - 'tscrollx', 11:04:54 INFO - 'cart']}, 11:04:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tsvgx', 11:04:54 INFO - 'tsvgr_opacity', 11:04:54 INFO - 'tart', 11:04:54 INFO - 'tscrollx', 11:04:54 INFO - 'cart']}, 11:04:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'tests': ['tp5o']}, 11:04:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s'], 11:04:54 INFO - 'tests': ['tp5o']}, 11:04:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--xperf_path', 11:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:54 INFO - 'tests': ['tp5n']}, 11:04:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:54 INFO - 'talos_options': ['--e10s', 11:04:54 INFO - '--xperf_path', 11:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:54 INFO - 'tests': ['tp5n']}}, 11:04:54 INFO - 'talos.zip': {'path': '', 11:04:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:04:54 INFO - Running post-action listener: _resource_record_post_action 11:04:54 INFO - ##### 11:04:54 INFO - ##### Running create-virtualenv step. 11:04:54 INFO - ##### 11:04:54 INFO - Running pre-action listener: _resource_record_pre_action 11:04:54 INFO - Running main action method: create_virtualenv 11:04:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:04:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:04:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:04:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:54 INFO - Using real prefix '/usr' 11:04:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:04:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:56 INFO - Installing pip.................done. 11:04:56 INFO - Return code: 0 11:04:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04: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 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04: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 11:04: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 11:04:56 INFO - Using env: {'DISPLAY': ':0', 11:04:56 INFO - 'HOME': '/home/cltbld', 11:04:56 INFO - 'LANG': 'en_US.UTF-8', 11:04:56 INFO - 'LANGUAGE': 'en_US:en', 11:04:56 INFO - 'LOGNAME': 'cltbld', 11:04:56 INFO - 'MAIL': '/var/mail/cltbld', 11:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:56 INFO - 'MOZ_NO_REMOTE': '1', 11:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:56 INFO - 'NO_EM_RESTART': '1', 11:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:56 INFO - 'PWD': '/builds/slave/test', 11:04:56 INFO - 'SHELL': '/bin/bash', 11:04:56 INFO - 'SHLVL': '1', 11:04:56 INFO - 'TERM': 'linux', 11:04:56 INFO - 'TMOUT': '86400', 11:04:56 INFO - 'USER': 'cltbld', 11:04:56 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:56 INFO - '_': '/tools/buildbot/bin/python'} 11:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:04:57 INFO - Cleaning up... 11:04:57 INFO - Return code: 0 11:04:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:04:57 INFO - Using env: {'DISPLAY': ':0', 11:04:57 INFO - 'HOME': '/home/cltbld', 11:04:57 INFO - 'LANG': 'en_US.UTF-8', 11:04:57 INFO - 'LANGUAGE': 'en_US:en', 11:04:57 INFO - 'LOGNAME': 'cltbld', 11:04:57 INFO - 'MAIL': '/var/mail/cltbld', 11:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:57 INFO - 'MOZ_NO_REMOTE': '1', 11:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:57 INFO - 'NO_EM_RESTART': '1', 11:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:57 INFO - 'PWD': '/builds/slave/test', 11:04:57 INFO - 'SHELL': '/bin/bash', 11:04:57 INFO - 'SHLVL': '1', 11:04:57 INFO - 'TERM': 'linux', 11:04:57 INFO - 'TMOUT': '86400', 11:04:57 INFO - 'USER': 'cltbld', 11:04:57 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:57 INFO - '_': '/tools/buildbot/bin/python'} 11:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:57 INFO - Downloading/unpacking psutil>=0.7.1 11:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:04:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:04:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:59 INFO - Installing collected packages: psutil 11:04:59 INFO - Running setup.py install for psutil 11:04:59 INFO - building 'psutil._psutil_linux' extension 11:04:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:04:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:04:59 INFO - building 'psutil._psutil_posix' extension 11:04:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:04:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:00 INFO - Successfully installed psutil 11:05:00 INFO - Cleaning up... 11:05:00 INFO - Return code: 0 11:05:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:00 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 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:05:00 INFO - Using env: {'DISPLAY': ':0', 11:05:00 INFO - 'HOME': '/home/cltbld', 11:05:00 INFO - 'LANG': 'en_US.UTF-8', 11:05:00 INFO - 'LANGUAGE': 'en_US:en', 11:05:00 INFO - 'LOGNAME': 'cltbld', 11:05:00 INFO - 'MAIL': '/var/mail/cltbld', 11:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:00 INFO - 'MOZ_NO_REMOTE': '1', 11:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:00 INFO - 'NO_EM_RESTART': '1', 11:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:00 INFO - 'PWD': '/builds/slave/test', 11:05:00 INFO - 'SHELL': '/bin/bash', 11:05:00 INFO - 'SHLVL': '1', 11:05:00 INFO - 'TERM': 'linux', 11:05:00 INFO - 'TMOUT': '86400', 11:05:00 INFO - 'USER': 'cltbld', 11:05:00 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:00 INFO - '_': '/tools/buildbot/bin/python'} 11:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:05:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:05:02 INFO - Installing collected packages: mozsystemmonitor 11:05:02 INFO - Running setup.py install for mozsystemmonitor 11:05:02 INFO - Successfully installed mozsystemmonitor 11:05:02 INFO - Cleaning up... 11:05:02 INFO - Return code: 0 11:05:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:05:02 INFO - Using env: {'DISPLAY': ':0', 11:05:02 INFO - 'HOME': '/home/cltbld', 11:05:02 INFO - 'LANG': 'en_US.UTF-8', 11:05:02 INFO - 'LANGUAGE': 'en_US:en', 11:05:02 INFO - 'LOGNAME': 'cltbld', 11:05:02 INFO - 'MAIL': '/var/mail/cltbld', 11:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:02 INFO - 'MOZ_NO_REMOTE': '1', 11:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:02 INFO - 'NO_EM_RESTART': '1', 11:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:02 INFO - 'PWD': '/builds/slave/test', 11:05:02 INFO - 'SHELL': '/bin/bash', 11:05:02 INFO - 'SHLVL': '1', 11:05:02 INFO - 'TERM': 'linux', 11:05:02 INFO - 'TMOUT': '86400', 11:05:02 INFO - 'USER': 'cltbld', 11:05:02 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:02 INFO - '_': '/tools/buildbot/bin/python'} 11:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:05 INFO - Downloading docopt-0.6.1.tar.gz 11:05:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:05 INFO - Running setup.py install for blobuploader 11:05:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:05 INFO - Running setup.py install for requests 11:05:05 INFO - Running setup.py install for docopt 11:05:05 INFO - Successfully installed blobuploader requests docopt 11:05:05 INFO - Cleaning up... 11:05:05 INFO - Return code: 0 11:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:05 INFO - Using env: {'DISPLAY': ':0', 11:05:05 INFO - 'HOME': '/home/cltbld', 11:05:05 INFO - 'LANG': 'en_US.UTF-8', 11:05:05 INFO - 'LANGUAGE': 'en_US:en', 11:05:05 INFO - 'LOGNAME': 'cltbld', 11:05:05 INFO - 'MAIL': '/var/mail/cltbld', 11:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:05 INFO - 'MOZ_NO_REMOTE': '1', 11:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:05 INFO - 'NO_EM_RESTART': '1', 11:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:05 INFO - 'PWD': '/builds/slave/test', 11:05:05 INFO - 'SHELL': '/bin/bash', 11:05:05 INFO - 'SHLVL': '1', 11:05:05 INFO - 'TERM': 'linux', 11:05:05 INFO - 'TMOUT': '86400', 11:05:05 INFO - 'USER': 'cltbld', 11:05:05 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:05 INFO - '_': '/tools/buildbot/bin/python'} 11:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:05 INFO - Running setup.py (path:/tmp/pip-L7E7gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:06 INFO - Running setup.py (path:/tmp/pip-t6w8AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:06 INFO - Running setup.py (path:/tmp/pip-C_gGmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:06 INFO - Running setup.py (path:/tmp/pip-UbPnI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:06 INFO - Running setup.py (path:/tmp/pip-6NPxES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:06 INFO - Running setup.py (path:/tmp/pip-q2aHr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:06 INFO - Running setup.py (path:/tmp/pip-DMKpDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:06 INFO - Running setup.py (path:/tmp/pip-WnOfIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:06 INFO - Running setup.py (path:/tmp/pip-bOyTUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:06 INFO - Running setup.py (path:/tmp/pip-o03Odq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:06 INFO - Running setup.py (path:/tmp/pip-68lNcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:06 INFO - Running setup.py (path:/tmp/pip-EDqm3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:06 INFO - Running setup.py (path:/tmp/pip-yzbVMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:06 INFO - Running setup.py (path:/tmp/pip-Ko2U1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:06 INFO - Running setup.py (path:/tmp/pip-B_vtfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:07 INFO - Running setup.py (path:/tmp/pip-CKTd9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:07 INFO - Running setup.py (path:/tmp/pip-681Iif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:07 INFO - Running setup.py install for manifestparser 11:05:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozcrash 11:05:07 INFO - Running setup.py install for mozdebug 11:05:07 INFO - Running setup.py install for mozdevice 11:05:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozfile 11:05:07 INFO - Running setup.py install for mozhttpd 11:05:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozinfo 11:05:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozInstall 11:05:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:07 INFO - Running setup.py install for mozleak 11:05:08 INFO - Running setup.py install for mozlog 11:05:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Running setup.py install for moznetwork 11:05:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Running setup.py install for mozprocess 11:05:08 INFO - Running setup.py install for mozprofile 11:05:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Running setup.py install for mozrunner 11:05:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Running setup.py install for mozscreenshot 11:05:08 INFO - Running setup.py install for moztest 11:05:08 INFO - Running setup.py install for mozversion 11:05:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:08 INFO - Cleaning up... 11:05:08 INFO - Return code: 0 11:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:08 INFO - Using env: {'DISPLAY': ':0', 11:05:08 INFO - 'HOME': '/home/cltbld', 11:05:08 INFO - 'LANG': 'en_US.UTF-8', 11:05:08 INFO - 'LANGUAGE': 'en_US:en', 11:05:08 INFO - 'LOGNAME': 'cltbld', 11:05:08 INFO - 'MAIL': '/var/mail/cltbld', 11:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:08 INFO - 'MOZ_NO_REMOTE': '1', 11:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:08 INFO - 'NO_EM_RESTART': '1', 11:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:08 INFO - 'PWD': '/builds/slave/test', 11:05:08 INFO - 'SHELL': '/bin/bash', 11:05:08 INFO - 'SHLVL': '1', 11:05:08 INFO - 'TERM': 'linux', 11:05:08 INFO - 'TMOUT': '86400', 11:05:08 INFO - 'USER': 'cltbld', 11:05:08 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:08 INFO - '_': '/tools/buildbot/bin/python'} 11:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:09 INFO - Running setup.py (path:/tmp/pip-UqAkaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:09 INFO - Running setup.py (path:/tmp/pip-4l8P46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:09 INFO - Running setup.py (path:/tmp/pip-q7JPex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:09 INFO - Running setup.py (path:/tmp/pip-2gLiaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:09 INFO - Running setup.py (path:/tmp/pip-Kycvrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:09 INFO - Running setup.py (path:/tmp/pip-a0eT_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:09 INFO - Running setup.py (path:/tmp/pip-tvd0QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:09 INFO - Running setup.py (path:/tmp/pip-HDQV_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:09 INFO - Running setup.py (path:/tmp/pip-uMqPQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:09 INFO - Running setup.py (path:/tmp/pip-0PLSNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:09 INFO - Running setup.py (path:/tmp/pip-zMSvRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:09 INFO - Running setup.py (path:/tmp/pip-7BZkVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05: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)) 11:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:10 INFO - Running setup.py (path:/tmp/pip-tO6iPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:10 INFO - Running setup.py (path:/tmp/pip-0Gcm0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:10 INFO - Running setup.py (path:/tmp/pip-OXQZZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:10 INFO - Running setup.py (path:/tmp/pip-4izzKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:10 INFO - Running setup.py (path:/tmp/pip-55imUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:12 INFO - Downloading blessings-1.5.1.tar.gz 11:05: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 11:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:12 INFO - Installing collected packages: blessings 11:05:12 INFO - Running setup.py install for blessings 11:05:12 INFO - Successfully installed blessings 11:05:12 INFO - Cleaning up... 11:05:12 INFO - Return code: 0 11:05:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:12 INFO - Reading from file tmpfile_stdout 11:05:12 INFO - Current package versions: 11:05:12 INFO - argparse == 1.2.1 11:05:12 INFO - blessings == 1.5.1 11:05:12 INFO - blobuploader == 1.2.4 11:05:12 INFO - docopt == 0.6.1 11:05:12 INFO - manifestparser == 1.1 11:05:12 INFO - mozInstall == 1.12 11:05:12 INFO - mozcrash == 0.16 11:05:12 INFO - mozdebug == 0.1 11:05:12 INFO - mozdevice == 0.47 11:05:12 INFO - mozfile == 1.2 11:05:12 INFO - mozhttpd == 0.7 11:05:12 INFO - mozinfo == 0.9 11:05:12 INFO - mozleak == 0.1 11:05:12 INFO - mozlog == 3.1 11:05:12 INFO - moznetwork == 0.27 11:05:12 INFO - mozprocess == 0.22 11:05:12 INFO - mozprofile == 0.27 11:05:12 INFO - mozrunner == 6.11 11:05:12 INFO - mozscreenshot == 0.1 11:05:12 INFO - mozsystemmonitor == 0.0 11:05:12 INFO - moztest == 0.7 11:05:12 INFO - mozversion == 1.4 11:05:12 INFO - psutil == 3.1.1 11:05:12 INFO - requests == 1.2.3 11:05:12 INFO - wsgiref == 0.1.2 11:05:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:12 INFO - Using env: {'DISPLAY': ':0', 11:05:12 INFO - 'HOME': '/home/cltbld', 11:05:12 INFO - 'LANG': 'en_US.UTF-8', 11:05:12 INFO - 'LANGUAGE': 'en_US:en', 11:05:12 INFO - 'LOGNAME': 'cltbld', 11:05:12 INFO - 'MAIL': '/var/mail/cltbld', 11:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:12 INFO - 'MOZ_NO_REMOTE': '1', 11:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:12 INFO - 'NO_EM_RESTART': '1', 11:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:12 INFO - 'PWD': '/builds/slave/test', 11:05:12 INFO - 'SHELL': '/bin/bash', 11:05:12 INFO - 'SHLVL': '1', 11:05:12 INFO - 'TERM': 'linux', 11:05:12 INFO - 'TMOUT': '86400', 11:05:12 INFO - 'USER': 'cltbld', 11:05:12 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:12 INFO - '_': '/tools/buildbot/bin/python'} 11:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:12 INFO - Cleaning up... 11:05:12 INFO - Return code: 0 11:05:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:05:12 INFO - Using env: {'DISPLAY': ':0', 11:05:12 INFO - 'HOME': '/home/cltbld', 11:05:12 INFO - 'LANG': 'en_US.UTF-8', 11:05:12 INFO - 'LANGUAGE': 'en_US:en', 11:05:12 INFO - 'LOGNAME': 'cltbld', 11:05:12 INFO - 'MAIL': '/var/mail/cltbld', 11:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:12 INFO - 'MOZ_NO_REMOTE': '1', 11:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:12 INFO - 'NO_EM_RESTART': '1', 11:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:12 INFO - 'PWD': '/builds/slave/test', 11:05:12 INFO - 'SHELL': '/bin/bash', 11:05:12 INFO - 'SHLVL': '1', 11:05:12 INFO - 'TERM': 'linux', 11:05:12 INFO - 'TMOUT': '86400', 11:05:12 INFO - 'USER': 'cltbld', 11:05:12 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:12 INFO - '_': '/tools/buildbot/bin/python'} 11:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:13 INFO - Downloading/unpacking jsonschema 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:05:14 INFO - Downloading/unpacking functools32 (from jsonschema) 11:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:15 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05: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 11:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:15 INFO - warning: no files found matching '*.txt' 11:05:15 INFO - no previously-included directories found matching 'build' 11:05:15 INFO - no previously-included directories found matching 'dist' 11:05:15 INFO - no previously-included directories found matching '.git*' 11:05:15 INFO - Installing collected packages: jsonschema, functools32 11:05:15 INFO - Running setup.py install for functools32 11:05:15 INFO - warning: no files found matching '*.txt' 11:05:15 INFO - no previously-included directories found matching 'build' 11:05:15 INFO - no previously-included directories found matching 'dist' 11:05:15 INFO - no previously-included directories found matching '.git*' 11:05:15 INFO - Successfully installed jsonschema functools32 11:05:15 INFO - Cleaning up... 11:05:15 INFO - Return code: 0 11:05:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48e9e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2032240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:05:15 INFO - Using env: {'DISPLAY': ':0', 11:05:15 INFO - 'HOME': '/home/cltbld', 11:05:15 INFO - 'LANG': 'en_US.UTF-8', 11:05:15 INFO - 'LANGUAGE': 'en_US:en', 11:05:15 INFO - 'LOGNAME': 'cltbld', 11:05:15 INFO - 'MAIL': '/var/mail/cltbld', 11:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:15 INFO - 'MOZ_NO_REMOTE': '1', 11:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:15 INFO - 'NO_EM_RESTART': '1', 11:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:15 INFO - 'PWD': '/builds/slave/test', 11:05:15 INFO - 'SHELL': '/bin/bash', 11:05:15 INFO - 'SHLVL': '1', 11:05:15 INFO - 'TERM': 'linux', 11:05:15 INFO - 'TMOUT': '86400', 11:05:15 INFO - 'USER': 'cltbld', 11:05:15 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:15 INFO - '_': '/tools/buildbot/bin/python'} 11:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:15 INFO - Downloading/unpacking flake8 11:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:05: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 11:05:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:05:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:05:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05: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 11:05:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:18 INFO - no previously-included directories found matching 'docs/_build' 11:05:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:05:18 INFO - Running setup.py install for pep8 11:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:18 INFO - no previously-included directories found matching 'docs/_build' 11:05:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:05:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:05:18 INFO - Cleaning up... 11:05:18 INFO - Return code: 0 11:05:18 INFO - Running post-action listener: _resource_record_post_action 11:05:18 INFO - Running post-action listener: _start_resource_monitoring 11:05:18 INFO - Starting resource monitoring. 11:05:18 INFO - ##### 11:05:18 INFO - ##### Running install step. 11:05:18 INFO - ##### 11:05:18 INFO - Running pre-action listener: _resource_record_pre_action 11:05:18 INFO - Running main action method: install 11:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:18 INFO - Reading from file tmpfile_stdout 11:05:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:05:18 INFO - Reading from file tmpfile_stdout 11:05:18 INFO - Output received: 11:05:18 INFO - Usage: mozinstall [options] installer 11:05:18 INFO - Options: 11:05:18 INFO - -h, --help show this help message and exit 11:05:18 INFO - -d DEST, --destination=DEST 11:05:18 INFO - Directory to install application into. [default: 11:05:18 INFO - "/builds/slave/test"] 11:05:18 INFO - --app=APP Application being installed. [default: firefox] 11:05:18 INFO - mkdir: /builds/slave/test/build/application 11:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:05:33 INFO - Reading from file tmpfile_stdout 11:05:33 INFO - Output received: 11:05:33 INFO - /builds/slave/test/build/application/firefox/firefox 11:05:33 INFO - Running post-action listener: _resource_record_post_action 11:05:33 INFO - ##### 11:05:33 INFO - ##### Running run-tests step. 11:05:33 INFO - ##### 11:05:33 INFO - Running pre-action listener: _resource_record_pre_action 11:05:33 INFO - Running main action method: run_tests 11:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:05:33 INFO - Python 2.7.3 11:05:33 INFO - Return code: 0 11:05:33 INFO - grabbing minidump binary from tooltool 11:05: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')]} 11:05: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 0x20c10b0>, '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 0x20c1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c2440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:05: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 11:05: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 11:05:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:05:33 INFO - Return code: 0 11:05:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:05:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:05:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:05:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:05:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:05:34 INFO - Return code: 0 11:05: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/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 11:05: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/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 11:05:34 INFO - Using env: {'DISPLAY': ':0', 11:05:34 INFO - 'HOME': '/home/cltbld', 11:05:34 INFO - 'LANG': 'en_US.UTF-8', 11:05:34 INFO - 'LANGUAGE': 'en_US:en', 11:05:34 INFO - 'LOGNAME': 'cltbld', 11:05:34 INFO - 'MAIL': '/var/mail/cltbld', 11:05:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:34 INFO - 'MOZ_NO_REMOTE': '1', 11:05:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:34 INFO - 'NO_EM_RESTART': '1', 11:05:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:34 INFO - 'PWD': '/builds/slave/test', 11:05:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:34 INFO - 'SHELL': '/bin/bash', 11:05:34 INFO - 'SHLVL': '1', 11:05:34 INFO - 'TERM': 'linux', 11:05:34 INFO - 'TMOUT': '86400', 11:05:34 INFO - 'USER': 'cltbld', 11:05:34 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134', 11:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:34 INFO - '_': '/tools/buildbot/bin/python'} 11:05: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/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 11:05:34 INFO - mozversion INFO | application_buildid: 20151203103325 11:05:34 INFO - mozversion INFO | application_changeset: 65b8c89ff1b737c5e58523b6faf89299ca674e4e 11:05:34 INFO - mozversion INFO | application_display_name: Nightly 11:05:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:05:34 INFO - mozversion INFO | application_name: Firefox 11:05:34 INFO - mozversion INFO | application_remotingname: firefox 11:05:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:05:34 INFO - mozversion INFO | application_vendor: Mozilla 11:05:34 INFO - mozversion INFO | application_version: 45.0a1 11:05:34 INFO - mozversion INFO | platform_buildid: 20151203103325 11:05:34 INFO - mozversion INFO | platform_changeset: 65b8c89ff1b737c5e58523b6faf89299ca674e4e 11:05:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:05:34 INFO - mozversion INFO | platform_version: 45.0a1 11:05:34 INFO - 2015-12-03 11:05:34,638 DEBUG : using testdate: 1449169534 11:05:34 INFO - 2015-12-03 11:05:34,638 DEBUG : actual date: 1449169534 11:05:34 INFO - 2015-12-03 11:05:34,754 INFO : starting webserver on 'localhost:40688' 11:05:34 INFO - 2015-12-03 11:05:34,755 INFO : Starting test suite talos-linux64-ix-018 11:05:34 INFO - 2015-12-03 11:05:34,755 INFO : Starting test dromaeo_css 11:05:34 INFO - 2015-12-03 11:05:34,755 DEBUG : operating with platform_type : linux_ 11:05:34 INFO - 2015-12-03 11:05:34,756 INFO : Initialising browser for dromaeo_css test... 11:05:34 INFO - 2015-12-03 11:05:34,768 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZeAWYu/profile http://localhost:40688/getInfo.html 11:05:38 INFO - 2015-12-03 11:05:38,600 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:05:38 INFO - 2015-12-03 11:05:38,600 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:05:38 INFO - 2015-12-03 11:05:38,600 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:05:38 INFO - 2015-12-03 11:05:38,600 DEBUG : BROWSER_OUTPUT: __metrics 11:05:38 INFO - 2015-12-03 11:05:38,704 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:05:38 INFO - 2015-12-03 11:05:38,768 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:05:39 INFO - 2015-12-03 11:05:39,886 INFO : Browser initialized. 11:05:39 INFO - 2015-12-03 11:05:39,887 INFO : Running cycle 1/1 for dromaeo_css test... 11:05:39 INFO - 2015-12-03 11:05:39,887 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZeAWYu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:05:51 INFO - 2015-12-03 11:05:51,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 143327232 11:05:51 INFO - 2015-12-03 11:05:51,936 DEBUG : BROWSER_OUTPUT: 11:06:43 INFO - 2015-12-03 11:06:43,196 DEBUG : BROWSER_OUTPUT: 1449169603195 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:08:55 INFO - 2015-12-03 11:08:55,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40688/tests/dromaeo/cssquery-ext.html) 11:08:56 INFO - 2015-12-03 11:08:56,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 253952000 11:08:56 INFO - 2015-12-03 11:08:56,360 DEBUG : BROWSER_OUTPUT: 11:11:59 INFO - 2015-12-03 11:11:59,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/dromaeo/cssquery-ext.html (next: http://localhost:40688/tests/dromaeo/cssquery-jquery.html) 11:11:59 INFO - 2015-12-03 11:11:59,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 225067008 11:11:59 INFO - 2015-12-03 11:11:59,616 DEBUG : BROWSER_OUTPUT: 11:15:01 INFO - 2015-12-03 11:15:01,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40688/tests/dromaeo/cssquery-mootools.html) 11:15:02 INFO - 2015-12-03 11:15:02,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 227717120 11:15:02 INFO - 2015-12-03 11:15:02,244 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-03 11:18:04,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40688/tests/dromaeo/cssquery-prototype.html) 11:18:04 INFO - 2015-12-03 11:18:04,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 208912384 11:18:04 INFO - 2015-12-03 11:18:04,789 DEBUG : BROWSER_OUTPUT: 11:21:07 INFO - 2015-12-03 11:21:07,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40688/tests/dromaeo/cssquery-yui.html) 11:21:08 INFO - 2015-12-03 11:21:08,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 209797120 11:21:08 INFO - 2015-12-03 11:21:08,260 DEBUG : BROWSER_OUTPUT: 11:24:10 INFO - 2015-12-03 11:24:10,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/dromaeo/cssquery-yui.html (next: http://localhost:40688/tests/dromaeo/cssquery-dojo.html) 11:24:11 INFO - 2015-12-03 11:24:11,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 269832192 11:24:11 INFO - 2015-12-03 11:24:11,099 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,100 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:24:11 INFO - 2015-12-03 11:24:11,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:24:11 INFO - 2015-12-03 11:24:11,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:24:11 INFO - 2015-12-03 11:24:11,101 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:24:11 INFO - 2015-12-03 11:24:11,105 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2563.423229773301;2667.053196115378;2671.118530884808;2677.986610066949;2693.326668332916;4372;4481.731096134226;4529;4613.907721845565;4637.930431043533;4554.362389265505;4617.330487079372;4628.328892310613;4631.091043493899;4631.629469642429;4140.420341152241;4229.97885010576;4261.424707664472;4337.262665346899;4370.475542934836;4036.979815100935;4274.97862510687;4286.807093680792;4339.435873336462;4375.496817865938;4205.07488352565;4211.684123690736;4248.001719595893;4278.529361770203;4292.506361768405;4234.407182994383;4235.555266696983;4263.936040959357;4269.6370808481315;4275.828966841323;4085.142120154771;4204.558521355244;4223.535411104776;4227.112306415656;4265.253580623409;4483.865484035484;4496.033352829125;4523;4538.682292239545;4573.176828170928;4904.362432883738;5012.674176178537;5046.318746969149;5046.646734728571;5094.79620815167;4862.100511405366;5036.546710796046;5056.747162641853;5067.6452648314635;5071.087204303224;4524.8416305429155;4545.954540454586;4550.340200670884;4553.590176884063;4613.077384523109;5104.566111880457;5134.640575159778;5139.922901156486;5145.76844042019;5146.485351464824;4927.901441971212;4928.088303663833;4934.481879402683;4937.901241975141;4978.079055374767;4781.497942716034;4873.41519017713;4875.098106850244;4916.655834091579;5046.016026874798;4999.175136102575;5038.974805125951;5039.899202015939;5042.546170844642;5087.516685914832;4994.850154495371;5007;5009.298698182258;5010.398752149693;5013.147764879979;4001.639852413297;4084.6732261419015;4085.571015043437;4114.321137012359;4178.331466965271;3685.0971511979737;3688.188598508324;3696.7412281140064;3698.2788356270808;3728.366177749789;4333.8699839004885;4334.176506463762;4334.631556317749;4364.8472303469225;4368.956310436918;4732.337472753818;4840.975795121002;4842.806287748521;4949.876253093629;5031.874203144877;4254.404383386328;4272.700910936267;4273.1026484438;4276.914461710749;4310.913781724348;4407.933880991788;4408.669349798778;4411.536788637147;4416.514183439819;4455.997400584843;4578.9771051144535;4638.443386793471;4693.530646935279;4694.3427920090535;4766.046790641816;4992.600591952708;5011.072951503984;5017.67385119966;5018.272350509229;5019.874503137451;4717.764111794465;4741.122892264942;4741.881452963704;4779.976100119477;4787.904241915212;4709.882252943704;4797.616190704805;4808.519148085164;4825.662203645711;4961.7519124044375;4983.103041452428;4994.101061808909;4999.325091112653;5011.223260394645;5013.924791128063;4858.95141048585;4862.781174847211;4865.659403841839;4866.0024694938165;4899.289603007473;4686.625069994324;4758.214894542361;4803.375561177025;4811.615070794258;4884.78018489176;4632.814687412466;4697.060587882505;4700.506446823171;4704.176769065469;4755.096531658974;4885.438174609965;4916.631252655993;4917.58200552957;4918.532739389752;4963.156263435297;4661;4768;4808.687435316693;4816.759162041954;4822.348982887265 11:24:11 INFO - 2015-12-03 11:24:11,105 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.5330975290511;568.8776912963712;573.9397363276853;577.0133072446118;578.2858170159855;26933;27631.309217269554;35959.280814383696;36084;36392.81803590985;38307.616923830756;38771.41842872359;38848.223035539275;38922;38941.41587876177;6952;7848.803779905491;8014.519128852258;8017.679292828309;8020.197980201962;7038.19060808006;10026.498675066254;10366.326188797704;10367.17062634991;10372.118369938564;9730;9797.706068817912;9803.656872009482;9804.852927206062;9811.803763924718;7119.21688614252;7298.489105762599;9864.506774661239;9952.5521351539;10047.29668923172;9771;9904.455254960974;9909.157721593674;9919.454430006346;9925.851112233322;35560.466593001125;35951.82024089889;36033.09917252063;36034.279314413565;36038.27923441517;2925.546540286259;2939.3533422646983;2957.5859379686863;3423.554937858087;3584.6773790358993;26973.460530789274;27051.86474067617;27366.589501157498;27485.587716184273;28034.158975230777;3230.03099070278;3478.0783092480515;3494.702950249232;3522.3659741246565;3580.606133325332;214967;215915;218093;218293.9999999984;218439;50809;51456.22815657768;54196.72901635546;54692.45307546874;54782.72608637011;63766.6811665948;66235.33764662388;66247;66248.01255962328;66318;12522.499100035897;12630.242185468902;12668.049896257817;12670.11309208365;12675.936620317023;9990.250731195045;10010.899891000996;10074.445905475122;10077.748056298504;10080.04239597237;18732.344367947328;18765.812341876408;18796.906015470107;18888;18965.43103706891;7369.963150184322;7646.3882889368715;7674.309312161932;7728.768136955788;7748.457607967388;831.301706566487;884.3611355394613;902.4984644647307;913.6756451459636;948.9952550237342;26280;26407.051729990064;26696.332591685365;26755.866220668773;26835.329116771845;941.6892425499706;977.2084611464736;1001.2190491416707;1073.8711354637494;1076.3488089705772;14229;15124.848751512563;15304.46920411766;15342.386304547694;15425.228738563026;308151;313866;314494;314739;315795;47398.763006184745;47695;47781.52218477771;47807.521924781;47813.760931195124;1017.9185665146771;1101.251149218523;1195.9162858599814;1197.9401029948467;1212.5695378140633;25069.87465062663;25793.87103064473;26336.736632634194;26607.33481662974;26621;35553.64446355607;37931.81034094812;38430.231395372495;38478.23043539058;38552.80723596364;161785.19107404858;326742;333202;333601;334065;28062.438751224454;28670;28676.42647147087;28695.713042869305;28715.8564207186;36414.4537831938;36988;37760;37793.433098504094;37805.43291850569;31915.56379962861;32690.673093269714;33232;33604.495932560545;33686.83156584299;32830.507542387364;37127;38716.60412058486;38815.80592097021;39304.606953930095;33885.66114338825;34001;34016.14959626029;34100.465479054;34214.315713685086;30084.398312034074;30433.39133217279;30692;30803.229919251302;31089.378212436077;24084.397890052187;24408.6338704916;24469.632955505327;24558.87720561386;24832.37919051966 11:24:11 INFO - 2015-12-03 11:24:11,108 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.7037007433458;337.0881764826144;338.5700160795788;339.24517947566665;340.4382768432087;12291.078169137329;12722.936385318084;14986.625334366647;15016.849831501682;16216.189190540485;11790.29258244506;13834.654133646638;14178.574642760708;14644.926775366135;14719.116852988827;4726.787294571735;5063.36707911512;5222.060029194743;5224.033553792541;6095.969520152393;3566.4115420955513;3657.3416784978695;5712.542996560265;5873;6010.158577799111;5632.943670563303;5762.308522977249;5785.942140578582;5816.662167701431;5817.418258174191;5715.9428405716035;5745.454181852718;5748.798792042279;5761.88476230473;5768.42315768424;4931.654784165074;5046.243063540462;5048.040872234301;5059.494050594948;5066.189409694468;18979.24083036677;18980.240790368367;19197.90401047986;19482.318118865915;19638.312659057006;1618.7408026090743;1659.8755093368045;1853.4902901702005;2012.5672980309157;2405.458771776354;8772.692955746517;8843.823123537493;8936.731898043068;9061.682841100595;12405.62783116508;1689.442483980296;1738.0440757583278;1775.6626241014167;1778.386456672446;1791.480470663506;51794.48205517972;52919.941601168146;53064.734676326756;53146.468535314925;54285.1857222142;9721.854172187423;9763.463009534402;9790.412575245507;9830.459324737065;9838.508074596242;12495.875041249654;12529.74940501185;12532;12544;12566.748665026647;6870.45036397087;6873.175218973755;6910.550814197061;6954.54795438305;7015.649217539102;6333.081703153017;6366.36336366369;6377.3303803100935;6393.360663933569;6446.097546343516;4121.9381709274385;4128.504579450485;4153.480814898137;4161.479815023122;4171.687123465752;1573.4571572807363;1613.499815057336;1668.8915220510628;1726.1024267380892;1729.152715169583;837.7026155714756;897.1970086772302;901.8647202919483;903.2412773270485;954.341504361988;12476.81284780729;14091.224982626054;14119.43924489226;14580.90643201764;14942.25288735559;853.9581710313407;854.0605334132529;864.8443280209623;876.6887754846938;877.4384393987852;8268.917310826935;8597.570121494025;8691.174338437839;8751.124887511325;8754.737357879147;450367;451556;451816;456912;460115;66826.33173668201;69545.65227173932;69990;70330.64834675794;71083.64458177677;965.4641673870929;993.8012397520525;994.418265314799;998.6904059741504;1026.0047753678919;14265.57203283903;14270.500532481314;14398.496052638107;14467.638309042359;14568.562943111723;31642.208944776565;31834.681653183172;32222.19444513812;33216.83391583027;33305.16737081592;42686.57313426826;43317.13365732731;44866;45013.09973800571;46085;8596.140385961355;8660.566971651266;8793.868091978498;8814.86777698348;8991.550422478718;15433.305501252695;15693.529194124194;15803.683926321179;15975.600609984844;16183;12878.742425151257;13192.20846749198;13605.79591306151;13615.863841361459;13705.314734263047;12684.23894566329;13084.803727943898;13278.86721132815;13671.658208544866;13737.519186828413;9235.538223088684;12534.435950382436;12780.680482988;12896;13602.523911663044;8575.185357391038;8611.569421528773;8653.264472519906;8703.521306328214;8724.69463568772;9104.726858194264;9395.671151509665;12388.132830701765;12503.937480312541;12523.248605083723 11:24:11 INFO - 2015-12-03 11:24:11,109 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1211.9272843629378;1567.3260497985866;1616.086910895344;1634.9182540872953;1652.3555813232842;6002.549808764344;7085.9291407085975;7200.35196832285;7210.7836764897;7214.134303883535;7015.54398964067;7154.248803875596;7161.5345002574795;7169.068021157243;7177.89233161503;1749.7987731410924;1777.6000399910047;1778.9911050444794;2057.526768843167;2087.603355362476;1793.417139429684;1799.7750281214849;2044.417341057799;2078.3972647932155;2084.2080009596334;2053.8767673939537;2067.441790716513;2079.656856618656;2080.240712140073;2086.885221312827;2026.4427282497284;2055.5580550181785;2068.6069646767064;2070.472029632434;2075.79242075792;2039.9592008159755;2074.263636409083;2078.844086693504;2085.8957052147484;2113.5455876986366;7113.502054856162;7184.425245980309;7197.89203161953;7202.891956620655;7217.783466495961;4051.3315302974975;4070.4911886014247;4085.7140000199997;4109.630133287988;4126.91746165078;2677.9196624101114;2708.647875776156;2731.0031838379045;2741.739534744196;2751.834889906612;861.1130535548396;870.4733636150102;880.9911900881037;895.6417433026842;897.1611543207122;9404.858927116098;9411.294152938557;9413;9431.292653051049;9434.622615095457;3887.688984881203;3938.9015274618364;3954.347532657137;3957.881263562098;4032.4354590357375;8151.673933042731;8193.426460147852;8204.056533498604;8209.507429554245;8216.21945915137;4126.793660316972;4138.710290279711;4141;4145.91708165841;4147.834086636561;3780.1494663700446;3781.0736369589627;3781.4516895050065;3782.3759079751535;3785.6971442284553;3406.795592264472;3423.3153369326233;3475.3396854597545;3477.200243943907;3491.720662347006;938.6808485115093;963.7735132243918;1096.4791723931069;1137.7496950670838;1141.5262665993519;837.6858677995751;856.6701819799422;858.3305022082785;858.4763294390542;1015.1371334365878;6744.190697116377;6749.0551322814845;6796.422304104207;6819.659017049128;6828.829279268058;1007.4358359318805;1031.8813336466253;1032.963846265377;1052.394872948058;1054.6625079974335;5147.6911385317;5259.342582177228;5261.579073674096;5283.233931079972;5288.3918349390315;8182.059063207688;8229.341652667772;8516.361272904556;8711.433756805787;8734.825303493895;8265.752027439186;8295.211954864279;8332.50004999702;8334.12491688376;8359.623816928253;6491.156149700509;6793.082933803873;6793.524453288322;6909.619970901648;6928.618925959121;6575.835604109744;6586.934130658632;6637.966810165918;6640.269570347355;6642.6014439133805;7718;7785.377169826287;7786.961065194638;7818.609069546386;7832.843343132991;7283.271672832674;7450.329470347695;7538.09542854861;8031.518108913484;8055.315298199719;6636.634985075867;6715.597064176165;6727.495437842083;6730.057791909038;6736.056952026622;5890.175375447527;6727.8990815138795;6937.791866244021;6943.132108486439;6958.8956165658565;5835.854103647443;6508.511861610304;6528.608283502815;6579.769708060195;6639.302873198245;6460;6462.967685161544;6522.184726909137;6546.443552298108;6616.900746488903;6396.200474940632;6445.709943052668;6505.186851643544;6595.736170553124;6605.04226887089;6064.727087280995;6122.5408094392205;6127.050307202391;6130.386961304012;6133.7546498141355;6093.146959425595;6115.205023346936;6168.629882207082;6171.506279497719;6172.4136207060255 11:24:11 INFO - 2015-12-03 11:24:11,110 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.33107511486486;302.6867192455807;305.28563162200453;309.06353748143135;309.23001725702994;5175.715335656542;5182.378114626245;5275.472452754722;5290.7354632268425;5298.258243845865;5166.302549155863;5178.0679477694;5183.144781111121;5185.611079169059;5191.792328306863;3906.785126818024;4102.282100632392;4104.076582768868;4113.9794301028605;4122.525909520414;3994.700397470187;4004.7196696231276;4062.1469491406842;4074.3684728866924;4082.3876418537307;4021.3163762160502;4043.8584649537274;4051.6758659307184;4056.452378928851;4080.1227736036744;3855.4795102661064;3932.842686292545;3968.72218944674;4080.5307389650275;4087.591240875918;3583.623719509466;3610.819459027038;3619.7647152934974;3622.8188590570367;3623.5289412376223;4996.7501624918605;5037.042961837239;5040.899182016339;5045.798168073273;5048.671836330626;4687.812487500496;4693.906121877578;4699.5535424135;4700.529947005306;4703.035877645075;5375.973120134374;5499.092649712793;5502.339719233718;5503.257060296889;5523.6409633374105;3927.1556615327554;3943.861964831246;3947.2894878921784;3951.3480275754464;3953.1303113315025;5790.10253410722;5791.971040144815;5792.131180322943;5800.187973683687;5805.4194580542035;4058.289799285113;4062.6749860011128;4068.5117785865295;4071.267171909085;4073.1446396256524;3858.401947698111;3949.7235193536753;4128.855490057834;4131.793410329472;4133.925179453364;4180.143070670566;4559.794809233593;4570.542945705402;4584.3352713856975;4678.2280923647895;5359.839204823861;5513.476219759116;5531.861703457365;5533.750981205855;5545.584081193927;1392.373431955624;1395.4069520453766;1396.1623026184411;1397.7134687389062;1398.1331574423718;944.2257348973912;955.4697143085515;958.6740508227236;969.3989726369555;969.7236287657984;4842.903141937141;4852.757362131879;4859.441164266084;4859.732714700725;4860.756962151878;5728.026235539968;5728.885422291531;5731;5731.054376027909;5745.9425405745405;4824;4829.613630909519;4844.249141383091;4850.53919877611;4851.830185943475;2854.1437568729298;2889.7688184945155;3049.9847500762353;3083.105899289181;3084.3368675734823;5337.226102215234;5449.754761035763;5463.426340234298;5466.043442397644;5470;5935.0503919372695;5937.139114828412;5938.435848594377;5946.494547963472;5949;5394.379646340564;5450.4549545045975;5452.482014208723;5460.208269800856;5462.317210348627;5532.972335138459;5719.628224165416;5719.685417302088;5730.054541000855;5741.971290143522;5632;5666.660000399989;5671.716414179192;5685;5688.715564221855;5445.319335083114;5446.291982042309;5454.072807622634;5456.345238571397;5462.371827239759;4030.576789437067;4064.532578753481;4070.6539944105084;4073.7759423230823;4077.734947228539;5573.6098473106495;5638.238837757014;5692.459216374438;5704.629199102211;5708.828735137952;5479.369872464717;5480.561555075505;5506.5870059744875;5506.779728810803;5509.834704958857;5505.834824955257;5511.53151982086;5511.862203444946;5514.117741161395;5515.834524964257;5187.922181167361;5364.785408583613;5383.08487557124;5400.783968641211;5402.432744561765;5552.52803511706;5557.610967232416;5566.165075238747;5566.721663916707;5566.91649625264;5225.686458812484;5350.759215835375;5407.702576358338;5410.810621628224;5495.642783219078 11:24:11 INFO - 2015-12-03 11:24:11,111 DEBUG : BROWSER_OUTPUT: |5;yui.html;737.7270409948324;744.3635691483781;744.7244519527776;760.2587477209718;775.3487070860477;12394.566190183334;12702.618921432371;12722.173058751174;12738.426770795324;12742.108052436322;10328.225383096278;11506.884931150686;11572.421378931042;11601.361925094116;11610.709732256697;605.4097255176201;777.0442355902244;791.1060501633175;791.5171745235402;791.6002418778509;769.2154002917022;785.505131766986;785.6582386661792;785.7721260834351;786.3512602103259;633.8605506788499;639.066962235135;804.4127786715701;821.6343727041469;829.6515463505342;806.4838503357855;806.8668669669527;806.995965020177;807.1121766057348;807.1484583764127;592.1118322516226;594.4976494861835;596.3678500789177;597.1162679234714;598.2432223237608;12038.277703337828;12247.081468889868;12252.326122063283;12294.692632684166;12301.200421972542;10687.946560267226;11489.770204595861;11494;11565.479553420117;11895.04839612829;9387.389819661701;9396.812063758687;9433.811323773487;9490.098440648197;9609;3261.3803377358226;3271.96728032719;3308.4375656138513;3321.086701157177;3321.8671253150087;41732.956676083035;41761;42147.36778948287;42284.57715422837;42295;9305;9348.065193480734;9396.248300135972;9404.294677899185;9423.528823558794;16035.919820400823;16058.598535036484;16061.919690401473;16070.75893861593;16072;6161.353057928853;6239.126522286883;6269.122322874801;6355.046742988588;6426.839329016812;3497;3505.859765609347;3526.735494837846;3560.893173204808;3600.6219346968714;2678.3571942733993;2716.2937636214333;2720.9932325039863;2721.088435374132;2722.9591556126675;470.4166833126898;472.8817795551112;473.4484325760519;473.8507370178383;491.92129259318335;539.9568034557226;551.8868631930445;568.1931657047003;593.3443544882842;596.5555661032558;7015.761559722159;7098.822529436702;7233;7273.199948005715;7333.596652184181;555.6082961512125;561.581621691834;566.1055532259021;601.7803501721927;602.2983224543358;3352.3946031224687;3447.67247111524;3608.5850127235703;3669.284489524517;4006.959930400717;42222.366664500056;42820.35769463461;42823;42995.35506967398;48052.27921581179;41613.375799363035;41866.162676746906;42069.36895946563;42176.78911605422;42225.15549688989;40273.19453610911;40760.1847963045;40999.975000624625;41296;41304;7695.538267703956;7864.2922137007945;8043.638036288498;8166.632501537326;8467.91532084696;31063.378732425677;31336.843315784186;32030;32108.357832843678;33329.166770830925;40553;40560;40594;41439;41469.37795933003;9893.851592226267;9911.157551608194;10144.376899696013;10223;10236.232282578687;11069.5572177112;11087.279326843729;11245.7750844981;11363.659090227306;11373.886261137282;9792.853107203255;9883.555240014073;9957.651482198089;11508.251963622337;11517.596884109016;10888.564457421931;10907.181961352771;11184.552617895519;11279.492422841156;11617.47721352558;10643.308184967953;11210.775784484102;11357.886421135683;11413.543458261576;11495.655130346104;9079.137481939206;9233.538323083952;9481.194098501705;9530.1899338557;9834.557444914853;8421.536815475207;8622.966117679782;8974.237189838937;9342;9435.905640943503 11:24:11 INFO - 2015-12-03 11:24:11,111 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:24:11 INFO - 2015-12-03 11:24:11,111 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1023 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: __startTimestamp1449170651100__endTimestamp 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4581.90 Median:4697.06 stddev:485.13 (10.3%) stddev-sans-first:460.05 11:24:11 INFO - 2015-12-03 11:24:11,112 DEBUG : BROWSER_OUTPUT: Values: 2563.4 2667.1 2671.1 2678.0 2693.3 4372.0 4481.7 4529.0 4613.9 4637.9 4554.4 4617.3 4628.3 4631.1 4631.6 4140.4 4230.0 4261.4 4337.3 4370.5 4037.0 4275.0 4286.8 4339.4 4375.5 4205.1 4211.7 4248.0 4278.5 4292.5 4234.4 4235.6 4263.9 4269.6 4275.8 4085.1 4204.6 4223.5 4227.1 4265.3 4483.9 4496.0 4523.0 4538.7 4573.2 4904.4 5012.7 5046.3 5046.6 5094.8 4862.1 5036.5 5056.7 5067.6 5071.1 4524.8 4546.0 4550.3 4553.6 4613.1 5104.6 5134.6 5139.9 5145.8 5146.5 4927.9 4928.1 4934.5 4937.9 4978.1 4781.5 4873.4 4875.1 4916.7 5046.0 4999.2 5039.0 5039.9 5042.5 5087.5 4994.9 5007.0 5009.3 5010.4 5013.1 4001.6 4084.7 4085.6 4114.3 4178.3 3685.1 3688.2 3696.7 3698.3 3728.4 4333.9 4334.2 4334.6 4364.8 4369.0 4732.3 4841.0 4842.8 4949.9 5031.9 4254.4 4272.7 4273.1 4276.9 4310.9 4407.9 4408.7 4411.5 4416.5 4456.0 4579.0 4638.4 4693.5 4694.3 4766.0 4992.6 5011.1 5017.7 5018.3 5019.9 4717.8 4741.1 4741.9 4780.0 4787.9 4709.9 4797.6 4808.5 4825.7 4961.8 4983.1 4994.1 4999.3 5011.2 5013.9 4859.0 4862.8 4865.7 4866.0 4899.3 4686.6 4758.2 4803.4 4811.6 4884.8 4632.8 4697.1 4700.5 4704.2 4755.1 4885.4 4916.6 4917.6 4918.5 4963.2 4661.0 4768.0 4808.7 4816.8 4822.3 11:24:11 INFO - 2015-12-03 11:24:11,113 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,113 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43501.93 Median:34008.57 stddev:74040.86 (217.7%) stddev-sans-first:74178.37 11:24:11 INFO - 2015-12-03 11:24:11,113 DEBUG : BROWSER_OUTPUT: Values: 562.5 568.9 573.9 577.0 578.3 26933.0 27631.3 35959.3 36084.0 36392.8 38307.6 38771.4 38848.2 38922.0 38941.4 6952.0 7848.8 8014.5 8017.7 8020.2 7038.2 10026.5 10366.3 10367.2 10372.1 9730.0 9797.7 9803.7 9804.9 9811.8 7119.2 7298.5 9864.5 9952.6 10047.3 9771.0 9904.5 9909.2 9919.5 9925.9 35560.5 35951.8 36033.1 36034.3 36038.3 2925.5 2939.4 2957.6 3423.6 3584.7 26973.5 27051.9 27366.6 27485.6 28034.2 3230.0 3478.1 3494.7 3522.4 3580.6 214967.0 215915.0 218093.0 218294.0 218439.0 50809.0 51456.2 54196.7 54692.5 54782.7 63766.7 66235.3 66247.0 66248.0 66318.0 12522.5 12630.2 12668.0 12670.1 12675.9 9990.3 10010.9 10074.4 10077.7 10080.0 18732.3 18765.8 18796.9 18888.0 18965.4 7370.0 7646.4 7674.3 7728.8 7748.5 831.3 884.4 902.5 913.7 949.0 26280.0 26407.1 26696.3 26755.9 26835.3 941.7 977.2 1001.2 1073.9 1076.3 14229.0 15124.8 15304.5 15342.4 15425.2 308151.0 313866.0 314494.0 314739.0 315795.0 47398.8 47695.0 47781.5 47807.5 47813.8 1017.9 1101.3 1195.9 1197.9 1212.6 25069.9 25793.9 26336.7 26607.3 26621.0 35553.6 37931.8 38430.2 38478.2 38552.8 161785.2 326742.0 333202.0 333601.0 334065.0 28062.4 28670.0 28676.4 28695.7 28715.9 36414.5 36988.0 37760.0 37793.4 37805.4 31915.6 32690.7 33232.0 33604.5 33686.8 32830.5 37127.0 38716.6 38815.8 39304.6 33885.7 34001.0 34016.1 34100.5 34214.3 30084.4 30433.4 30692.0 30803.2 31089.4 24084.4 24408.6 24469.6 24558.9 24832.4 11:24:11 INFO - 2015-12-03 11:24:11,113 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,113 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25163.32 Median:450961.50 stddev:74190.18 (16.5%) stddev-sans-first:74374.89 11:24:11 INFO - 2015-12-03 11:24:11,114 DEBUG : BROWSER_OUTPUT: Values: 336.7 337.1 338.6 339.2 340.4 12291.1 12722.9 14986.6 15016.8 16216.2 11790.3 13834.7 14178.6 14644.9 14719.1 4726.8 5063.4 5222.1 5224.0 6096.0 3566.4 3657.3 5712.5 5873.0 6010.2 5632.9 5762.3 5785.9 5816.7 5817.4 5715.9 5745.5 5748.8 5761.9 5768.4 4931.7 5046.2 5048.0 5059.5 5066.2 18979.2 18980.2 19197.9 19482.3 19638.3 1618.7 1659.9 1853.5 2012.6 2405.5 8772.7 8843.8 8936.7 9061.7 12405.6 1689.4 1738.0 1775.7 1778.4 1791.5 51794.5 52919.9 53064.7 53146.5 54285.2 9721.9 9763.5 9790.4 9830.5 9838.5 12495.9 12529.7 12532.0 12544.0 12566.7 6870.5 6873.2 6910.6 6954.5 7015.6 6333.1 6366.4 6377.3 6393.4 6446.1 4121.9 4128.5 4153.5 4161.5 4171.7 1573.5 1613.5 1668.9 1726.1 1729.2 837.7 897.2 901.9 903.2 954.3 12476.8 14091.2 14119.4 14580.9 14942.3 854.0 854.1 864.8 876.7 877.4 8268.9 8597.6 8691.2 8751.1 8754.7 450367.0 451556.0 451816.0 456912.0 460115.0 66826.3 69545.7 69990.0 70330.6 71083.6 965.5 993.8 994.4 998.7 1026.0 14265.6 14270.5 14398.5 14467.6 14568.6 31642.2 31834.7 32222.2 33216.8 33305.2 42686.6 43317.1 44866.0 45013.1 46085.0 8596.1 8660.6 8793.9 8814.9 8991.6 15433.3 15693.5 15803.7 15975.6 16183.0 12878.7 13192.2 13605.8 13615.9 13705.3 12684.2 13084.8 13278.9 13671.7 13737.5 9235.5 12534.4 12780.7 12896.0 13602.5 8575.2 8611.6 8653.3 8703.5 8724.7 9104.7 9395.7 12388.1 12503.9 12523.2 11:24:11 INFO - 2015-12-03 11:24:11,114 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,115 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4979.79 Median:6477.06 stddev:2584.45 (39.9%) stddev-sans-first:2576.18 11:24:11 INFO - 2015-12-03 11:24:11,115 DEBUG : BROWSER_OUTPUT: Values: 1211.9 1567.3 1616.1 1634.9 1652.4 6002.5 7085.9 7200.4 7210.8 7214.1 7015.5 7154.2 7161.5 7169.1 7177.9 1749.8 1777.6 1779.0 2057.5 2087.6 1793.4 1799.8 2044.4 2078.4 2084.2 2053.9 2067.4 2079.7 2080.2 2086.9 2026.4 2055.6 2068.6 2070.5 2075.8 2040.0 2074.3 2078.8 2085.9 2113.5 7113.5 7184.4 7197.9 7202.9 7217.8 4051.3 4070.5 4085.7 4109.6 4126.9 2677.9 2708.6 2731.0 2741.7 2751.8 861.1 870.5 881.0 895.6 897.2 9404.9 9411.3 9413.0 9431.3 9434.6 3887.7 3938.9 3954.3 3957.9 4032.4 8151.7 8193.4 8204.1 8209.5 8216.2 4126.8 4138.7 4141.0 4145.9 4147.8 3780.1 3781.1 3781.5 3782.4 3785.7 3406.8 3423.3 3475.3 3477.2 3491.7 938.7 963.8 1096.5 1137.7 1141.5 837.7 856.7 858.3 858.5 1015.1 6744.2 6749.1 6796.4 6819.7 6828.8 1007.4 1031.9 1033.0 1052.4 1054.7 5147.7 5259.3 5261.6 5283.2 5288.4 8182.1 8229.3 8516.4 8711.4 8734.8 8265.8 8295.2 8332.5 8334.1 8359.6 6491.2 6793.1 6793.5 6909.6 6928.6 6575.8 6586.9 6638.0 6640.3 6642.6 7718.0 7785.4 7787.0 7818.6 7832.8 7283.3 7450.3 7538.1 8031.5 8055.3 6636.6 6715.6 6727.5 6730.1 6736.1 5890.2 6727.9 6937.8 6943.1 6958.9 5835.9 6508.5 6528.6 6579.8 6639.3 6460.0 6463.0 6522.2 6546.4 6616.9 6396.2 6445.7 6505.2 6595.7 6605.0 6064.7 6122.5 6127.1 6130.4 6133.8 6093.1 6115.2 6168.6 6171.5 6172.4 11:24:11 INFO - 2015-12-03 11:24:11,115 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,115 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4583.18 Median:5186.77 stddev:1344.50 (25.9%) stddev-sans-first:1309.19 11:24:11 INFO - 2015-12-03 11:24:11,116 DEBUG : BROWSER_OUTPUT: Values: 295.3 302.7 305.3 309.1 309.2 5175.7 5182.4 5275.5 5290.7 5298.3 5166.3 5178.1 5183.1 5185.6 5191.8 3906.8 4102.3 4104.1 4114.0 4122.5 3994.7 4004.7 4062.1 4074.4 4082.4 4021.3 4043.9 4051.7 4056.5 4080.1 3855.5 3932.8 3968.7 4080.5 4087.6 3583.6 3610.8 3619.8 3622.8 3623.5 4996.8 5037.0 5040.9 5045.8 5048.7 4687.8 4693.9 4699.6 4700.5 4703.0 5376.0 5499.1 5502.3 5503.3 5523.6 3927.2 3943.9 3947.3 3951.3 3953.1 5790.1 5792.0 5792.1 5800.2 5805.4 4058.3 4062.7 4068.5 4071.3 4073.1 3858.4 3949.7 4128.9 4131.8 4133.9 4180.1 4559.8 4570.5 4584.3 4678.2 5359.8 5513.5 5531.9 5533.8 5545.6 1392.4 1395.4 1396.2 1397.7 1398.1 944.2 955.5 958.7 969.4 969.7 4842.9 4852.8 4859.4 4859.7 4860.8 5728.0 5728.9 5731.0 5731.1 5745.9 4824.0 4829.6 4844.2 4850.5 4851.8 2854.1 2889.8 3050.0 3083.1 3084.3 5337.2 5449.8 5463.4 5466.0 5470.0 5935.1 5937.1 5938.4 5946.5 5949.0 5394.4 5450.5 5452.5 5460.2 5462.3 5533.0 5719.6 5719.7 5730.1 5742.0 5632.0 5666.7 5671.7 5685.0 5688.7 5445.3 5446.3 5454.1 5456.3 5462.4 4030.6 4064.5 4070.7 4073.8 4077.7 5573.6 5638.2 5692.5 5704.6 5708.8 5479.4 5480.6 5506.6 5506.8 5509.8 5505.8 5511.5 5511.9 5514.1 5515.8 5187.9 5364.8 5383.1 5400.8 5402.4 5552.5 5557.6 5566.2 5566.7 5566.9 5225.7 5350.8 5407.7 5410.8 5495.6 11:24:11 INFO - 2015-12-03 11:24:11,116 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,116 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12154.44 Median:42557.68 stddev:13449.27 (31.6%) stddev-sans-first:13459.67 11:24:11 INFO - 2015-12-03 11:24:11,116 DEBUG : BROWSER_OUTPUT: Values: 737.7 744.4 744.7 760.3 775.3 12394.6 12702.6 12722.2 12738.4 12742.1 10328.2 11506.9 11572.4 11601.4 11610.7 605.4 777.0 791.1 791.5 791.6 769.2 785.5 785.7 785.8 786.4 633.9 639.1 804.4 821.6 829.7 806.5 806.9 807.0 807.1 807.1 592.1 594.5 596.4 597.1 598.2 12038.3 12247.1 12252.3 12294.7 12301.2 10687.9 11489.8 11494.0 11565.5 11895.0 9387.4 9396.8 9433.8 9490.1 9609.0 3261.4 3272.0 3308.4 3321.1 3321.9 41733.0 41761.0 42147.4 42284.6 42295.0 9305.0 9348.1 9396.2 9404.3 9423.5 16035.9 16058.6 16061.9 16070.8 16072.0 6161.4 6239.1 6269.1 6355.0 6426.8 3497.0 3505.9 3526.7 3560.9 3600.6 2678.4 2716.3 2721.0 2721.1 2723.0 470.4 472.9 473.4 473.9 491.9 540.0 551.9 568.2 593.3 596.6 7015.8 7098.8 7233.0 7273.2 7333.6 555.6 561.6 566.1 601.8 602.3 3352.4 3447.7 3608.6 3669.3 4007.0 42222.4 42820.4 42823.0 42995.4 48052.3 41613.4 41866.2 42069.4 42176.8 42225.2 40273.2 40760.2 41000.0 41296.0 41304.0 7695.5 7864.3 8043.6 8166.6 8467.9 31063.4 31336.8 32030.0 32108.4 33329.2 40553.0 40560.0 40594.0 41439.0 41469.4 9893.9 9911.2 10144.4 10223.0 10236.2 11069.6 11087.3 11245.8 11363.7 11373.9 9792.9 9883.6 9957.7 11508.3 11517.6 10888.6 10907.2 11184.6 11279.5 11617.5 10643.3 11210.8 11357.9 11413.5 11495.7 9079.1 9233.5 9481.2 9530.2 9834.6 8421.5 8623.0 8974.2 9342.0 9435.9 11:24:11 INFO - 2015-12-03 11:24:11,116 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:24:11 INFO - 2015-12-03 11:24:11,117 DEBUG : BROWSER_OUTPUT: 11:24:11 INFO - 2015-12-03 11:24:11,901 INFO : Browser exited with error code: 0 11:24:11 INFO - 2015-12-03 11:24:11,920 INFO : Completed test dromaeo_css (00:18:37) 11:24:11 INFO - 2015-12-03 11:24:11,920 INFO : Starting test kraken 11:24:11 INFO - 2015-12-03 11:24:11,920 DEBUG : operating with platform_type : linux_ 11:24:11 INFO - 2015-12-03 11:24:11,920 INFO : Initialising browser for kraken test... 11:24:11 INFO - 2015-12-03 11:24:11,926 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2uAGSq/profile http://localhost:40688/getInfo.html 11:24:16 INFO - 2015-12-03 11:24:16,040 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:24:16 INFO - 2015-12-03 11:24:16,041 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:24:16 INFO - 2015-12-03 11:24:16,041 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:24:16 INFO - 2015-12-03 11:24:16,041 DEBUG : BROWSER_OUTPUT: __metrics 11:24:16 INFO - 2015-12-03 11:24:16,125 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:24:16 INFO - 2015-12-03 11:24:16,209 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:24:17 INFO - 2015-12-03 11:24:17,095 INFO : Browser initialized. 11:24:17 INFO - 2015-12-03 11:24:17,096 INFO : Running cycle 1/1 for kraken test... 11:24:17 INFO - 2015-12-03 11:24:17,096 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2uAGSq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:24:29 INFO - 2015-12-03 11:24:29,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 143757312 11:24:29 INFO - 2015-12-03 11:24:29,196 DEBUG : BROWSER_OUTPUT: 11:24:31 INFO - 2015-12-03 11:24:31,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40688/tests/kraken/driver.html?testName=audio-beat-detection) 11:24:32 INFO - 2015-12-03 11:24:32,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 181145600 11:24:32 INFO - 2015-12-03 11:24:32,364 DEBUG : BROWSER_OUTPUT: 11:24:35 INFO - 2015-12-03 11:24:35,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40688/tests/kraken/driver.html?testName=audio-dft) 11:24:35 INFO - 2015-12-03 11:24:35,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 169656320 11:24:35 INFO - 2015-12-03 11:24:35,654 DEBUG : BROWSER_OUTPUT: 11:24:38 INFO - 2015-12-03 11:24:38,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40688/tests/kraken/driver.html?testName=audio-fft) 11:24:39 INFO - 2015-12-03 11:24:39,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 154173440 11:24:39 INFO - 2015-12-03 11:24:39,244 DEBUG : BROWSER_OUTPUT: 11:24:41 INFO - 2015-12-03 11:24:41,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40688/tests/kraken/driver.html?testName=audio-oscillator) 11:24:41 INFO - 2015-12-03 11:24:41,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 154779648 11:24:41 INFO - 2015-12-03 11:24:41,877 DEBUG : BROWSER_OUTPUT: 11:24:44 INFO - 2015-12-03 11:24:44,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:44 INFO - 2015-12-03 11:24:44,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 158117888 11:24:44 INFO - 2015-12-03 11:24:44,683 DEBUG : BROWSER_OUTPUT: 11:24:47 INFO - 2015-12-03 11:24:47,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40688/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:48 INFO - 2015-12-03 11:24:48,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 156114944 11:24:48 INFO - 2015-12-03 11:24:48,255 DEBUG : BROWSER_OUTPUT: 11:24:51 INFO - 2015-12-03 11:24:51,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40688/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:52 INFO - 2015-12-03 11:24:52,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 158035968 11:24:52 INFO - 2015-12-03 11:24:52,244 DEBUG : BROWSER_OUTPUT: 11:24:55 INFO - 2015-12-03 11:24:55,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40688/tests/kraken/driver.html?testName=json-parse-financial) 11:24:55 INFO - 2015-12-03 11:24:55,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 158023680 11:24:55 INFO - 2015-12-03 11:24:55,680 DEBUG : BROWSER_OUTPUT: 11:24:57 INFO - 2015-12-03 11:24:57,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:58 INFO - 2015-12-03 11:24:58,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 167927808 11:24:58 INFO - 2015-12-03 11:24:58,041 DEBUG : BROWSER_OUTPUT: 11:24:59 INFO - 2015-12-03 11:24:59,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:00 INFO - 2015-12-03 11:25:00,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 167460864 11:25:00 INFO - 2015-12-03 11:25:00,529 DEBUG : BROWSER_OUTPUT: 11:25:02 INFO - 2015-12-03 11:25:02,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:03 INFO - 2015-12-03 11:25:03,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 179429376 11:25:03 INFO - 2015-12-03 11:25:03,286 DEBUG : BROWSER_OUTPUT: 11:25:05 INFO - 2015-12-03 11:25:05,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:06 INFO - 2015-12-03 11:25:06,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 184233984 11:25:06 INFO - 2015-12-03 11:25:06,447 DEBUG : BROWSER_OUTPUT: 11:25:09 INFO - 2015-12-03 11:25:09,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:09 INFO - 2015-12-03 11:25:09,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 182444032 11:25:09 INFO - 2015-12-03 11:25:09,675 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40688/tests/kraken/driver.html?testName=ai-astar) 11:25:11 INFO - 2015-12-03 11:25:11,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 240369664 11:25:11 INFO - 2015-12-03 11:25:11,679 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,680 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:25:11 INFO - 2015-12-03 11:25:11,680 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:25:11 INFO - 2015-12-03 11:25:11,680 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:25:11 INFO - 2015-12-03 11:25:11,681 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:25:11 INFO - 2015-12-03 11:25:11,681 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;104;110;112;112;102;111;112;106 11:25:11 INFO - 2015-12-03 11:25:11,681 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;153;172;131;153;151;130;164;140 11:25:11 INFO - 2015-12-03 11:25:11,681 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;159;160;159;161;162;161;161 11:25:11 INFO - 2015-12-03 11:25:11,682 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;82;93;73;71;71;114;90;72 11:25:11 INFO - 2015-12-03 11:25:11,682 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;127;95;94;94;135;95;95;132 11:25:11 INFO - 2015-12-03 11:25:11,682 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;109 11:25:11 INFO - 2015-12-03 11:25:11,682 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;147;147;147;146;147;146;147 11:25:11 INFO - 2015-12-03 11:25:11,682 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;94;95;96;95;95 11:25:11 INFO - 2015-12-03 11:25:11,682 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;70;70;70;70;69;70;83;69;67 11:25:11 INFO - 2015-12-03 11:25:11,684 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;68;69;67;68;67;68 11:25:11 INFO - 2015-12-03 11:25:11,684 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;84;85;85;85;85;85;85;85 11:25:11 INFO - 2015-12-03 11:25:11,684 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;122;123;119;129;121;128;122;128;121 11:25:11 INFO - 2015-12-03 11:25:11,684 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;151;149;160;156;141;151;152;151;139 11:25:11 INFO - 2015-12-03 11:25:11,684 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;72;71;71;69;69;71;73;71 11:25:11 INFO - 2015-12-03 11:25:11,685 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:25:11 INFO - 2015-12-03 11:25:11,685 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:25:11 INFO - 2015-12-03 11:25:11,685 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 11:25:11 INFO - 2015-12-03 11:25:11,685 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:25:11 INFO - 2015-12-03 11:25:11,685 DEBUG : BROWSER_OUTPUT: __startTimestamp1449170711680__endTimestamp 11:25:11 INFO - 2015-12-03 11:25:11,685 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,688 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:25:11 INFO - 2015-12-03 11:25:11,688 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:111.50 stddev:3.77 (3.4%) stddev-sans-first:3.94 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 104.0 110.0 112.0 112.0 102.0 111.0 112.0 106.0 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:153.00 stddev:14.88 (9.7%) stddev-sans-first:15.49 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 153.0 172.0 131.0 153.0 151.0 130.0 164.0 140.0 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 159.0 160.0 159.0 161.0 162.0 161.0 161.0 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:73.00 stddev:14.24 (19.5%) stddev-sans-first:14.80 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 82.0 93.0 73.0 71.0 71.0 114.0 90.0 72.0 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.50 stddev:17.86 (18.9%) stddev-sans-first:18.53 11:25:11 INFO - 2015-12-03 11:25:11,689 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 127.0 95.0 94.0 94.0 135.0 95.0 95.0 132.0 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.00 stddev:4.42 (6.3%) stddev-sans-first:4.65 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 70.0 69.0 70.0 83.0 69.0 67.0 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 68.0 69.0 67.0 68.0 67.0 68.0 11:25:11 INFO - 2015-12-03 11:25:11,690 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 84.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.50 stddev:5.22 (4.2%) stddev-sans-first:3.67 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: Values: 136.0 122.0 123.0 119.0 129.0 121.0 128.0 122.0 128.0 121.0 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:151.00 stddev:6.21 (4.1%) stddev-sans-first:6.58 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: Values: 151.0 151.0 149.0 160.0 156.0 141.0 151.0 152.0 151.0 139.0 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.29 (1.8%) stddev-sans-first:1.32 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 72.0 71.0 71.0 69.0 69.0 71.0 73.0 71.0 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:25:11 INFO - 2015-12-03 11:25:11,691 DEBUG : BROWSER_OUTPUT: 11:25:12 INFO - 2015-12-03 11:25:12,557 INFO : Browser exited with error code: 0 11:25:12 INFO - 2015-12-03 11:25:12,612 INFO : Completed test kraken (00:01:00) 11:25:12 INFO - 2015-12-03 11:25:12,612 INFO : Starting test v8_7 11:25:12 INFO - 2015-12-03 11:25:12,612 DEBUG : operating with platform_type : linux_ 11:25:12 INFO - 2015-12-03 11:25:12,612 INFO : Initialising browser for v8_7 test... 11:25:12 INFO - 2015-12-03 11:25:12,618 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX4VriX/profile http://localhost:40688/getInfo.html 11:25:16 INFO - 2015-12-03 11:25:16,759 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:25:16 INFO - 2015-12-03 11:25:16,759 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:25:16 INFO - 2015-12-03 11:25:16,759 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:25:16 INFO - 2015-12-03 11:25:16,759 DEBUG : BROWSER_OUTPUT: __metrics 11:25:16 INFO - 2015-12-03 11:25:16,835 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:25:16 INFO - 2015-12-03 11:25:16,896 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:17 INFO - 2015-12-03 11:25:17,837 INFO : Browser initialized. 11:25:17 INFO - 2015-12-03 11:25:17,838 INFO : Running cycle 1/1 for v8_7 test... 11:25:17 INFO - 2015-12-03 11:25:17,838 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX4VriX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:25:29 INFO - 2015-12-03 11:25:29,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 142827520 11:25:29 INFO - 2015-12-03 11:25:29,808 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40688/tests/v8_7/run.html (next: http://localhost:40688/tests/v8_7/run.html) 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 459309056 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: |0;Richards;165.31658125309968 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.74136321195144 11:25:51 INFO - 2015-12-03 11:25:51,525 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: |6;Boyer;12035.714285714286 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: |8;Splay;708.2152974504249 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: __startTimestamp1449170751518__endTimestamp 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.32 Median:165.32 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,526 DEBUG : BROWSER_OUTPUT: Values: 165.3 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.74 Median:186.74 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: Values: 186.7 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: Values: 278.1 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,527 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: Values: 5202.1 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: Values: 1978.3 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: Values: 784.3 11:25:51 INFO - 2015-12-03 11:25:51,528 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12035.71 Median:12035.71 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: Values: 12035.7 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: Values: 26153.8 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:708.22 Median:708.22 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,529 DEBUG : BROWSER_OUTPUT: Values: 708.2 11:25:51 INFO - 2015-12-03 11:25:51,530 DEBUG : BROWSER_OUTPUT: 11:25:51 INFO - 2015-12-03 11:25:51,530 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:25:51 INFO - 2015-12-03 11:25:51,530 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:25:51 INFO - 2015-12-03 11:25:51,530 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:25:51 INFO - 2015-12-03 11:25:51,530 DEBUG : BROWSER_OUTPUT: 11:25:52 INFO - 2015-12-03 11:25:52,378 INFO : Browser exited with error code: 0 11:25:52 INFO - 2015-12-03 11:25:52,392 INFO : Completed test v8_7 (00:00:39) 11:25:52 INFO - 2015-12-03 11:25:52,501 INFO : Completed test suite (00:20:17) 11:25:52 INFO - 2015-12-03 11:25:52,501 DEBUG : Working with test: dromaeo_css 11:25:52 INFO - 2015-12-03 11:25:52,502 DEBUG : Generating results file: dromaeo_css 11:25:52 INFO - 2015-12-03 11:25:52,503 DEBUG : Working with test: kraken 11:25:52 INFO - 2015-12-03 11:25:52,503 DEBUG : Generating results file: kraken 11:25:52 INFO - 2015-12-03 11:25:52,503 INFO : javascript benchmark 11:25:52 INFO - 2015-12-03 11:25:52,503 DEBUG : Working with test: v8_7 11:25:52 INFO - 2015-12-03 11:25:52,503 DEBUG : Generating results file: v8_7 11:25:52 INFO - 2015-12-03 11:25:52,504 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:25:52 INFO - 2015-12-03 11:25:52,565 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:25:52 INFO - 2015-12-03 11:25:52,565 DEBUG : process_Request line: dromaeo_css 6291.11 graph.html#tests=[[72,132,35]] 11:25:52 INFO - 2015-12-03 11:25:52,566 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:25:52 INFO - 2015-12-03 11:25:52,598 DEBUG : process_Request line: kraken 1524.30 graph.html#tests=[[232,132,35]] 11:25:52 INFO - 2015-12-03 11:25:52,598 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:25:52 INFO - 2015-12-03 11:25:52,627 DEBUG : process_Request line: v8_7 19590.51 graph.html#tests=[[230,132,35]] 11:25:52 INFO - 2015-12-03 11:25:52,628 INFO : javascript benchmark 11:25:52 INFO - 2015-12-03 11:25:52,632 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2563.423229773301, 2667.053196115378, 2671.118530884808, 2677.986610066949, 2693.326668332916, 4372.0, 4481.731096134226, 4529.0, 4613.907721845565, 4637.930431043533, 4554.362389265505, 4617.330487079372, 4628.328892310613, 4631.091043493899, 4631.629469642429, 4140.420341152241, 4229.97885010576, 4261.424707664472, 4337.262665346899, 4370.475542934836, 4036.979815100935, 4274.97862510687, 4286.807093680792, 4339.435873336462, 4375.496817865938, 4205.07488352565, 4211.684123690736, 4248.001719595893, 4278.529361770203, 4292.506361768405, 4234.407182994383, 4235.555266696983, 4263.936040959357, 4269.6370808481315, 4275.828966841323, 4085.142120154771, 4204.558521355244, 4223.535411104776, 4227.112306415656, 4265.253580623409, 4483.865484035484, 4496.033352829125, 4523.0, 4538.682292239545, 4573.176828170928, 4904.362432883738, 5012.674176178537, 5046.318746969149, 5046.646734728571, 5094.79620815167, 4862.100511405366, 5036.546710796046, 5056.747162641853, 5067.6452648314635, 5071.087204303224, 4524.8416305429155, 4545.954540454586, 4550.340200670884, 4553.590176884063, 4613.077384523109, 5104.566111880457, 5134.640575159778, 5139.922901156486, 5145.76844042019, 5146.485351464824, 4927.901441971212, 4928.088303663833, 4934.481879402683, 4937.901241975141, 4978.079055374767, 4781.497942716034, 4873.41519017713, 4875.098106850244, 4916.655834091579, 5046.016026874798, 4999.175136102575, 5038.974805125951, 5039.899202015939, 5042.546170844642, 5087.516685914832, 4994.850154495371, 5007.0, 5009.298698182258, 5010.398752149693, 5013.147764879979, 4001.639852413297, 4084.6732261419015, 4085.571015043437, 4114.321137012359, 4178.331466965271, 3685.0971511979737, 3688.188598508324, 3696.7412281140064, 3698.2788356270808, 3728.366177749789, 4333.8699839004885, 4334.176506463762, 4334.631556317749, 4364.8472303469225, 4368.956310436918, 4732.337472753818, 4840.975795121002, 4842.806287748521, 4949.876253093629, 5031.874203144877, 4254.404383386328, 4272.700910936267, 4273.1026484438, 4276.914461710749, 4310.913781724348, 4407.933880991788, 4408.669349798778, 4411.536788637147, 4416.514183439819, 4455.997400584843, 4578.9771051144535, 4638.443386793471, 4693.530646935279, 4694.3427920090535, 4766.046790641816, 4992.600591952708, 5011.072951503984, 5017.67385119966, 5018.272350509229, 5019.874503137451, 4717.764111794465, 4741.122892264942, 4741.881452963704, 4779.976100119477, 4787.904241915212, 4709.882252943704, 4797.616190704805, 4808.519148085164, 4825.662203645711, 4961.7519124044375, 4983.103041452428, 4994.101061808909, 4999.325091112653, 5011.223260394645, 5013.924791128063, 4858.95141048585, 4862.781174847211, 4865.659403841839, 4866.0024694938165, 4899.289603007473, 4686.625069994324, 4758.214894542361, 4803.375561177025, 4811.615070794258, 4884.78018489176, 4632.814687412466, 4697.060587882505, 4700.506446823171, 4704.176769065469, 4755.096531658974, 4885.438174609965, 4916.631252655993, 4917.58200552957, 4918.532739389752, 4963.156263435297, 4661.0, 4768.0, 4808.687435316693, 4816.759162041954, 4822.348982887265], "unit": "ms", "name": "dojo.html", "value": 4551.5193537451105}, {"lowerIsBetter": false, "replicates": [562.5330975290511, 568.8776912963712, 573.9397363276853, 577.0133072446118, 578.2858170159855, 26933.0, 27631.309217269554, 35959.280814383696, 36084.0, 36392.81803590985, 38307.616923830756, 38771.41842872359, 38848.223035539275, 38922.0, 38941.41587876177, 6952.0, 7848.803779905491, 8014.519128852258, 8017.679292828309, 8020.197980201962, 7038.19060808006, 10026.498675066254, 10366.326188797704, 10367.17062634991, 10372.118369938564, 9730.0, 9797.706068817912, 9803.656872009482, 9804.852927206062, 9811.803763924718, 7119.21688614252, 7298.489105762599, 9864.506774661239, 9952.5521351539, 10047.29668923172, 9771.0, 9904.455254960974, 9909.157721593674, 9919.454430006346, 9925.851112233322, 35560.466593001125, 35951.82024089889, 36033.09917252063, 36034.279314413565, 36038.27923441517, 2925.546540286259, 2939.3533422646983, 2957.5859379686863, 3423.554937858087, 3584.6773790358993, 26973.460530789274, 27051.86474067617, 27366.589501157498, 27485.587716184273, 28034.158975230777, 3230.03099070278, 3478.0783092480515, 3494.702950249232, 3522.3659741246565, 3580.606133325332, 214967.0, 215915.0, 218093.0, 218293.9999999984, 218439.0, 50809.0, 51456.22815657768, 54196.72901635546, 54692.45307546874, 54782.72608637011, 63766.6811665948, 66235.33764662388, 66247.0, 66248.01255962328, 66318.0, 12522.499100035897, 12630.242185468902, 12668.049896257817, 12670.11309208365, 12675.936620317023, 9990.250731195045, 10010.899891000996, 10074.445905475122, 10077.748056298504, 10080.04239597237, 18732.344367947328, 18765.812341876408, 18796.906015470107, 18888.0, 18965.43103706891, 7369.963150184322, 7646.3882889368715, 7674.309312161932, 7728.768136955788, 7748.457607967388, 831.301706566487, 884.3611355394613, 902.4984644647307, 913.6756451459636, 948.9952550237342, 26280.0, 26407.051729990064, 26696.332591685365, 26755.866220668773, 26835.329116771845, 941.6892425499706, 977.2084611464736, 1001.2190491416707, 1073.8711354637494, 1076.3488089705772, 14229.0, 15124.848751512563, 15304.46920411766, 15342.386304547694, 15425.228738563026, 308151.0, 313866.0, 314494.0, 314739.0, 315795.0, 47398.763006184745, 47695.0, 47781.52218477771, 47807.521924781, 47813.760931195124, 1017.9185665146771, 1101.251149218523, 1195.9162858599814, 1197.9401029948467, 1212.5695378140633, 25069.87465062663, 25793.87103064473, 26336.736632634194, 26607.33481662974, 26621.0, 35553.64446355607, 37931.81034094812, 38430.231395372495, 38478.23043539058, 38552.80723596364, 161785.19107404858, 326742.0, 333202.0, 333601.0, 334065.0, 28062.438751224454, 28670.0, 28676.42647147087, 28695.713042869305, 28715.8564207186, 36414.4537831938, 36988.0, 37760.0, 37793.433098504094, 37805.43291850569, 31915.56379962861, 32690.673093269714, 33232.0, 33604.495932560545, 33686.83156584299, 32830.507542387364, 37127.0, 38716.60412058486, 38815.80592097021, 39304.606953930095, 33885.66114338825, 34001.0, 34016.14959626029, 34100.465479054, 34214.315713685086, 30084.398312034074, 30433.39133217279, 30692.0, 30803.229919251302, 31089.378212436077, 24084.397890052187, 24408.6338704916, 24469.632955505327, 24558.87720561386, 24832.37919051966], "unit": "ms", "name": "ext.html", "value": 17368.969063447574}, {"lowerIsBetter": false, "replicates": [336.7037007433458, 337.0881764826144, 338.5700160795788, 339.24517947566665, 340.4382768432087, 12291.078169137329, 12722.936385318084, 14986.625334366647, 15016.849831501682, 16216.189190540485, 11790.29258244506, 13834.654133646638, 14178.574642760708, 14644.926775366135, 14719.116852988827, 4726.787294571735, 5063.36707911512, 5222.060029194743, 5224.033553792541, 6095.969520152393, 3566.4115420955513, 3657.3416784978695, 5712.542996560265, 5873.0, 6010.158577799111, 5632.943670563303, 5762.308522977249, 5785.942140578582, 5816.662167701431, 5817.418258174191, 5715.9428405716035, 5745.454181852718, 5748.798792042279, 5761.88476230473, 5768.42315768424, 4931.654784165074, 5046.243063540462, 5048.040872234301, 5059.494050594948, 5066.189409694468, 18979.24083036677, 18980.240790368367, 19197.90401047986, 19482.318118865915, 19638.312659057006, 1618.7408026090743, 1659.8755093368045, 1853.4902901702005, 2012.5672980309157, 2405.458771776354, 8772.692955746517, 8843.823123537493, 8936.731898043068, 9061.682841100595, 12405.62783116508, 1689.442483980296, 1738.0440757583278, 1775.6626241014167, 1778.386456672446, 1791.480470663506, 51794.48205517972, 52919.941601168146, 53064.734676326756, 53146.468535314925, 54285.1857222142, 9721.854172187423, 9763.463009534402, 9790.412575245507, 9830.459324737065, 9838.508074596242, 12495.875041249654, 12529.74940501185, 12532.0, 12544.0, 12566.748665026647, 6870.45036397087, 6873.175218973755, 6910.550814197061, 6954.54795438305, 7015.649217539102, 6333.081703153017, 6366.36336366369, 6377.3303803100935, 6393.360663933569, 6446.097546343516, 4121.9381709274385, 4128.504579450485, 4153.480814898137, 4161.479815023122, 4171.687123465752, 1573.4571572807363, 1613.499815057336, 1668.8915220510628, 1726.1024267380892, 1729.152715169583, 837.7026155714756, 897.1970086772302, 901.8647202919483, 903.2412773270485, 954.341504361988, 12476.81284780729, 14091.224982626054, 14119.43924489226, 14580.90643201764, 14942.25288735559, 853.9581710313407, 854.0605334132529, 864.8443280209623, 876.6887754846938, 877.4384393987852, 8268.917310826935, 8597.570121494025, 8691.174338437839, 8751.124887511325, 8754.737357879147, 450367.0, 451556.0, 451816.0, 456912.0, 460115.0, 66826.33173668201, 69545.65227173932, 69990.0, 70330.64834675794, 71083.64458177677, 965.4641673870929, 993.8012397520525, 994.418265314799, 998.6904059741504, 1026.0047753678919, 14265.57203283903, 14270.500532481314, 14398.496052638107, 14467.638309042359, 14568.562943111723, 31642.208944776565, 31834.681653183172, 32222.19444513812, 33216.83391583027, 33305.16737081592, 42686.57313426826, 43317.13365732731, 44866.0, 45013.09973800571, 46085.0, 8596.140385961355, 8660.566971651266, 8793.868091978498, 8814.86777698348, 8991.550422478718, 15433.305501252695, 15693.529194124194, 15803.683926321179, 15975.600609984844, 16183.0, 12878.742425151257, 13192.20846749198, 13605.79591306151, 13615.863841361459, 13705.314734263047, 12684.23894566329, 13084.803727943898, 13278.86721132815, 13671.658208544866, 13737.519186828413, 9235.538223088684, 12534.435950382436, 12780.680482988, 12896.0, 13602.523911663044, 8575.185357391038, 8611.569421528773, 8653.264472519906, 8703.521306328214, 8724.69463568772, 9104.726858194264, 9395.671151509665, 12388.132830701765, 12503.937480312541, 12523.248605083723], "unit": "ms", "name": "jquery.html", "value": 8153.668000858229}, {"lowerIsBetter": false, "replicates": [1211.9272843629378, 1567.3260497985866, 1616.086910895344, 1634.9182540872953, 1652.3555813232842, 6002.549808764344, 7085.9291407085975, 7200.35196832285, 7210.7836764897, 7214.134303883535, 7015.54398964067, 7154.248803875596, 7161.5345002574795, 7169.068021157243, 7177.89233161503, 1749.7987731410924, 1777.6000399910047, 1778.9911050444794, 2057.526768843167, 2087.603355362476, 1793.417139429684, 1799.7750281214849, 2044.417341057799, 2078.3972647932155, 2084.2080009596334, 2053.8767673939537, 2067.441790716513, 2079.656856618656, 2080.240712140073, 2086.885221312827, 2026.4427282497284, 2055.5580550181785, 2068.6069646767064, 2070.472029632434, 2075.79242075792, 2039.9592008159755, 2074.263636409083, 2078.844086693504, 2085.8957052147484, 2113.5455876986366, 7113.502054856162, 7184.425245980309, 7197.89203161953, 7202.891956620655, 7217.783466495961, 4051.3315302974975, 4070.4911886014247, 4085.7140000199997, 4109.630133287988, 4126.91746165078, 2677.9196624101114, 2708.647875776156, 2731.0031838379045, 2741.739534744196, 2751.834889906612, 861.1130535548396, 870.4733636150102, 880.9911900881037, 895.6417433026842, 897.1611543207122, 9404.858927116098, 9411.294152938557, 9413.0, 9431.292653051049, 9434.622615095457, 3887.688984881203, 3938.9015274618364, 3954.347532657137, 3957.881263562098, 4032.4354590357375, 8151.673933042731, 8193.426460147852, 8204.056533498604, 8209.507429554245, 8216.21945915137, 4126.793660316972, 4138.710290279711, 4141.0, 4145.91708165841, 4147.834086636561, 3780.1494663700446, 3781.0736369589627, 3781.4516895050065, 3782.3759079751535, 3785.6971442284553, 3406.795592264472, 3423.3153369326233, 3475.3396854597545, 3477.200243943907, 3491.720662347006, 938.6808485115093, 963.7735132243918, 1096.4791723931069, 1137.7496950670838, 1141.5262665993519, 837.6858677995751, 856.6701819799422, 858.3305022082785, 858.4763294390542, 1015.1371334365878, 6744.190697116377, 6749.0551322814845, 6796.422304104207, 6819.659017049128, 6828.829279268058, 1007.4358359318805, 1031.8813336466253, 1032.963846265377, 1052.394872948058, 1054.6625079974335, 5147.6911385317, 5259.342582177228, 5261.579073674096, 5283.233931079972, 5288.3918349390315, 8182.059063207688, 8229.341652667772, 8516.361272904556, 8711.433756805787, 8734.825303493895, 8265.752027439186, 8295.211954864279, 8332.50004999702, 8334.12491688376, 8359.623816928253, 6491.156149700509, 6793.082933803873, 6793.524453288322, 6909.619970901648, 6928.618925959121, 6575.835604109744, 6586.934130658632, 6637.966810165918, 6640.269570347355, 6642.6014439133805, 7718.0, 7785.377169826287, 7786.961065194638, 7818.609069546386, 7832.843343132991, 7283.271672832674, 7450.329470347695, 7538.09542854861, 8031.518108913484, 8055.315298199719, 6636.634985075867, 6715.597064176165, 6727.495437842083, 6730.057791909038, 6736.056952026622, 5890.175375447527, 6727.8990815138795, 6937.791866244021, 6943.132108486439, 6958.8956165658565, 5835.854103647443, 6508.511861610304, 6528.608283502815, 6579.769708060195, 6639.302873198245, 6460.0, 6462.967685161544, 6522.184726909137, 6546.443552298108, 6616.900746488903, 6396.200474940632, 6445.709943052668, 6505.186851643544, 6595.736170553124, 6605.04226887089, 6064.727087280995, 6122.5408094392205, 6127.050307202391, 6130.386961304012, 6133.7546498141355, 6093.146959425595, 6115.205023346936, 6168.629882207082, 6171.506279497719, 6172.4136207060255], "unit": "ms", "name": "mootools.html", "value": 4069.131823744077}, {"lowerIsBetter": false, "replicates": [295.33107511486486, 302.6867192455807, 305.28563162200453, 309.06353748143135, 309.23001725702994, 5175.715335656542, 5182.378114626245, 5275.472452754722, 5290.7354632268425, 5298.258243845865, 5166.302549155863, 5178.0679477694, 5183.144781111121, 5185.611079169059, 5191.792328306863, 3906.785126818024, 4102.282100632392, 4104.076582768868, 4113.9794301028605, 4122.525909520414, 3994.700397470187, 4004.7196696231276, 4062.1469491406842, 4074.3684728866924, 4082.3876418537307, 4021.3163762160502, 4043.8584649537274, 4051.6758659307184, 4056.452378928851, 4080.1227736036744, 3855.4795102661064, 3932.842686292545, 3968.72218944674, 4080.5307389650275, 4087.591240875918, 3583.623719509466, 3610.819459027038, 3619.7647152934974, 3622.8188590570367, 3623.5289412376223, 4996.7501624918605, 5037.042961837239, 5040.899182016339, 5045.798168073273, 5048.671836330626, 4687.812487500496, 4693.906121877578, 4699.5535424135, 4700.529947005306, 4703.035877645075, 5375.973120134374, 5499.092649712793, 5502.339719233718, 5503.257060296889, 5523.6409633374105, 3927.1556615327554, 3943.861964831246, 3947.2894878921784, 3951.3480275754464, 3953.1303113315025, 5790.10253410722, 5791.971040144815, 5792.131180322943, 5800.187973683687, 5805.4194580542035, 4058.289799285113, 4062.6749860011128, 4068.5117785865295, 4071.267171909085, 4073.1446396256524, 3858.401947698111, 3949.7235193536753, 4128.855490057834, 4131.793410329472, 4133.925179453364, 4180.143070670566, 4559.794809233593, 4570.542945705402, 4584.3352713856975, 4678.2280923647895, 5359.839204823861, 5513.476219759116, 5531.861703457365, 5533.750981205855, 5545.584081193927, 1392.373431955624, 1395.4069520453766, 1396.1623026184411, 1397.7134687389062, 1398.1331574423718, 944.2257348973912, 955.4697143085515, 958.6740508227236, 969.3989726369555, 969.7236287657984, 4842.903141937141, 4852.757362131879, 4859.441164266084, 4859.732714700725, 4860.756962151878, 5728.026235539968, 5728.885422291531, 5731.0, 5731.054376027909, 5745.9425405745405, 4824.0, 4829.613630909519, 4844.249141383091, 4850.53919877611, 4851.830185943475, 2854.1437568729298, 2889.7688184945155, 3049.9847500762353, 3083.105899289181, 3084.3368675734823, 5337.226102215234, 5449.754761035763, 5463.426340234298, 5466.043442397644, 5470.0, 5935.0503919372695, 5937.139114828412, 5938.435848594377, 5946.494547963472, 5949.0, 5394.379646340564, 5450.4549545045975, 5452.482014208723, 5460.208269800856, 5462.317210348627, 5532.972335138459, 5719.628224165416, 5719.685417302088, 5730.054541000855, 5741.971290143522, 5632.0, 5666.660000399989, 5671.716414179192, 5685.0, 5688.715564221855, 5445.319335083114, 5446.291982042309, 5454.072807622634, 5456.345238571397, 5462.371827239759, 4030.576789437067, 4064.532578753481, 4070.6539944105084, 4073.7759423230823, 4077.734947228539, 5573.6098473106495, 5638.238837757014, 5692.459216374438, 5704.629199102211, 5708.828735137952, 5479.369872464717, 5480.561555075505, 5506.5870059744875, 5506.779728810803, 5509.834704958857, 5505.834824955257, 5511.53151982086, 5511.862203444946, 5514.117741161395, 5515.834524964257, 5187.922181167361, 5364.785408583613, 5383.08487557124, 5400.783968641211, 5402.432744561765, 5552.52803511706, 5557.610967232416, 5566.165075238747, 5566.721663916707, 5566.91649625264, 5225.686458812484, 5350.759215835375, 5407.702576358338, 5410.810621628224, 5495.642783219078], "unit": "ms", "name": "prototype.html", "value": 4150.905750574801}, {"lowerIsBetter": false, "replicates": [737.7270409948324, 744.3635691483781, 744.7244519527776, 760.2587477209718, 775.3487070860477, 12394.566190183334, 12702.618921432371, 12722.173058751174, 12738.426770795324, 12742.108052436322, 10328.225383096278, 11506.884931150686, 11572.421378931042, 11601.361925094116, 11610.709732256697, 605.4097255176201, 777.0442355902244, 791.1060501633175, 791.5171745235402, 791.6002418778509, 769.2154002917022, 785.505131766986, 785.6582386661792, 785.7721260834351, 786.3512602103259, 633.8605506788499, 639.066962235135, 804.4127786715701, 821.6343727041469, 829.6515463505342, 806.4838503357855, 806.8668669669527, 806.995965020177, 807.1121766057348, 807.1484583764127, 592.1118322516226, 594.4976494861835, 596.3678500789177, 597.1162679234714, 598.2432223237608, 12038.277703337828, 12247.081468889868, 12252.326122063283, 12294.692632684166, 12301.200421972542, 10687.946560267226, 11489.770204595861, 11494.0, 11565.479553420117, 11895.04839612829, 9387.389819661701, 9396.812063758687, 9433.811323773487, 9490.098440648197, 9609.0, 3261.3803377358226, 3271.96728032719, 3308.4375656138513, 3321.086701157177, 3321.8671253150087, 41732.956676083035, 41761.0, 42147.36778948287, 42284.57715422837, 42295.0, 9305.0, 9348.065193480734, 9396.248300135972, 9404.294677899185, 9423.528823558794, 16035.919820400823, 16058.598535036484, 16061.919690401473, 16070.75893861593, 16072.0, 6161.353057928853, 6239.126522286883, 6269.122322874801, 6355.046742988588, 6426.839329016812, 3497.0, 3505.859765609347, 3526.735494837846, 3560.893173204808, 3600.6219346968714, 2678.3571942733993, 2716.2937636214333, 2720.9932325039863, 2721.088435374132, 2722.9591556126675, 470.4166833126898, 472.8817795551112, 473.4484325760519, 473.8507370178383, 491.92129259318335, 539.9568034557226, 551.8868631930445, 568.1931657047003, 593.3443544882842, 596.5555661032558, 7015.761559722159, 7098.822529436702, 7233.0, 7273.199948005715, 7333.596652184181, 555.6082961512125, 561.581621691834, 566.1055532259021, 601.7803501721927, 602.2983224543358, 3352.3946031224687, 3447.67247111524, 3608.5850127235703, 3669.284489524517, 4006.959930400717, 42222.366664500056, 42820.35769463461, 42823.0, 42995.35506967398, 48052.27921581179, 41613.375799363035, 41866.162676746906, 42069.36895946563, 42176.78911605422, 42225.15549688989, 40273.19453610911, 40760.1847963045, 40999.975000624625, 41296.0, 41304.0, 7695.538267703956, 7864.2922137007945, 8043.638036288498, 8166.632501537326, 8467.91532084696, 31063.378732425677, 31336.843315784186, 32030.0, 32108.357832843678, 33329.166770830925, 40553.0, 40560.0, 40594.0, 41439.0, 41469.37795933003, 9893.851592226267, 9911.157551608194, 10144.376899696013, 10223.0, 10236.232282578687, 11069.5572177112, 11087.279326843729, 11245.7750844981, 11363.659090227306, 11373.886261137282, 9792.853107203255, 9883.555240014073, 9957.651482198089, 11508.251963622337, 11517.596884109016, 10888.564457421931, 10907.181961352771, 11184.552617895519, 11279.492422841156, 11617.47721352558, 10643.308184967953, 11210.775784484102, 11357.886421135683, 11413.543458261576, 11495.655130346104, 9079.137481939206, 9233.538323083952, 9481.194098501705, 9530.1899338557, 9834.557444914853, 8421.536815475207, 8622.966117679782, 8974.237189838937, 9342.0, 9435.905640943503], "unit": "ms", "name": "yui.html", "value": 5693.59094526479}], "name": "dromaeo_css", "value": 6291.104654907173}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 104.0, 110.0, 112.0, 112.0, 102.0, 111.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 153.0, 172.0, 131.0, 153.0, 151.0, 130.0, 164.0, 140.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 159.0, 160.0, 159.0, 161.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 82.0, 93.0, 73.0, 71.0, 71.0, 114.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 127.0, 95.0, 94.0, 94.0, 135.0, 95.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 83.0, 69.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 67.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [136.0, 122.0, 123.0, 119.0, 129.0, 121.0, 128.0, 122.0, 128.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [151.0, 151.0, 149.0, 160.0, 156.0, 141.0, 151.0, 152.0, 151.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 72.0, 71.0, 71.0, 69.0, 69.0, 71.0, 73.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1524.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.31658125309968], "unit": "score", "name": "Richards", "value": 213.54179800000009}, {"lowerIsBetter": false, "replicates": [186.74136321195144], "unit": "score", "name": "DeltaBlue", "value": 354.06189}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12035.714285714286], "unit": "score", "name": "Boyer", "value": 55.37378041543021}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [708.2152974504249], "unit": "score", "name": "Splay", "value": 115.06529199999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19590.50919794143}]} 11:25:52 INFO - RETURN: dromaeo_css: 6291.11 11:25:52 INFO - RETURN: kraken: 1524.30 11:25:52 INFO - RETURN: v8_7: 19590.51 11:25:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19590.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1524.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6291.11"}}} 11:25:52 INFO - Return code: 0 11:25:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:25:52 INFO - # TBPL SUCCESS # 11:25:52 INFO - Running post-action listener: _resource_record_post_action 11:25:52 INFO - Running post-run listener: _resource_record_post_run 11:25:53 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 507379712; Read time: 20; Write time: 587148 11:25:53 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231796736; Read time: 0; Write time: 395612 11:25:53 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 275582976; Read time: 20; Write time: 191536 11:25:53 INFO - Running post-run listener: _upload_blobber_files 11:25:53 INFO - Blob upload gear active. 11:25:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:25:53 INFO - Copying logs to upload dir... 11:25:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.057569 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-03 11:25:53.571876) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 11:25:53.575826) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009075 build_url: 'https://queue.taskcluster.net/v1/task/5Yu5Yrn0SxyC9eQBdS7LxA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 11:25:53.626705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:25:53.627086) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449168404.826773-98253134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 11:25:53.677917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 11:25:53.678292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 11:25:53.678645) ========= ========= Total master_lag: 0.25 =========