builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1449188918.58 results: success (0) buildid: 20151203154241 builduid: 5fa54660a384465383934c7ef28efe75 revision: d05e740814759b053ffaec0ef924e2f916833d31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.584040) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.584513) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.584819) ========= 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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006395 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.618283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.618598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.657188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.657549) ========= 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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.708175) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.708525) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.708981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.709378) ========= 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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 16:28:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-03 16:28:39 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.915689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.916034) ========= 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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014954 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.965878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 16:28:38.966243) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d05e740814759b053ffaec0ef924e2f916833d31 --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 d05e740814759b053ffaec0ef924e2f916833d31 --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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 16:28:39,586 truncating revision to first 12 chars 2015-12-03 16:28:39,586 Setting DEBUG logging. 2015-12-03 16:28:39,586 attempt 1/10 2015-12-03 16:28:39,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d05e74081475?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 16:28:40,260 unpacking tar archive at: fx-team-d05e74081475/testing/mozharness/ program finished with exit code 0 elapsedTime=1.049417 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 16:28:40.028599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:40.028947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:40.041743) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:40.042174) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:40.042750) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-03 16:28:40.043207) ========= /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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:28:40 INFO - MultiFileLogger online at 20151203 16:28:40 in /builds/slave/test 16:28:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:28:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:40 INFO - {'append_to_log': False, 16:28:40 INFO - 'base_work_dir': '/builds/slave/test', 16:28:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:28:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:40 INFO - 'branch': 'Fx-Team-Non-PGO', 16:28:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:40 INFO - 'config_files': ('talos/linux_config.py',), 16:28:40 INFO - 'default_actions': ('clobber', 16:28:40 INFO - 'read-buildbot-config', 16:28:40 INFO - 'download-and-extract', 16:28:40 INFO - 'populate-webroot', 16:28:40 INFO - 'create-virtualenv', 16:28:40 INFO - 'install', 16:28:40 INFO - 'run-tests'), 16:28:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:40 INFO - 'download_minidump_stackwalk': True, 16:28:40 INFO - 'download_symbols': 'ondemand', 16:28:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:40 INFO - 'installer_path': 'installer.exe', 16:28:40 INFO - 'log_level': 'info', 16:28:40 INFO - 'log_name': 'talos', 16:28:40 INFO - 'log_to_console': True, 16:28:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:28:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:28:40 INFO - 'opt_config_files': (), 16:28:40 INFO - 'pip_index': False, 16:28:40 INFO - 'sps_profile': False, 16:28:40 INFO - 'sps_profile_interval': 0, 16:28:40 INFO - 'suite': 'dromaeojs', 16:28:40 INFO - 'system_bits': '64', 16:28:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:40 INFO - 'title': 'talos-linux64-ix-067', 16:28:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:40 INFO - 'use_talos_json': True, 16:28:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:40 INFO - 'work_dir': 'build'} 16:28:40 INFO - ##### 16:28:40 INFO - ##### Running clobber step. 16:28:40 INFO - ##### 16:28:40 INFO - Running pre-action listener: _resource_record_pre_action 16:28:40 INFO - Running main action method: clobber 16:28:40 INFO - rmtree: /builds/slave/test/build 16:28:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:41 INFO - Running post-action listener: _resource_record_post_action 16:28:41 INFO - ##### 16:28:41 INFO - ##### Running read-buildbot-config step. 16:28:41 INFO - ##### 16:28:41 INFO - Running pre-action listener: _resource_record_pre_action 16:28:41 INFO - Running main action method: read_buildbot_config 16:28:41 INFO - Using buildbot properties: 16:28:41 INFO - { 16:28:41 INFO - "properties": { 16:28:41 INFO - "buildnumber": 2185, 16:28:41 INFO - "product": "firefox", 16:28:41 INFO - "script_repo_revision": "production", 16:28:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:28:41 INFO - "repository": "", 16:28:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:28:41 INFO - "buildid": "20151203154241", 16:28:41 INFO - "slavename": "talos-linux64-ix-067", 16:28:41 INFO - "pgo_build": "False", 16:28:41 INFO - "basedir": "/builds/slave/test", 16:28:41 INFO - "project": "", 16:28:41 INFO - "platform": "ubuntu64_hw", 16:28:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:28:41 INFO - "slavebuilddir": "test", 16:28:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:28:41 INFO - "branch": "fx-team", 16:28:41 INFO - "repo_path": "integration/fx-team", 16:28:41 INFO - "stage_platform": "linux64", 16:28:41 INFO - "builduid": "5fa54660a384465383934c7ef28efe75", 16:28:41 INFO - "revision": "d05e740814759b053ffaec0ef924e2f916833d31" 16:28:41 INFO - }, 16:28:41 INFO - "sourcestamp": { 16:28:41 INFO - "repository": "", 16:28:41 INFO - "hasPatch": false, 16:28:41 INFO - "project": "", 16:28:41 INFO - "branch": "fx-team-linux64-talos", 16:28:41 INFO - "changes": [ 16:28:41 INFO - { 16:28:41 INFO - "category": null, 16:28:41 INFO - "files": [ 16:28:41 INFO - { 16:28:41 INFO - "url": null, 16:28:41 INFO - "name": "https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:28:41 INFO - } 16:28:41 INFO - ], 16:28:41 INFO - "repository": "", 16:28:41 INFO - "rev": "d05e740814759b053ffaec0ef924e2f916833d31", 16:28:41 INFO - "who": "dtownsend@mozilla.com", 16:28:41 INFO - "when": 1449188858, 16:28:41 INFO - "number": 6741642, 16:28:41 INFO - "comments": "Bug 1229519: Fix toolkit/components/contentprefs to pass eslint checks. r=mconley", 16:28:41 INFO - "project": "", 16:28:41 INFO - "at": "Thu 03 Dec 2015 16:27:38", 16:28:41 INFO - "branch": "fx-team-linux64-talos", 16:28:41 INFO - "revlink": "", 16:28:41 INFO - "properties": [ 16:28:41 INFO - [ 16:28:41 INFO - "buildid", 16:28:41 INFO - "20151203154241", 16:28:41 INFO - "Change" 16:28:41 INFO - ], 16:28:41 INFO - [ 16:28:41 INFO - "builduid", 16:28:41 INFO - "5fa54660a384465383934c7ef28efe75", 16:28:41 INFO - "Change" 16:28:41 INFO - ], 16:28:41 INFO - [ 16:28:41 INFO - "pgo_build", 16:28:41 INFO - "False", 16:28:41 INFO - "Change" 16:28:41 INFO - ] 16:28:41 INFO - ], 16:28:41 INFO - "revision": "d05e740814759b053ffaec0ef924e2f916833d31" 16:28:41 INFO - } 16:28:41 INFO - ], 16:28:41 INFO - "revision": "d05e740814759b053ffaec0ef924e2f916833d31" 16:28:41 INFO - } 16:28:41 INFO - } 16:28:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:28:41 INFO - Running post-action listener: _resource_record_post_action 16:28:41 INFO - ##### 16:28:41 INFO - ##### Running download-and-extract step. 16:28:41 INFO - ##### 16:28:41 INFO - Running pre-action listener: _resource_record_pre_action 16:28:41 INFO - Running main action method: download_and_extract 16:28:41 INFO - mkdir: /builds/slave/test/build/tests 16:28:41 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')]} 16:28:41 INFO - https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/test_packages.json 16:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/test_packages.json 16:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:28:45 INFO - Downloaded 1302 bytes. 16:28:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:28:45 INFO - Using the following test package requirements: 16:28:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:28:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:45 INFO - u'jsshell-linux-x86_64.zip'], 16:28:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:28:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:28:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:28:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:28:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:28:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:28:45 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')]} 16:28:45 INFO - https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:28:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:28:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:28:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:48 INFO - Downloaded 21788775 bytes. 16:28: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 16:28:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:28: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 16:28:49 INFO - Return code: 0 16:28:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:49 INFO - https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:28:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:28:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:28:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:52 INFO - Downloaded 21788775 bytes. 16:28:52 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 16:28:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:28:52 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 16:28:53 INFO - Return code: 0 16:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:53 INFO - https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:28:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:28:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:28:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:55 INFO - Downloaded 11132001 bytes. 16:28:55 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 16:28:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:28:55 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 16:28:55 INFO - Return code: 0 16:28:55 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')]} 16:28:55 INFO - https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:28:57 INFO - Downloaded 57688660 bytes. 16:28:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:28:57 INFO - mkdir: /builds/slave/test/properties 16:28:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:57 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:57 INFO - Contents: 16:28:57 INFO - build_url:https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:28:57 INFO - Running post-action listener: _resource_record_post_action 16:28:57 INFO - Running post-action listener: set_extra_try_arguments 16:28:57 INFO - ##### 16:28:57 INFO - ##### Running populate-webroot step. 16:28:57 INFO - ##### 16:28:57 INFO - Running pre-action listener: _resource_record_pre_action 16:28:57 INFO - Running main action method: populate_webroot 16:28:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:28:57 INFO - '../fennec_ids.txt'], 16:28:57 INFO - 'tests': ['tcheck2']}, 16:28:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:57 INFO - '--tppagecycles', 16:28:57 INFO - '7'], 16:28:57 INFO - 'tests': ['tsvgm']}}, 16:28:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:28:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:28:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:28:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'tests': ['damp', 'tps']}, 16:28:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['damp', 'tps']}, 16:28:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:28:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:57 INFO - 'other': {'tests': ['a11yr', 16:28:57 INFO - 'ts_paint', 16:28:57 INFO - 'tpaint', 16:28:57 INFO - 'sessionrestore', 16:28:57 INFO - 'sessionrestore_no_auto_restore']}, 16:28:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['a11yr', 16:28:57 INFO - 'ts_paint', 16:28:57 INFO - 'tpaint', 16:28:57 INFO - 'sessionrestore', 16:28:57 INFO - 'sessionrestore_no_auto_restore']}, 16:28:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['a11yr', 16:28:57 INFO - 'ts_paint', 16:28:57 INFO - 'tpaint', 16:28:57 INFO - 'sessionrestore', 16:28:57 INFO - 'sessionrestore_no_auto_restore']}, 16:28:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['a11yr', 16:28:57 INFO - 'ts_paint', 16:28:57 INFO - 'tpaint', 16:28:57 INFO - 'sessionrestore', 16:28:57 INFO - 'sessionrestore_no_auto_restore']}, 16:28:57 INFO - 'other_l64': {'tests': ['a11yr', 16:28:57 INFO - 'ts_paint', 16:28:57 INFO - 'tpaint', 16:28:57 INFO - 'sessionrestore', 16:28:57 INFO - 'sessionrestore_no_auto_restore']}, 16:28:57 INFO - 'other_nol64': {'tests': ['a11yr', 16:28:57 INFO - 'ts_paint', 16:28:57 INFO - 'tpaint', 16:28:57 INFO - 'sessionrestore', 16:28:57 INFO - 'sessionrestore_no_auto_restore']}, 16:28:57 INFO - 'svgr': {'tests': ['tsvgx', 16:28:57 INFO - 'tsvgr_opacity', 16:28:57 INFO - 'tart', 16:28:57 INFO - 'tscrollx', 16:28:57 INFO - 'cart']}, 16:28:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['tsvgx', 16:28:57 INFO - 'tsvgr_opacity', 16:28:57 INFO - 'tart', 16:28:57 INFO - 'tscrollx', 16:28:57 INFO - 'cart']}, 16:28:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'tests': ['tp5o']}, 16:28:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'talos_options': ['--e10s'], 16:28:57 INFO - 'tests': ['tp5o']}, 16:28:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'talos_options': ['--xperf_path', 16:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:57 INFO - 'tests': ['tp5n']}, 16:28:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - 'talos_options': ['--e10s', 16:28:57 INFO - '--xperf_path', 16:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:57 INFO - 'tests': ['tp5n']}}, 16:28:57 INFO - 'talos.zip': {'path': '', 16:28:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:57 INFO - Running post-action listener: _resource_record_post_action 16:28:57 INFO - ##### 16:28:57 INFO - ##### Running create-virtualenv step. 16:28:57 INFO - ##### 16:28:57 INFO - Running pre-action listener: _resource_record_pre_action 16:28:57 INFO - Running main action method: create_virtualenv 16:28:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:57 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 16:28:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:57 INFO - Using real prefix '/usr' 16:28:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:58 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:59 INFO - Installing pip.................done. 16:28:59 INFO - Return code: 0 16:28:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:28:59 INFO - Using env: {'DISPLAY': ':0', 16:28:59 INFO - 'HOME': '/home/cltbld', 16:28:59 INFO - 'LANG': 'en_US.UTF-8', 16:28:59 INFO - 'LANGUAGE': 'en_US:en', 16:28:59 INFO - 'LOGNAME': 'cltbld', 16:28:59 INFO - 'MAIL': '/var/mail/cltbld', 16:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:59 INFO - 'MOZ_NO_REMOTE': '1', 16:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:59 INFO - 'NO_EM_RESTART': '1', 16:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:59 INFO - 'PWD': '/builds/slave/test', 16:28:59 INFO - 'SHELL': '/bin/bash', 16:28:59 INFO - 'SHLVL': '1', 16:28:59 INFO - 'TERM': 'linux', 16:28:59 INFO - 'TMOUT': '86400', 16:28:59 INFO - 'USER': 'cltbld', 16:28:59 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:59 INFO - '_': '/tools/buildbot/bin/python'} 16:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:00 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 16:29:00 INFO - Cleaning up... 16:29:00 INFO - Return code: 0 16:29:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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', '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 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:29: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 psutil>=0.7.1 16:29:00 INFO - Using env: {'DISPLAY': ':0', 16:29:00 INFO - 'HOME': '/home/cltbld', 16:29:00 INFO - 'LANG': 'en_US.UTF-8', 16:29:00 INFO - 'LANGUAGE': 'en_US:en', 16:29:00 INFO - 'LOGNAME': 'cltbld', 16:29:00 INFO - 'MAIL': '/var/mail/cltbld', 16:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:00 INFO - 'MOZ_NO_REMOTE': '1', 16:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:00 INFO - 'NO_EM_RESTART': '1', 16:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:00 INFO - 'PWD': '/builds/slave/test', 16:29:00 INFO - 'SHELL': '/bin/bash', 16:29:00 INFO - 'SHLVL': '1', 16:29:00 INFO - 'TERM': 'linux', 16:29:00 INFO - 'TMOUT': '86400', 16:29:00 INFO - 'USER': 'cltbld', 16:29:00 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:00 INFO - '_': '/tools/buildbot/bin/python'} 16:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:00 INFO - Downloading/unpacking psutil>=0.7.1 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:29:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:29:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:02 INFO - Installing collected packages: psutil 16:29:02 INFO - Running setup.py install for psutil 16:29:02 INFO - building 'psutil._psutil_linux' extension 16:29:02 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 16:29:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:29:02 INFO - building 'psutil._psutil_posix' extension 16:29:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:29:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:29:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:02 INFO - Successfully installed psutil 16:29:02 INFO - Cleaning up... 16:29:02 INFO - Return code: 0 16:29:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:29:02 INFO - Using env: {'DISPLAY': ':0', 16:29:02 INFO - 'HOME': '/home/cltbld', 16:29:02 INFO - 'LANG': 'en_US.UTF-8', 16:29:02 INFO - 'LANGUAGE': 'en_US:en', 16:29:02 INFO - 'LOGNAME': 'cltbld', 16:29:02 INFO - 'MAIL': '/var/mail/cltbld', 16:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:02 INFO - 'MOZ_NO_REMOTE': '1', 16:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:02 INFO - 'NO_EM_RESTART': '1', 16:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:02 INFO - 'PWD': '/builds/slave/test', 16:29:02 INFO - 'SHELL': '/bin/bash', 16:29:02 INFO - 'SHLVL': '1', 16:29:02 INFO - 'TERM': 'linux', 16:29:02 INFO - 'TMOUT': '86400', 16:29:02 INFO - 'USER': 'cltbld', 16:29:02 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:02 INFO - '_': '/tools/buildbot/bin/python'} 16:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:29:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:29:04 INFO - Installing collected packages: mozsystemmonitor 16:29:04 INFO - Running setup.py install for mozsystemmonitor 16:29:04 INFO - Successfully installed mozsystemmonitor 16:29:04 INFO - Cleaning up... 16:29:04 INFO - Return code: 0 16:29:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:29:04 INFO - Using env: {'DISPLAY': ':0', 16:29:04 INFO - 'HOME': '/home/cltbld', 16:29:04 INFO - 'LANG': 'en_US.UTF-8', 16:29:04 INFO - 'LANGUAGE': 'en_US:en', 16:29:04 INFO - 'LOGNAME': 'cltbld', 16:29:04 INFO - 'MAIL': '/var/mail/cltbld', 16:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:04 INFO - 'MOZ_NO_REMOTE': '1', 16:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:04 INFO - 'NO_EM_RESTART': '1', 16:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:04 INFO - 'PWD': '/builds/slave/test', 16:29:04 INFO - 'SHELL': '/bin/bash', 16:29:04 INFO - 'SHLVL': '1', 16:29:04 INFO - 'TERM': 'linux', 16:29:04 INFO - 'TMOUT': '86400', 16:29:04 INFO - 'USER': 'cltbld', 16:29:04 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:04 INFO - '_': '/tools/buildbot/bin/python'} 16:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:06 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:07 INFO - Downloading docopt-0.6.1.tar.gz 16:29:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:07 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:07 INFO - Running setup.py install for blobuploader 16:29:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:07 INFO - Running setup.py install for requests 16:29:07 INFO - Running setup.py install for docopt 16:29:07 INFO - Successfully installed blobuploader requests docopt 16:29:07 INFO - Cleaning up... 16:29:08 INFO - Return code: 0 16:29:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:08 INFO - Using env: {'DISPLAY': ':0', 16:29:08 INFO - 'HOME': '/home/cltbld', 16:29:08 INFO - 'LANG': 'en_US.UTF-8', 16:29:08 INFO - 'LANGUAGE': 'en_US:en', 16:29:08 INFO - 'LOGNAME': 'cltbld', 16:29:08 INFO - 'MAIL': '/var/mail/cltbld', 16:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:08 INFO - 'MOZ_NO_REMOTE': '1', 16:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:08 INFO - 'NO_EM_RESTART': '1', 16:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:08 INFO - 'PWD': '/builds/slave/test', 16:29:08 INFO - 'SHELL': '/bin/bash', 16:29:08 INFO - 'SHLVL': '1', 16:29:08 INFO - 'TERM': 'linux', 16:29:08 INFO - 'TMOUT': '86400', 16:29:08 INFO - 'USER': 'cltbld', 16:29:08 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:08 INFO - '_': '/tools/buildbot/bin/python'} 16:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:08 INFO - Running setup.py (path:/tmp/pip-Z9EBzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:08 INFO - Running setup.py (path:/tmp/pip-kzZUkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:08 INFO - Running setup.py (path:/tmp/pip-1fN0fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:08 INFO - Running setup.py (path:/tmp/pip-LvdN0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:08 INFO - Running setup.py (path:/tmp/pip-eDk9Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:08 INFO - Running setup.py (path:/tmp/pip-mPCS4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:08 INFO - Running setup.py (path:/tmp/pip-FGShOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:08 INFO - Running setup.py (path:/tmp/pip-uUVjaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:08 INFO - Running setup.py (path:/tmp/pip-lKHevs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:08 INFO - Running setup.py (path:/tmp/pip-ZCPhxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:08 INFO - Running setup.py (path:/tmp/pip-z3QwqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:09 INFO - Running setup.py (path:/tmp/pip-MmmgfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:09 INFO - Running setup.py (path:/tmp/pip-6Y_vSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:09 INFO - Running setup.py (path:/tmp/pip-rm2Zte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:09 INFO - Running setup.py (path:/tmp/pip-q2iUT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:09 INFO - Running setup.py (path:/tmp/pip-gaAeYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:09 INFO - Running setup.py (path:/tmp/pip-f9XLl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:09 INFO - Running setup.py install for manifestparser 16:29:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:09 INFO - Running setup.py install for mozcrash 16:29:09 INFO - Running setup.py install for mozdebug 16:29:09 INFO - Running setup.py install for mozdevice 16:29:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:29:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:29:09 INFO - Running setup.py install for mozfile 16:29:09 INFO - Running setup.py install for mozhttpd 16:29:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Running setup.py install for mozinfo 16:29:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Running setup.py install for mozInstall 16:29:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Running setup.py install for mozleak 16:29:10 INFO - Running setup.py install for mozlog 16:29:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Running setup.py install for moznetwork 16:29:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Running setup.py install for mozprocess 16:29:10 INFO - Running setup.py install for mozprofile 16:29:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Running setup.py install for mozrunner 16:29:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:29:10 INFO - Running setup.py install for mozscreenshot 16:29:11 INFO - Running setup.py install for moztest 16:29:11 INFO - Running setup.py install for mozversion 16:29:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:29:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:11 INFO - Cleaning up... 16:29:11 INFO - Return code: 0 16:29:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:11 INFO - Using env: {'DISPLAY': ':0', 16:29:11 INFO - 'HOME': '/home/cltbld', 16:29:11 INFO - 'LANG': 'en_US.UTF-8', 16:29:11 INFO - 'LANGUAGE': 'en_US:en', 16:29:11 INFO - 'LOGNAME': 'cltbld', 16:29:11 INFO - 'MAIL': '/var/mail/cltbld', 16:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:11 INFO - 'MOZ_NO_REMOTE': '1', 16:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:11 INFO - 'NO_EM_RESTART': '1', 16:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:11 INFO - 'PWD': '/builds/slave/test', 16:29:11 INFO - 'SHELL': '/bin/bash', 16:29:11 INFO - 'SHLVL': '1', 16:29:11 INFO - 'TERM': 'linux', 16:29:11 INFO - 'TMOUT': '86400', 16:29:11 INFO - 'USER': 'cltbld', 16:29:11 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:11 INFO - '_': '/tools/buildbot/bin/python'} 16:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:11 INFO - Running setup.py (path:/tmp/pip-zUsEp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:11 INFO - Running setup.py (path:/tmp/pip-Lg7VLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:11 INFO - Running setup.py (path:/tmp/pip-j4dvSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:11 INFO - Running setup.py (path:/tmp/pip-GCoksn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:11 INFO - Running setup.py (path:/tmp/pip-vWgmJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:11 INFO - Running setup.py (path:/tmp/pip-M4iCRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:11 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)) 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:11 INFO - Running setup.py (path:/tmp/pip-Ug6txz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:11 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)) 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:11 INFO - Running setup.py (path:/tmp/pip-qWEueO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:12 INFO - Running setup.py (path:/tmp/pip-tkNC8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:12 INFO - Running setup.py (path:/tmp/pip-cJy4LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:12 INFO - Running setup.py (path:/tmp/pip-pyYygv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:12 INFO - Running setup.py (path:/tmp/pip-d0tfnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:12 INFO - Running setup.py (path:/tmp/pip-hF7g8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:12 INFO - Running setup.py (path:/tmp/pip-8qVljW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:12 INFO - Running setup.py (path:/tmp/pip-fFBVxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:12 INFO - Running setup.py (path:/tmp/pip-rjdgww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:12 INFO - Running setup.py (path:/tmp/pip-svsgN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - Downloading blessings-1.5.1.tar.gz 16:29:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:29:14 INFO - Installing collected packages: blessings 16:29:14 INFO - Running setup.py install for blessings 16:29:14 INFO - Successfully installed blessings 16:29:14 INFO - Cleaning up... 16:29:14 INFO - Return code: 0 16:29:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:14 INFO - Reading from file tmpfile_stdout 16:29:14 INFO - Current package versions: 16:29:14 INFO - argparse == 1.2.1 16:29:14 INFO - blessings == 1.5.1 16:29:14 INFO - blobuploader == 1.2.4 16:29:14 INFO - docopt == 0.6.1 16:29:14 INFO - manifestparser == 1.1 16:29:14 INFO - mozInstall == 1.12 16:29:14 INFO - mozcrash == 0.16 16:29:14 INFO - mozdebug == 0.1 16:29:14 INFO - mozdevice == 0.47 16:29:14 INFO - mozfile == 1.2 16:29:14 INFO - mozhttpd == 0.7 16:29:14 INFO - mozinfo == 0.9 16:29:14 INFO - mozleak == 0.1 16:29:14 INFO - mozlog == 3.1 16:29:14 INFO - moznetwork == 0.27 16:29:14 INFO - mozprocess == 0.22 16:29:14 INFO - mozprofile == 0.27 16:29:14 INFO - mozrunner == 6.11 16:29:14 INFO - mozscreenshot == 0.1 16:29:14 INFO - mozsystemmonitor == 0.0 16:29:14 INFO - moztest == 0.7 16:29:14 INFO - mozversion == 1.4 16:29:14 INFO - psutil == 3.1.1 16:29:14 INFO - requests == 1.2.3 16:29:14 INFO - wsgiref == 0.1.2 16:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:14 INFO - Using env: {'DISPLAY': ':0', 16:29:14 INFO - 'HOME': '/home/cltbld', 16:29:14 INFO - 'LANG': 'en_US.UTF-8', 16:29:14 INFO - 'LANGUAGE': 'en_US:en', 16:29:14 INFO - 'LOGNAME': 'cltbld', 16:29:14 INFO - 'MAIL': '/var/mail/cltbld', 16:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:14 INFO - 'MOZ_NO_REMOTE': '1', 16:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:14 INFO - 'NO_EM_RESTART': '1', 16:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:14 INFO - 'PWD': '/builds/slave/test', 16:29:14 INFO - 'SHELL': '/bin/bash', 16:29:14 INFO - 'SHLVL': '1', 16:29:14 INFO - 'TERM': 'linux', 16:29:14 INFO - 'TMOUT': '86400', 16:29:14 INFO - 'USER': 'cltbld', 16:29:14 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:14 INFO - '_': '/tools/buildbot/bin/python'} 16:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:15 INFO - Cleaning up... 16:29:15 INFO - Return code: 0 16:29:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:29:15 INFO - Using env: {'DISPLAY': ':0', 16:29:15 INFO - 'HOME': '/home/cltbld', 16:29:15 INFO - 'LANG': 'en_US.UTF-8', 16:29:15 INFO - 'LANGUAGE': 'en_US:en', 16:29:15 INFO - 'LOGNAME': 'cltbld', 16:29:15 INFO - 'MAIL': '/var/mail/cltbld', 16:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:15 INFO - 'MOZ_NO_REMOTE': '1', 16:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:15 INFO - 'NO_EM_RESTART': '1', 16:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:15 INFO - 'PWD': '/builds/slave/test', 16:29:15 INFO - 'SHELL': '/bin/bash', 16:29:15 INFO - 'SHLVL': '1', 16:29:15 INFO - 'TERM': 'linux', 16:29:15 INFO - 'TMOUT': '86400', 16:29:15 INFO - 'USER': 'cltbld', 16:29:15 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:15 INFO - '_': '/tools/buildbot/bin/python'} 16:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:15 INFO - Downloading/unpacking jsonschema 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:29:16 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 16:29:16 INFO - Downloading/unpacking functools32 (from jsonschema) 16:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:29:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:29:17 INFO - warning: no files found matching '*.txt' 16:29:17 INFO - no previously-included directories found matching 'build' 16:29:17 INFO - no previously-included directories found matching 'dist' 16:29:17 INFO - no previously-included directories found matching '.git*' 16:29:17 INFO - Installing collected packages: jsonschema, functools32 16:29:17 INFO - Running setup.py install for functools32 16:29:17 INFO - warning: no files found matching '*.txt' 16:29:17 INFO - no previously-included directories found matching 'build' 16:29:17 INFO - no previously-included directories found matching 'dist' 16:29:17 INFO - no previously-included directories found matching '.git*' 16:29:17 INFO - Successfully installed jsonschema functools32 16:29:17 INFO - Cleaning up... 16:29:17 INFO - Return code: 0 16:29:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce7c772f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, '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': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', '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 16:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:29:17 INFO - Using env: {'DISPLAY': ':0', 16:29:17 INFO - 'HOME': '/home/cltbld', 16:29:17 INFO - 'LANG': 'en_US.UTF-8', 16:29:17 INFO - 'LANGUAGE': 'en_US:en', 16:29:17 INFO - 'LOGNAME': 'cltbld', 16:29:17 INFO - 'MAIL': '/var/mail/cltbld', 16:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:17 INFO - 'MOZ_NO_REMOTE': '1', 16:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:17 INFO - 'NO_EM_RESTART': '1', 16:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:17 INFO - 'PWD': '/builds/slave/test', 16:29:17 INFO - 'SHELL': '/bin/bash', 16:29:17 INFO - 'SHLVL': '1', 16:29:17 INFO - 'TERM': 'linux', 16:29:17 INFO - 'TMOUT': '86400', 16:29:17 INFO - 'USER': 'cltbld', 16:29:17 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:17 INFO - '_': '/tools/buildbot/bin/python'} 16:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:17 INFO - Downloading/unpacking flake8 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:29:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:29:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:29:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:29:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:29:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:29:20 INFO - no previously-included directories found matching 'docs/_build' 16:29:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:29:20 INFO - Running setup.py install for pep8 16:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:29:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:29:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:29:20 INFO - no previously-included directories found matching 'docs/_build' 16:29:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:29:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:29:20 INFO - Cleaning up... 16:29:20 INFO - Return code: 0 16:29:20 INFO - Running post-action listener: _resource_record_post_action 16:29:20 INFO - Running post-action listener: _start_resource_monitoring 16:29:20 INFO - Starting resource monitoring. 16:29:20 INFO - ##### 16:29:20 INFO - ##### Running install step. 16:29:20 INFO - ##### 16:29:20 INFO - Running pre-action listener: _resource_record_pre_action 16:29:20 INFO - Running main action method: install 16:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:20 INFO - Reading from file tmpfile_stdout 16:29:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:29:20 INFO - Reading from file tmpfile_stdout 16:29:20 INFO - Output received: 16:29:20 INFO - Usage: mozinstall [options] installer 16:29:20 INFO - Options: 16:29:20 INFO - -h, --help show this help message and exit 16:29:20 INFO - -d DEST, --destination=DEST 16:29:20 INFO - Directory to install application into. [default: 16:29:20 INFO - "/builds/slave/test"] 16:29:20 INFO - --app=APP Application being installed. [default: firefox] 16:29:20 INFO - mkdir: /builds/slave/test/build/application 16:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:29:35 INFO - Reading from file tmpfile_stdout 16:29:35 INFO - Output received: 16:29:35 INFO - /builds/slave/test/build/application/firefox/firefox 16:29:35 INFO - Running post-action listener: _resource_record_post_action 16:29:35 INFO - ##### 16:29:35 INFO - ##### Running run-tests step. 16:29:35 INFO - ##### 16:29:35 INFO - Running pre-action listener: _resource_record_pre_action 16:29:35 INFO - Running main action method: run_tests 16:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:35 INFO - Python 2.7.3 16:29:35 INFO - Return code: 0 16:29:35 INFO - grabbing minidump binary from tooltool 16:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a0b0>, '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 0x212afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:29:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:29:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:35 INFO - Return code: 0 16:29:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:29:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:29:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:29:36 INFO - Return code: 0 16:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test/build 16:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 16:29:36 INFO - Using env: {'DISPLAY': ':0', 16:29:36 INFO - 'HOME': '/home/cltbld', 16:29:36 INFO - 'LANG': 'en_US.UTF-8', 16:29:36 INFO - 'LANGUAGE': 'en_US:en', 16:29:36 INFO - 'LOGNAME': 'cltbld', 16:29:36 INFO - 'MAIL': '/var/mail/cltbld', 16:29:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:36 INFO - 'MOZ_NO_REMOTE': '1', 16:29:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:36 INFO - 'NO_EM_RESTART': '1', 16:29:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:36 INFO - 'PWD': '/builds/slave/test', 16:29:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:36 INFO - 'SHELL': '/bin/bash', 16:29:36 INFO - 'SHLVL': '1', 16:29:36 INFO - 'TERM': 'linux', 16:29:36 INFO - 'TMOUT': '86400', 16:29:36 INFO - 'USER': 'cltbld', 16:29:36 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590', 16:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:36 INFO - '_': '/tools/buildbot/bin/python'} 16:29:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 16:29:36 INFO - mozversion INFO | application_buildid: 20151203154241 16:29:36 INFO - mozversion INFO | application_changeset: d05e740814759b053ffaec0ef924e2f916833d31 16:29:36 INFO - mozversion INFO | application_display_name: Nightly 16:29:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:36 INFO - mozversion INFO | application_name: Firefox 16:29:36 INFO - mozversion INFO | application_remotingname: firefox 16:29:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:29:36 INFO - mozversion INFO | application_vendor: Mozilla 16:29:36 INFO - mozversion INFO | application_version: 45.0a1 16:29:36 INFO - mozversion INFO | platform_buildid: 20151203154241 16:29:36 INFO - mozversion INFO | platform_changeset: d05e740814759b053ffaec0ef924e2f916833d31 16:29:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:29:36 INFO - mozversion INFO | platform_version: 45.0a1 16:29:36 INFO - 2015-12-03 16:29:36,410 DEBUG : using testdate: 1449188976 16:29:36 INFO - 2015-12-03 16:29:36,410 DEBUG : actual date: 1449188976 16:29:36 INFO - 2015-12-03 16:29:36,418 INFO : starting webserver on 'localhost:60906' 16:29:36 INFO - 2015-12-03 16:29:36,419 INFO : Starting test suite talos-linux64-ix-067 16:29:36 INFO - 2015-12-03 16:29:36,419 INFO : Starting test dromaeo_css 16:29:36 INFO - 2015-12-03 16:29:36,419 DEBUG : operating with platform_type : linux_ 16:29:36 INFO - 2015-12-03 16:29:36,420 INFO : Initialising browser for dromaeo_css test... 16:29:36 INFO - 2015-12-03 16:29:36,434 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mgsI7/profile http://localhost:60906/getInfo.html 16:29:40 INFO - 2015-12-03 16:29:40,799 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:29:40 INFO - 2015-12-03 16:29:40,799 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:29:40 INFO - 2015-12-03 16:29:40,799 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:29:40 INFO - 2015-12-03 16:29:40,799 DEBUG : BROWSER_OUTPUT: __metrics 16:29:40 INFO - 2015-12-03 16:29:40,887 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] 16:29:40 INFO - 2015-12-03 16:29:40,955 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] 16:29:42 INFO - 2015-12-03 16:29:42,154 INFO : Browser initialized. 16:29:42 INFO - 2015-12-03 16:29:42,155 INFO : Running cycle 1/1 for dromaeo_css test... 16:29:42 INFO - 2015-12-03 16:29:42,155 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7mgsI7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:29:54 INFO - 2015-12-03 16:29:54,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 143769600 16:29:54 INFO - 2015-12-03 16:29:54,259 DEBUG : BROWSER_OUTPUT: 16:30:45 INFO - 2015-12-03 16:30:45,585 DEBUG : BROWSER_OUTPUT: 1449189045579 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] 16:32:57 INFO - 2015-12-03 16:32:57,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60906/tests/dromaeo/cssquery-ext.html) 16:32:58 INFO - 2015-12-03 16:32:58,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 237309952 16:32:58 INFO - 2015-12-03 16:32:58,827 DEBUG : BROWSER_OUTPUT: 16:36:01 INFO - 2015-12-03 16:36:01,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/dromaeo/cssquery-ext.html (next: http://localhost:60906/tests/dromaeo/cssquery-jquery.html) 16:36:01 INFO - 2015-12-03 16:36:01,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 210067456 16:36:01 INFO - 2015-12-03 16:36:01,947 DEBUG : BROWSER_OUTPUT: 16:39:03 INFO - 2015-12-03 16:39:03,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60906/tests/dromaeo/cssquery-mootools.html) 16:39:04 INFO - 2015-12-03 16:39:04,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 209817600 16:39:04 INFO - 2015-12-03 16:39:04,540 DEBUG : BROWSER_OUTPUT: 16:42:06 INFO - 2015-12-03 16:42:06,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60906/tests/dromaeo/cssquery-prototype.html) 16:42:07 INFO - 2015-12-03 16:42:07,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 200364032 16:42:07 INFO - 2015-12-03 16:42:07,099 DEBUG : BROWSER_OUTPUT: 16:45:09 INFO - 2015-12-03 16:45:09,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60906/tests/dromaeo/cssquery-yui.html) 16:45:10 INFO - 2015-12-03 16:45:10,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 207613952 16:45:10 INFO - 2015-12-03 16:45:10,471 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/dromaeo/cssquery-yui.html (next: http://localhost:60906/tests/dromaeo/cssquery-dojo.html) 16:48:13 INFO - 2015-12-03 16:48:13,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 233259008 16:48:13 INFO - 2015-12-03 16:48:13,541 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,541 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:48:13 INFO - 2015-12-03 16:48:13,542 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:48:13 INFO - 2015-12-03 16:48:13,542 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:48:13 INFO - 2015-12-03 16:48:13,542 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:48:13 INFO - 2015-12-03 16:48:13,542 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2602.8568428736417;2696.460707858429;2699.1362763915554;2710.837349759016;2720.768734657554;4570.10882877839;4592.448906131265;4654.534546545339;4678.625709943205;4684.437867455906;4549.9090018199695;4625.514320996297;4666.276727107295;4688.390509233804;4699.130660827749;4141.8964525886795;4268.253055715238;4272.572742725733;4305.4833419989645;4372.475302963649;4360.716553424033;4384.0355121873135;4394.516603173648;4401.889952751175;4432.047109871377;4104.733192342488;4209.789510524462;4229.6404805591565;4321.546237645033;4335.176316499871;4366.956330436687;4377.649788016951;4381.780910954471;4389.319655453378;4419.0719948810465;4353.978230108829;4355.891102722458;4361.149575832714;4377.978110109461;4384.824607015716;4444.8444304449185;4531.161735079021;4536.659750518725;4569.748663823521;4690.437147542317;5036.496350364971;5037.345145131109;5039.748012599355;5040.34475518184;5086.92369614456;5037.319961805146;5053.722045287508;5060.620453465968;5086.186210206386;5091.46539613339;4530.569595888385;4631.606313463326;4635.23518619424;4686.109639168581;4691.1086893490465;5029.2958985742025;5093.083245015932;5099.36257967754;5105.081085404663;5150.459201783834;4884.462709101996;4915.26271059344;4916.532929371704;4930.235813448921;4973.527514886152;4850.53919877611;4963.5780958618925;4968.378952630921;5009.474005229471;5017.37282839645;4855.490173531728;4892.3884514435695;4915.606751459874;4964.131277026506;4970.925436118461;4925.335079764186;4969.627277954096;4973.1297023020825;4975.029869175549;5018.272350509229;4003.53959294679;4164.208800327928;4173.97913010433;4177.498700156001;4223.113146239324;3589.10272431892;3602.0994751312173;3663.3222853772136;3691.7046636269033;3694.261147770403;4281.443412356373;4308.5045219799495;4309.41822853917;4323.3947247385395;4362.17118747437;5024.874378140503;5035.84892453227;5036.269740887551;5037.82367617139;5075.720835354091;4191.015111448807;4242.957570424318;4276.2302785498905;4277.550857159953;4327.199468098412;4385.627221686129;4386.846460373871;4411.845585404495;4437.267850804646;4476.41806565151;4725.267583524559;4748.169070412664;4748.3352330674425;4751;4788.856334309976;4814.5907597854575;4921.975390123026;4922.655414120977;4964.627652925973;5012.298278241122;4731.3612662291525;4740.762961851825;4741.668083234141;4785.377900872864;4789.736564488987;4944.950550494593;4948.901021979468;4961.280614310833;4970.055689419143;5007.3240112584335;4815.903681926412;4902.240152776183;4928.827491037797;4930.802767889244;4997.675151115166;4846;4865.197242454955;4869.391326084239;4901.877453063702;4905.7792399342825;4872.244802055687;4877.561019508261;4878.365812444359;4881.682690625098;4917.188663870421;4527.094581083862;4652.232381656989;4652.720836749806;4674.298855171752;4785.282207668877;4906.215005599087;4915.066137433876;4925.901481970269;4929.0388374268105;4954.801807927643;4812;4813.614910807197;4814.735189564468;4814.831480898151;4856.174450343379 16:48:13 INFO - 2015-12-03 16:48:13,543 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.6468653113387;565.6662569084242;573.1030936584245;578.5429510686558;586.7682265505125;27853.442931141366;28822.42355152896;28887.855560722168;35920.64079359206;36332.81833590835;39552.80223598885;40140.799296003555;40155.79922100393;40223.59776402235;40227.39658905119;7904.604769761518;8076.434649574532;8080.555569443678;8080.717174898879;8081.43429959903;7109.253528379523;7245.384142347907;10082.445465499395;10335.896641033607;10407.479626018707;9925.950370248138;10088.89911100887;10100.191984641211;10112.191024718042;10114;7123.074000379917;7274.709011639528;10041.347312424705;10105.9494702526;10151.441670708145;10194.490275486196;10475.685729428129;10477.947610261976;10481.58073677052;10492.94753526235;36477.63522364769;36586.268274634356;36792.63207367919;36814.89555313345;36852.78883267013;2743.876525556335;2966.480865848468;3498.930021399583;3546.6476349074305;3618.4029635110173;27302.5904611431;27432.17703468899;28135.859320703472;28202.15393538197;28296.162186896865;3392.3215356928467;3392.6607339266125;3485.6514348565192;3566.625504322035;3580.427131658948;235214;238098;238163;238205;238552;48745;49427.752861235465;50407.747961259956;51477.7426112867;60129.699351503834;56578.7171064142;56940;57246.42753572494;57309.71345143248;57365.42634573684;13409.731805363837;13655.590332290047;13704.10923289983;13738.587842364745;13746.106503077268;10074.14369778577;10153.746156346002;10160.949195253976;10192.286539942133;10198.490075496196;18865.811341886405;18977.33579324717;19148.234070637296;19154.329598463988;19195.8080419194;7483.8877416838795;7688.692452301845;7705.4220933430215;7728.304452599293;7800.765977020698;817.3175398542284;817.5626040068654;862.4092496639696;890.9955450222708;954.3939598355095;26402.207933762016;29304.853475732485;29326.853365733034;30678;30792.692073078983;818.5988865455884;879.8768172455862;1023.6007956896816;1111.6942840718705;1120.3389999900098;13669.384877680528;13994.440222390991;14554.490592829412;14567.271636418136;15081.622959426102;310992;315936;316531;316617;316733;47763.76118119387;47803.5219647806;47821.28268075982;47866.760666196446;48424.273635895486;1214.368528365245;1219.3354621731178;1240.2157157182003;1245.6636708088765;1247.0584708545173;26800.865995669898;28134.437311253252;28480.43039139164;29505.082169658905;30590.4591354526;42152.57847421487;42542.5745742551;42632.78683606562;42669.14661706811;42769.78615107029;235294;236588;240112;240286;240652;34601.30797383988;34970.65029349674;38891.416628751154;41320.807071787494;43020.78489607532;38399.232015360096;38528.614713852505;38797.41803873001;39108;39205.2158956825;32633.510497343035;36900.630993689716;37972.81013594914;38431.80784096062;38923.2215355697;33734;34184;34410;34436.139096522784;34706.65293347135;31207.531887021258;31882.20294492656;37786.62213377941;38168.427473588476;38170.618293816704;27808.44383112367;30890.84554577213;31147.84426077855;31284.687153128176;31294.68705312918;25356;26140.817469204834;26695.466090678467;26771.7322826777;26928.596071058557 16:48:13 INFO - 2015-12-03 16:48:13,544 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.2673800793234;333.16708229426433;338.1731666076443;338.215340410248;338.27102593910126;12506.937465312662;12899.355032248397;14972.379833529143;15081.62295942602;15544.300506477222;9062.184403403693;9105.453672779639;9305;9325.720228393142;9337;4367.890802729926;4541.863744087666;4545.704529205591;4548.681592288541;4549;3302;3384.5092461593053;5040.344755181821;5191.558717509016;5200.401953775327;5044.596432285427;5113.974430127844;5147.613928955325;5151.150060240056;5172.6379153459275;5732.684702341369;5774.451427114417;5794.101914203306;5801.941980580183;5811.389804070554;5034.471380505068;5135.281060651511;5141.177411614124;5160.587153027749;5161.225816127573;18569.350072747387;18586.442406727685;18659.906700466545;19062.33281835143;19295.324663636704;1737.1661602430904;1761.2866788950496;1781.750554922312;1853.0364210610408;1936.070686070694;8610.52642104684;8851.424657397249;9072.228860546862;11039.39283339416;12338.64274929757;1690.9661806763918;1693.2126561149003;1705.1815128738276;1713.9314427422887;1726.1196789637374;49371.50628493705;50012.99974000536;53307.73346133244;54225.72887135579;56032;8805.339599530062;9158.129977652112;9578;9584.233261339075;9659.227261819178;12611.873881261254;12716.491340346467;12755.744885102245;12764.425600847984;12791.616251512469;6929.7228110875;6945.583265004116;6977.616231107338;7007.334303241184;7042.647867606599;6808.217055038734;6860.485463590251;6867;6887.345702158287;6933.861322773617;4213.389058586549;4280;4285.635720963691;4314.697971142053;4323.654107671378;1570.740827763429;1599.6480774229651;1675.1373042882924;1682.3102527963722;1688.4765722626025;862.5299211929513;908.2688435809237;952.1763674421713;972.9270304727174;1006.2402885821305;15917.52247432579;15935.36258549645;16021.439249626206;16042.197890105448;16477.505674829776;849.1338834388889;852.6504133305315;873.8907636545432;931.1247427418206;932.5896605493562;8749.16882896124;8842.778930526789;9097.40866843653;9126.680566180152;9358.485283309346;286561;288670;467378;473059;496847;57177.42822571721;60207.39792602018;60273.57610176463;62980.05529917055;71699.24391486256;983.8671779309844;1026.1329176845554;1030.5311083457009;1037.2531777120462;1061.23591014471;14453.132812031312;14497.92751036238;14539.418423263374;14580.635484112981;14803.18582477974;31770;32709.672903271614;32947;33208.1697957553;33214.50891183219;41601.583984160985;42940.141197176505;43902.34146487741;44430.55569444264;44717.77641111774;8285.088640249447;8426.831463370821;8462.534560599226;8498.872516912128;8509.276711479593;9853.753656158653;12955.611331660066;16080.597985050468;16167.110808905623;16211.18944052769;12860.871391285968;13124.73750524965;13142.474301027853;13156.60530184096;13808.861911380758;13245.072844900764;13288.601341959757;13340.3329833506;13360.265185414895;13472;13064.80402793978;13297.534586289434;13425.194488330731;13733;13778.379972901444;8707.564621769014;8721.825563488568;8809.295256379346;8847.42491738035;9010.90989090127;9239.584218710308;9341.34610577253;11193.440327983732;13606.591802245948;14028.22844743549 16:48:13 INFO - 2015-12-03 16:48:13,545 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1232.291432426354;1590.3002678821317;1645.9259333330003;1654.5946243170417;1675.9497215083552;5965;7019.859602807947;7302.160251571071;7304.890426643605;7307.707691692339;7021.75423860165;7148.142222933256;7170.713171473135;7171.247019062988;7176.390006849411;2077.4910147013966;2108.8840113793813;2109.6519074352714;2109.968350474744;2110.6517424624917;2127.638301488743;2133.605283022638;2135.7970992755663;2141.2933731868447;2159.0608085482786;2054.907529161184;2058.4853786553363;2067.4831292176955;2088.2899814063217;2089.101686274901;2066.0496171761006;2079.4281572567515;2089.5403011337557;2090.602785470756;2090.874547527153;2066.5124493197086;2105.6841473778904;2116.608427440928;2126.946826329339;2129.3505480828494;6094.299155597118;6233.812985610393;7050.964745176241;7126.358627723478;7129.394001509878;4097.692673049533;4170.687198460128;4172.5410204877435;4173.269677806402;4176.979115104405;2736.165469531792;2751.147144385247;2770.8891644334203;2783.498970185366;2788.539890917996;906.5240748606968;910.7040211931148;918.7611221082567;922.8695195329171;935.4387367579466;9474.763130921714;9540.236781057498;9575.09036641518;9606.183474404685;9611.807763844754;3978.76127432355;4001.6598589119667;4056.3977228994972;4059.330210515232;4104.363823607286;8376.288015518749;8380.664773408995;8398.706045288385;8401.873971890427;8424.199701028392;4231.259529582311;4233.386159006926;4238.533761286256;4264.466941632296;4269.060806622538;3817.6564109230303;3822.7324087313623;3842.3852183650483;3850.537935447764;3861.3821788514265;3346.6151392589677;3355.328934213167;3361.9831900840827;3387.390269751419;3393.3382990317145;1069.9572017119228;1071.6731396924013;1075.5267682219799;1082.3722241100143;1085.6146068145852;922.294444749767;937.437537477508;938.136914039072;970.9611615535441;1197.4252358867793;6612.801615951529;6668.266490686021;6668.766593169215;6692.832679182962;6696.19645642526;428.5136370219823;429.57686678622156;436.1952198194326;452.4999875137925;452.79171581072416;4953.504649535018;4984.651074424828;5057.822976195889;5058.608882557326;5063.367079115111;7265.12818461788;8457.746267611981;8556.74329770108;8557.315414766803;8560.186782255676;8148.5518296494265;8409.03296120954;8462;8488.193621605938;8500.829983400297;6779.72881084761;6855.931440685529;6879.621620810904;6934.930650693529;6937.618430986344;6465.450436712932;6474.2554606219;6481.287058423664;6549.770758023446;6576.408123268929;7488.363489103487;7589.810254743676;7728.536287822749;7735.033120859893;7738.4969976951315;7560.168381478143;7732.729354472792;7872.84254314922;7921.841563168589;7925.960370198112;6080;6084.452399284086;6091;6103.8779224414375;6136.386361363828;6780;6825.726970921306;6826;6830.795076147723;6842.110525631636;6339.144215531029;6451.580647257913;6501;6515.934840651533;6588.769393071219;6290.716917738621;6333.809985700436;6449.3550644937;6457.418832305115;6645.9003114954285;6477.578957367945;6511.772087976898;6519.08732777421;6519.576227545194;6527;5773.393793651606;5953.583249172516;5974.4324289192455;6085.2393450818645;6106.72519736604;6170.413810687977;6198.690065496617;6212.378762123752;6212.943799554177;6222.377762223741 16:48:13 INFO - 2015-12-03 16:48:13,546 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.9312458134629;300.3452473607536;307.1400079776628;307.91070589529033;311.17383347213143;5212.973935130319;5255.527002569768;5281.155015197569;5321.361436627601;5417.052015897222;5134.589232861372;5250.8687282817855;5286.920696189561;5294.788208471657;5299.258103865462;3913.1391093959282;4022.8994275143064;4035.656969157625;4041.6968727345493;4083.4895638045246;3997.060690737674;4023.135025969416;4097.79511024449;4102.466679331683;4106.260873042851;4054.331035379159;4055.5944405559358;4057.8985525361954;4058.959410405888;4066.512018557777;4053.209624123297;4055;4059.9797001014954;4065.451164092839;4068.125353049079;3531.611522732497;3535.7878527288444;3536.681698647134;3536.9115772105647;3537.663921927413;5010.3737032870895;5144.099782538041;5151.278820965068;5151.356080489939;5151.7681704323395;4679.766011699401;4682.6019788318035;4683.203855344565;4694.600958918496;4699.483056863743;5579.69311687857;5580.469855363734;5591.860203494904;5592.217089607459;5596.468335508121;3694.3350196964534;3802.4106263529197;3875.8255878485534;3879.72841901067;3881.2819628368843;5752.884942301131;5868.706564671792;5896.056630939029;5896.056630939029;5905.704714764244;3966.662833659171;3967.861124860616;3968.6825053995613;3970.4242884781543;3973.344398174269;4019.959800402017;4023.094803669151;4027.3958906163725;4027.7986100694848;4027.9194416111513;4567.13241235244;4640.257558790578;4643.721376717408;4648.418947631546;4669.60308373792;5595.468430499096;5602.4957753802355;5602.663840169603;5611.663300202001;5618.325800903917;1416.4759039155579;1436.0737324425686;1436.4685066525453;1436.590571687064;1437.0659071603332;936.8594710793435;949.2785483032944;963.2679163835395;966.9951650241704;973.0658567774874;4873.220284754422;4881.267809828483;4887.29134275528;4888.120138375127;4890.508394939578;5810.854728631818;5824.88350232993;5825.7087145642545;5827.271591051119;5829.708514574254;4875.171220892456;4876.707397556158;4882.340883980688;4887.95112048882;4888.535589119028;3023.909282721522;3098.4422803895513;3120.1107684309864;3127.8436078196455;3145.811251324928;5513.42109078549;5515;5519.503244707996;5519.69641669704;5522.585806064561;6009.429104235091;6013.338532761392;6018.879622407528;6024.457798798129;6025.276966764016;5504.614676972654;5513.696746678971;5513.862153446196;5517.834464966058;5519.061759500814;5672.432756724294;5812.18629391877;5815.534757219328;5816.331121920864;5830.300363956352;5455;5703.914441283467;5711.314642242791;5714.399988001366;5727;5336.279602253801;5410.161424979135;5411.918821217606;5414.485623865727;5425.945740542544;3989.4215338775134;4033.3949907514107;4033.7176397651883;4036.2129384769687;4040.7373520721058;5825.3592104867585;5840.386759390372;5842.444967728059;5843.970780146072;5846.152307915243;5491.972540137273;5623.550115990793;5626.718664066862;5651.4348565143155;5658.03813351723;5648.689322087324;5659.547236221175;5661.037623603915;5662.716864156858;5665.20687103814;5540.141278101901;5543.972280138573;5544.805931792368;5545.417731138334;5547.583931205095;5543.3902270751;5693.829185124453;5697.088465845445;5698.886022279448;5700.486956173799;5541.251930989426;5546.972265138648;5550.417206193453;5554.1391084381985;5557.749901254534 16:48:13 INFO - 2015-12-03 16:48:13,546 DEBUG : BROWSER_OUTPUT: |5;yui.html;651.244556314675;731.8828987362022;739.9704011839526;751.77070993347;755.7506023012406;12020.879791202085;12029.278243305396;12049.518019279218;12080.69798255043;12102.273863568182;11611.245269057505;11745.23655962364;12809.423575939081;13008.804867926989;13023.869761302383;773.4624436016957;788.4165717369162;788.4323287233183;788.4953629677011;789.1201310538765;622.2874808344443;630.8959021761403;631.3844002097964;770.1335997003371;788.1999770233218;810.2586133687669;812.2892469089546;817.6075483767795;817.7464985854374;818.1041759273616;646.6217262901162;809.5628360685223;810.4610434061342;810.9553974531399;811.5698679699768;479.820067474697;587.597495715432;595.9344472108064;597.0357872036673;598.5780025082306;11788.469518871585;11801.822972655416;11895.286282823059;11917.046636269077;11957.820632690517;10706.979198295716;10945.507452164671;11061.944690276498;11349.489272982735;11710;9092.909070909272;9149.496777677225;9156.158101978754;9159.129882661136;9422.246220302359;3075.7539396848424;3082.075377386775;3102.7672924530752;3120.4851199552045;3163.43058249515;40247;40758.388624170664;41105.79447102745;41273.79363103165;41421.37867931953;8615.483071015758;8616.09530999236;8624.870626940601;8745.212930836255;9032.548372581345;15625.531234062997;15638.139902305482;15666.530004099895;15695.764563531557;15704.685906281811;5866.911996320058;5925.703714814242;5974;6043.456088952015;6162.291336496271;3416.1288871338147;3467.8612855486003;3505.9123521912156;3536.540249767565;3598.1364472526407;2707.91876243713;2719;2720.91837244883;2741.368286445035;2848.1170837040586;515.7215103843882;525.7502686224013;533.6531254684486;535.7080391186812;537.5780012690019;416.91661667666585;470.4613217865525;528.0442399257356;613.7084884679741;628.5474458389951;7319.707211711579;7394.704211831574;7396.704131834774;7432.405407567489;7466.887996680054;520.6277511579239;564.0383146734807;592.2301008688687;624.4941597306197;631.3875540725489;3719.6466335698065;3735.495708079429;3774.7168962327937;3823.9426408603895;3910.432987216838;42090.57909420928;44416.55583444189;46240.768796155804;51009;51106;43069;43597.564024359985;43668.344974825406;43833;44172.779136104116;38777.806110969264;38908.02729931774;38956.80521597431;39054.41418378727;39153;7997.7600671979935;8039.598020099089;8113.594320283844;8381.245687888118;8488.278496327634;32380.676193237767;32483.675163248066;32553.674463255065;32620.347593048482;33077.84227552024;38076.23847523089;39521;41075.794621026704;41499.1700166001;42327;9988.550515226687;10217.489125543842;10221.9488902555;10275.588976440858;10447.791044179226;9462.2430205582;9520.952395237979;10270.127039201752;11116.388598627153;11816.586419475278;10673;11100.167487438313;11107.72230694239;11180.552777888794;11366.431678416211;10681.89318106809;10725.41010244444;10753.408562529135;10969.23215374916;11162.832557511481;9996.650117246152;10405.375677459377;10519.789604208027;10551.788964220827;10759.408232546972;9292.535373231176;9457.24342052648;9459.195968342769;9759.12167904892;9908.653197138066;8607.096254893397;8822.33832462555;9019.278457723498;9021.684241051795;9283.953580232055 16:48:13 INFO - 2015-12-03 16:48:13,546 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:48:13 INFO - 2015-12-03 16:48:13,546 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:48:13 INFO - 2015-12-03 16:48:13,546 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,846 16:48:13 INFO - 2015-12-03 16:48:13,546 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:48:13 INFO - 2015-12-03 16:48:13,547 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190093540__endTimestamp 16:48:13 INFO - 2015-12-03 16:48:13,547 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,547 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:48:13 INFO - 2015-12-03 16:48:13,547 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:48:13 INFO - 2015-12-03 16:48:13,547 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,547 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4610.07 Median:4741.67 stddev:477.95 (10.1%) stddev-sans-first:452.74 16:48:13 INFO - 2015-12-03 16:48:13,548 DEBUG : BROWSER_OUTPUT: Values: 2602.9 2696.5 2699.1 2710.8 2720.8 4570.1 4592.4 4654.5 4678.6 4684.4 4549.9 4625.5 4666.3 4688.4 4699.1 4141.9 4268.3 4272.6 4305.5 4372.5 4360.7 4384.0 4394.5 4401.9 4432.0 4104.7 4209.8 4229.6 4321.5 4335.2 4367.0 4377.6 4381.8 4389.3 4419.1 4354.0 4355.9 4361.1 4378.0 4384.8 4444.8 4531.2 4536.7 4569.7 4690.4 5036.5 5037.3 5039.7 5040.3 5086.9 5037.3 5053.7 5060.6 5086.2 5091.5 4530.6 4631.6 4635.2 4686.1 4691.1 5029.3 5093.1 5099.4 5105.1 5150.5 4884.5 4915.3 4916.5 4930.2 4973.5 4850.5 4963.6 4968.4 5009.5 5017.4 4855.5 4892.4 4915.6 4964.1 4970.9 4925.3 4969.6 4973.1 4975.0 5018.3 4003.5 4164.2 4174.0 4177.5 4223.1 3589.1 3602.1 3663.3 3691.7 3694.3 4281.4 4308.5 4309.4 4323.4 4362.2 5024.9 5035.8 5036.3 5037.8 5075.7 4191.0 4243.0 4276.2 4277.6 4327.2 4385.6 4386.8 4411.8 4437.3 4476.4 4725.3 4748.2 4748.3 4751.0 4788.9 4814.6 4922.0 4922.7 4964.6 5012.3 4731.4 4740.8 4741.7 4785.4 4789.7 4945.0 4948.9 4961.3 4970.1 5007.3 4815.9 4902.2 4928.8 4930.8 4997.7 4846.0 4865.2 4869.4 4901.9 4905.8 4872.2 4877.6 4878.4 4881.7 4917.2 4527.1 4652.2 4652.7 4674.3 4785.3 4906.2 4915.1 4925.9 4929.0 4954.8 4812.0 4813.6 4814.7 4814.8 4856.2 16:48:13 INFO - 2015-12-03 16:48:13,548 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,548 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43006.20 Median:33183.76 stddev:69441.52 (209.3%) stddev-sans-first:69563.17 16:48:13 INFO - 2015-12-03 16:48:13,548 DEBUG : BROWSER_OUTPUT: Values: 556.6 565.7 573.1 578.5 586.8 27853.4 28822.4 28887.9 35920.6 36332.8 39552.8 40140.8 40155.8 40223.6 40227.4 7904.6 8076.4 8080.6 8080.7 8081.4 7109.3 7245.4 10082.4 10335.9 10407.5 9926.0 10088.9 10100.2 10112.2 10114.0 7123.1 7274.7 10041.3 10105.9 10151.4 10194.5 10475.7 10477.9 10481.6 10492.9 36477.6 36586.3 36792.6 36814.9 36852.8 2743.9 2966.5 3498.9 3546.6 3618.4 27302.6 27432.2 28135.9 28202.2 28296.2 3392.3 3392.7 3485.7 3566.6 3580.4 235214.0 238098.0 238163.0 238205.0 238552.0 48745.0 49427.8 50407.7 51477.7 60129.7 56578.7 56940.0 57246.4 57309.7 57365.4 13409.7 13655.6 13704.1 13738.6 13746.1 10074.1 10153.7 10160.9 10192.3 10198.5 18865.8 18977.3 19148.2 19154.3 19195.8 7483.9 7688.7 7705.4 7728.3 7800.8 817.3 817.6 862.4 891.0 954.4 26402.2 29304.9 29326.9 30678.0 30792.7 818.6 879.9 1023.6 1111.7 1120.3 13669.4 13994.4 14554.5 14567.3 15081.6 310992.0 315936.0 316531.0 316617.0 316733.0 47763.8 47803.5 47821.3 47866.8 48424.3 1214.4 1219.3 1240.2 1245.7 1247.1 26800.9 28134.4 28480.4 29505.1 30590.5 42152.6 42542.6 42632.8 42669.1 42769.8 235294.0 236588.0 240112.0 240286.0 240652.0 34601.3 34970.7 38891.4 41320.8 43020.8 38399.2 38528.6 38797.4 39108.0 39205.2 32633.5 36900.6 37972.8 38431.8 38923.2 33734.0 34184.0 34410.0 34436.1 34706.7 31207.5 31882.2 37786.6 38168.4 38170.6 27808.4 30890.8 31147.8 31284.7 31294.7 25356.0 26140.8 26695.5 26771.7 26928.6 16:48:13 INFO - 2015-12-03 16:48:13,548 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,549 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23398.29 Median:24135.12 stddev:67619.94 (280.2%) stddev-sans-first:67787.45 16:48:13 INFO - 2015-12-03 16:48:13,549 DEBUG : BROWSER_OUTPUT: Values: 329.3 333.2 338.2 338.2 338.3 12506.9 12899.4 14972.4 15081.6 15544.3 9062.2 9105.5 9305.0 9325.7 9337.0 4367.9 4541.9 4545.7 4548.7 4549.0 3302.0 3384.5 5040.3 5191.6 5200.4 5044.6 5114.0 5147.6 5151.2 5172.6 5732.7 5774.5 5794.1 5801.9 5811.4 5034.5 5135.3 5141.2 5160.6 5161.2 18569.4 18586.4 18659.9 19062.3 19295.3 1737.2 1761.3 1781.8 1853.0 1936.1 8610.5 8851.4 9072.2 11039.4 12338.6 1691.0 1693.2 1705.2 1713.9 1726.1 49371.5 50013.0 53307.7 54225.7 56032.0 8805.3 9158.1 9578.0 9584.2 9659.2 12611.9 12716.5 12755.7 12764.4 12791.6 6929.7 6945.6 6977.6 7007.3 7042.6 6808.2 6860.5 6867.0 6887.3 6933.9 4213.4 4280.0 4285.6 4314.7 4323.7 1570.7 1599.6 1675.1 1682.3 1688.5 862.5 908.3 952.2 972.9 1006.2 15917.5 15935.4 16021.4 16042.2 16477.5 849.1 852.7 873.9 931.1 932.6 8749.2 8842.8 9097.4 9126.7 9358.5 286561.0 288670.0 467378.0 473059.0 496847.0 57177.4 60207.4 60273.6 62980.1 71699.2 983.9 1026.1 1030.5 1037.3 1061.2 14453.1 14497.9 14539.4 14580.6 14803.2 31770.0 32709.7 32947.0 33208.2 33214.5 41601.6 42940.1 43902.3 44430.6 44717.8 8285.1 8426.8 8462.5 8498.9 8509.3 9853.8 12955.6 16080.6 16167.1 16211.2 12860.9 13124.7 13142.5 13156.6 13808.9 13245.1 13288.6 13340.3 13360.3 13472.0 13064.8 13297.5 13425.2 13733.0 13778.4 8707.6 8721.8 8809.3 8847.4 9010.9 9239.6 9341.3 11193.4 13606.6 14028.2 16:48:13 INFO - 2015-12-03 16:48:13,549 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,549 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4957.33 Median:6212.66 stddev:2577.60 (41.5%) stddev-sans-first:2569.62 16:48:13 INFO - 2015-12-03 16:48:13,550 DEBUG : BROWSER_OUTPUT: Values: 1232.3 1590.3 1645.9 1654.6 1675.9 5965.0 7019.9 7302.2 7304.9 7307.7 7021.8 7148.1 7170.7 7171.2 7176.4 2077.5 2108.9 2109.7 2110.0 2110.7 2127.6 2133.6 2135.8 2141.3 2159.1 2054.9 2058.5 2067.5 2088.3 2089.1 2066.0 2079.4 2089.5 2090.6 2090.9 2066.5 2105.7 2116.6 2126.9 2129.4 6094.3 6233.8 7051.0 7126.4 7129.4 4097.7 4170.7 4172.5 4173.3 4177.0 2736.2 2751.1 2770.9 2783.5 2788.5 906.5 910.7 918.8 922.9 935.4 9474.8 9540.2 9575.1 9606.2 9611.8 3978.8 4001.7 4056.4 4059.3 4104.4 8376.3 8380.7 8398.7 8401.9 8424.2 4231.3 4233.4 4238.5 4264.5 4269.1 3817.7 3822.7 3842.4 3850.5 3861.4 3346.6 3355.3 3362.0 3387.4 3393.3 1070.0 1071.7 1075.5 1082.4 1085.6 922.3 937.4 938.1 971.0 1197.4 6612.8 6668.3 6668.8 6692.8 6696.2 428.5 429.6 436.2 452.5 452.8 4953.5 4984.7 5057.8 5058.6 5063.4 7265.1 8457.7 8556.7 8557.3 8560.2 8148.6 8409.0 8462.0 8488.2 8500.8 6779.7 6855.9 6879.6 6934.9 6937.6 6465.5 6474.3 6481.3 6549.8 6576.4 7488.4 7589.8 7728.5 7735.0 7738.5 7560.2 7732.7 7872.8 7921.8 7926.0 6080.0 6084.5 6091.0 6103.9 6136.4 6780.0 6825.7 6826.0 6830.8 6842.1 6339.1 6451.6 6501.0 6515.9 6588.8 6290.7 6333.8 6449.4 6457.4 6645.9 6477.6 6511.8 6519.1 6519.6 6527.0 5773.4 5953.6 5974.4 6085.2 6106.7 6170.4 6198.7 6212.4 6212.9 6222.4 16:48:13 INFO - 2015-12-03 16:48:13,550 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,550 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4633.36 Median:5290.85 stddev:1377.33 (26.0%) stddev-sans-first:1342.23 16:48:13 INFO - 2015-12-03 16:48:13,550 DEBUG : BROWSER_OUTPUT: Values: 298.9 300.3 307.1 307.9 311.2 5213.0 5255.5 5281.2 5321.4 5417.1 5134.6 5250.9 5286.9 5294.8 5299.3 3913.1 4022.9 4035.7 4041.7 4083.5 3997.1 4023.1 4097.8 4102.5 4106.3 4054.3 4055.6 4057.9 4059.0 4066.5 4053.2 4055.0 4060.0 4065.5 4068.1 3531.6 3535.8 3536.7 3536.9 3537.7 5010.4 5144.1 5151.3 5151.4 5151.8 4679.8 4682.6 4683.2 4694.6 4699.5 5579.7 5580.5 5591.9 5592.2 5596.5 3694.3 3802.4 3875.8 3879.7 3881.3 5752.9 5868.7 5896.1 5896.1 5905.7 3966.7 3967.9 3968.7 3970.4 3973.3 4020.0 4023.1 4027.4 4027.8 4027.9 4567.1 4640.3 4643.7 4648.4 4669.6 5595.5 5602.5 5602.7 5611.7 5618.3 1416.5 1436.1 1436.5 1436.6 1437.1 936.9 949.3 963.3 967.0 973.1 4873.2 4881.3 4887.3 4888.1 4890.5 5810.9 5824.9 5825.7 5827.3 5829.7 4875.2 4876.7 4882.3 4888.0 4888.5 3023.9 3098.4 3120.1 3127.8 3145.8 5513.4 5515.0 5519.5 5519.7 5522.6 6009.4 6013.3 6018.9 6024.5 6025.3 5504.6 5513.7 5513.9 5517.8 5519.1 5672.4 5812.2 5815.5 5816.3 5830.3 5455.0 5703.9 5711.3 5714.4 5727.0 5336.3 5410.2 5411.9 5414.5 5425.9 3989.4 4033.4 4033.7 4036.2 4040.7 5825.4 5840.4 5842.4 5844.0 5846.2 5492.0 5623.6 5626.7 5651.4 5658.0 5648.7 5659.5 5661.0 5662.7 5665.2 5540.1 5544.0 5544.8 5545.4 5547.6 5543.4 5693.8 5697.1 5698.9 5700.5 5541.3 5547.0 5550.4 5554.1 5557.7 16:48:13 INFO - 2015-12-03 16:48:13,550 DEBUG : BROWSER_OUTPUT: 16:48:13 INFO - 2015-12-03 16:48:13,550 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12143.31 Median:43750.67 stddev:13614.87 (31.1%) stddev-sans-first:13625.71 16:48:13 INFO - 2015-12-03 16:48:13,550 DEBUG : BROWSER_OUTPUT: Values: 651.2 731.9 740.0 751.8 755.8 12020.9 12029.3 12049.5 12080.7 12102.3 11611.2 11745.2 12809.4 13008.8 13023.9 773.5 788.4 788.4 788.5 789.1 622.3 630.9 631.4 770.1 788.2 810.3 812.3 817.6 817.7 818.1 646.6 809.6 810.5 811.0 811.6 479.8 587.6 595.9 597.0 598.6 11788.5 11801.8 11895.3 11917.0 11957.8 10707.0 10945.5 11061.9 11349.5 11710.0 9092.9 9149.5 9156.2 9159.1 9422.2 3075.8 3082.1 3102.8 3120.5 3163.4 40247.0 40758.4 41105.8 41273.8 41421.4 8615.5 8616.1 8624.9 8745.2 9032.5 15625.5 15638.1 15666.5 15695.8 15704.7 5866.9 5925.7 5974.0 6043.5 6162.3 3416.1 3467.9 3505.9 3536.5 3598.1 2707.9 2719.0 2720.9 2741.4 2848.1 515.7 525.8 533.7 535.7 537.6 416.9 470.5 528.0 613.7 628.5 7319.7 7394.7 7396.7 7432.4 7466.9 520.6 564.0 592.2 624.5 631.4 3719.6 3735.5 3774.7 3823.9 3910.4 42090.6 44416.6 46240.8 51009.0 51106.0 43069.0 43597.6 43668.3 43833.0 44172.8 38777.8 38908.0 38956.8 39054.4 39153.0 7997.8 8039.6 8113.6 8381.2 8488.3 32380.7 32483.7 32553.7 32620.3 33077.8 38076.2 39521.0 41075.8 41499.2 42327.0 9988.6 10217.5 10221.9 10275.6 10447.8 9462.2 9521.0 10270.1 11116.4 11816.6 10673.0 11100.2 11107.7 11180.6 11366.4 10681.9 10725.4 10753.4 10969.2 11162.8 9996.7 10405.4 10519.8 10551.8 10759.4 9292.5 9457.2 9459.2 9759.1 9908.7 8607.1 8822.3 9019.3 9021.7 9284.0 16:48:13 INFO - 2015-12-03 16:48:13,551 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:48:13 INFO - 2015-12-03 16:48:13,551 DEBUG : BROWSER_OUTPUT: 16:48:14 INFO - 2015-12-03 16:48:14,265 INFO : Browser exited with error code: 0 16:48:14 INFO - 2015-12-03 16:48:14,286 INFO : Completed test dromaeo_css (00:18:37) 16:48:14 INFO - 2015-12-03 16:48:14,286 INFO : Starting test kraken 16:48:14 INFO - 2015-12-03 16:48:14,286 DEBUG : operating with platform_type : linux_ 16:48:14 INFO - 2015-12-03 16:48:14,286 INFO : Initialising browser for kraken test... 16:48:14 INFO - 2015-12-03 16:48:14,292 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7fhVM/profile http://localhost:60906/getInfo.html 16:48:18 INFO - 2015-12-03 16:48:18,369 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:48:18 INFO - 2015-12-03 16:48:18,370 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:48:18 INFO - 2015-12-03 16:48:18,370 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:48:18 INFO - 2015-12-03 16:48:18,370 DEBUG : BROWSER_OUTPUT: __metrics 16:48:18 INFO - 2015-12-03 16:48:18,508 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] 16:48:18 INFO - 2015-12-03 16:48:18,564 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] 16:48:19 INFO - 2015-12-03 16:48:19,661 INFO : Browser initialized. 16:48:19 INFO - 2015-12-03 16:48:19,662 INFO : Running cycle 1/1 for kraken test... 16:48:19 INFO - 2015-12-03 16:48:19,662 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn7fhVM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:48:31 INFO - 2015-12-03 16:48:31,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 143843328 16:48:31 INFO - 2015-12-03 16:48:31,678 DEBUG : BROWSER_OUTPUT: 16:48:34 INFO - 2015-12-03 16:48:34,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60906/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:34 INFO - 2015-12-03 16:48:34,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 181641216 16:48:34 INFO - 2015-12-03 16:48:34,857 DEBUG : BROWSER_OUTPUT: 16:48:37 INFO - 2015-12-03 16:48:37,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60906/tests/kraken/driver.html?testName=audio-dft) 16:48:38 INFO - 2015-12-03 16:48:38,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 171941888 16:48:38 INFO - 2015-12-03 16:48:38,167 DEBUG : BROWSER_OUTPUT: 16:48:41 INFO - 2015-12-03 16:48:41,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60906/tests/kraken/driver.html?testName=audio-fft) 16:48:41 INFO - 2015-12-03 16:48:41,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 153600000 16:48:41 INFO - 2015-12-03 16:48:41,733 DEBUG : BROWSER_OUTPUT: 16:48:43 INFO - 2015-12-03 16:48:43,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60906/tests/kraken/driver.html?testName=audio-oscillator) 16:48:44 INFO - 2015-12-03 16:48:44,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 154959872 16:48:44 INFO - 2015-12-03 16:48:44,319 DEBUG : BROWSER_OUTPUT: 16:48:46 INFO - 2015-12-03 16:48:46,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60906/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:47 INFO - 2015-12-03 16:48:47,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 157110272 16:48:47 INFO - 2015-12-03 16:48:47,140 DEBUG : BROWSER_OUTPUT: 16:48:50 INFO - 2015-12-03 16:48:50,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60906/tests/kraken/driver.html?testName=imaging-darkroom) 16:48:50 INFO - 2015-12-03 16:48:50,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 157736960 16:48:50 INFO - 2015-12-03 16:48:50,714 DEBUG : BROWSER_OUTPUT: 16:48:54 INFO - 2015-12-03 16:48:54,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60906/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:54 INFO - 2015-12-03 16:48:54,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 157614080 16:48:54 INFO - 2015-12-03 16:48:54,743 DEBUG : BROWSER_OUTPUT: 16:48:57 INFO - 2015-12-03 16:48:57,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60906/tests/kraken/driver.html?testName=json-parse-financial) 16:48:58 INFO - 2015-12-03 16:48:58,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 158457856 16:48:58 INFO - 2015-12-03 16:48:58,170 DEBUG : BROWSER_OUTPUT: 16:48:59 INFO - 2015-12-03 16:48:59,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60906/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:00 INFO - 2015-12-03 16:49:00,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 170135552 16:49:00 INFO - 2015-12-03 16:49:00,497 DEBUG : BROWSER_OUTPUT: 16:49:02 INFO - 2015-12-03 16:49:02,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:49:02 INFO - 2015-12-03 16:49:02,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 168595456 16:49:02 INFO - 2015-12-03 16:49:02,974 DEBUG : BROWSER_OUTPUT: 16:49:05 INFO - 2015-12-03 16:49:05,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:05 INFO - 2015-12-03 16:49:05,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 181559296 16:49:05 INFO - 2015-12-03 16:49:05,687 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:08 INFO - 2015-12-03 16:49:08,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 188022784 16:49:08 INFO - 2015-12-03 16:49:08,773 DEBUG : BROWSER_OUTPUT: 16:49:11 INFO - 2015-12-03 16:49:11,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:12 INFO - 2015-12-03 16:49:12,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 187183104 16:49:12 INFO - 2015-12-03 16:49:12,017 DEBUG : BROWSER_OUTPUT: 16:49:13 INFO - 2015-12-03 16:49:13,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60906/tests/kraken/driver.html?testName=ai-astar) 16:49:14 INFO - 2015-12-03 16:49:14,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 244654080 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;112;105;111;114;113;101;113;110;103 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;130;165;171;129;153;152;135;169;132 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;160;160;160;162;161;160;162 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;82;90;74;72;73;101;92;71 16:49:14 INFO - 2015-12-03 16:49:14,031 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;132;94;96;96;134;95;95;129 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;109;110;110;109;110 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;147;147;147;147;147;147;147;147 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;95;98;95;95;96;96;97;96;96 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;70;70;70;69;71;70;68 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;68;68;69;67;68;68 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;90;86;85;84;83;85;84;84;86 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;121;125;123;124;119;127;126;119;125 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;147;144;156;145;134;144;133;157;149 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;67;69;68;68;70;67;67;68 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:49:14 INFO - 2015-12-03 16:49:14,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,979 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190154026__endTimestamp 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.50 stddev:4.57 (4.1%) stddev-sans-first:4.83 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: Values: 108.0 112.0 105.0 111.0 114.0 113.0 101.0 113.0 110.0 103.0 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:152.50 stddev:16.36 (10.7%) stddev-sans-first:17.35 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: Values: 148.0 130.0 165.0 171.0 129.0 153.0 152.0 135.0 169.0 132.0 16:49:14 INFO - 2015-12-03 16:49:14,033 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 160.0 160.0 160.0 162.0 161.0 160.0 162.0 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:10.79 (14.7%) stddev-sans-first:11.05 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 82.0 90.0 74.0 72.0 73.0 101.0 92.0 71.0 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.50 stddev:17.84 (18.9%) stddev-sans-first:18.39 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 132.0 94.0 96.0 96.0 134.0 95.0 95.0 129.0 16:49:14 INFO - 2015-12-03 16:49:14,034 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,035 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:49:14 INFO - 2015-12-03 16:49:14,035 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 16:49:14 INFO - 2015-12-03 16:49:14,035 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,035 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 16:49:14 INFO - 2015-12-03 16:49:14,035 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.14 (1.2%) stddev-sans-first:1.00 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 98.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:0.94 (1.3%) stddev-sans-first:0.93 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 70.0 70.0 69.0 71.0 70.0 68.0 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 16:49:14 INFO - 2015-12-03 16:49:14,036 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 68.0 68.0 69.0 67.0 68.0 68.0 16:49:14 INFO - 2015-12-03 16:49:14,037 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,037 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:2.18 (2.6%) stddev-sans-first:2.05 16:49:14 INFO - 2015-12-03 16:49:14,037 DEBUG : BROWSER_OUTPUT: Values: 82.0 90.0 86.0 85.0 84.0 83.0 85.0 84.0 84.0 86.0 16:49:14 INFO - 2015-12-03 16:49:14,037 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,037 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:124.50 stddev:2.87 (2.3%) stddev-sans-first:2.95 16:49:14 INFO - 2015-12-03 16:49:14,037 DEBUG : BROWSER_OUTPUT: Values: 121.0 121.0 125.0 123.0 124.0 119.0 127.0 126.0 119.0 125.0 16:49:14 INFO - 2015-12-03 16:49:14,037 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,038 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:146.00 stddev:7.82 (5.4%) stddev-sans-first:8.29 16:49:14 INFO - 2015-12-03 16:49:14,038 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 144.0 156.0 145.0 134.0 144.0 133.0 157.0 149.0 16:49:14 INFO - 2015-12-03 16:49:14,038 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,038 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.16 (1.7%) stddev-sans-first:1.05 16:49:14 INFO - 2015-12-03 16:49:14,038 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 67.0 69.0 68.0 68.0 70.0 67.0 67.0 68.0 16:49:14 INFO - 2015-12-03 16:49:14,038 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:49:14 INFO - 2015-12-03 16:49:14,038 DEBUG : BROWSER_OUTPUT: 16:49:14 INFO - 2015-12-03 16:49:14,924 INFO : Browser exited with error code: 0 16:49:14 INFO - 2015-12-03 16:49:14,978 INFO : Completed test kraken (00:01:00) 16:49:14 INFO - 2015-12-03 16:49:14,978 INFO : Starting test v8_7 16:49:14 INFO - 2015-12-03 16:49:14,978 DEBUG : operating with platform_type : linux_ 16:49:14 INFO - 2015-12-03 16:49:14,979 INFO : Initialising browser for v8_7 test... 16:49:14 INFO - 2015-12-03 16:49:14,985 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMCOn9/profile http://localhost:60906/getInfo.html 16:49:19 INFO - 2015-12-03 16:49:19,355 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:49:19 INFO - 2015-12-03 16:49:19,355 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:49:19 INFO - 2015-12-03 16:49:19,355 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:49:19 INFO - 2015-12-03 16:49:19,355 DEBUG : BROWSER_OUTPUT: __metrics 16:49:19 INFO - 2015-12-03 16:49:19,484 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] 16:49:19 INFO - 2015-12-03 16:49:19,560 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] 16:49:20 INFO - 2015-12-03 16:49:20,454 INFO : Browser initialized. 16:49:20 INFO - 2015-12-03 16:49:20,454 INFO : Running cycle 1/1 for v8_7 test... 16:49:20 INFO - 2015-12-03 16:49:20,455 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMCOn9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:49:32 INFO - 2015-12-03 16:49:32,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 143732736 16:49:32 INFO - 2015-12-03 16:49:32,452 DEBUG : BROWSER_OUTPUT: 16:49:53 INFO - 2015-12-03 16:49:53,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60906/tests/v8_7/run.html (next: http://localhost:60906/tests/v8_7/run.html) 16:49:54 INFO - 2015-12-03 16:49:54,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 444784640 16:49:54 INFO - 2015-12-03 16:49:54,130 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,131 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:49:54 INFO - 2015-12-03 16:49:54,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:49:54 INFO - 2015-12-03 16:49:54,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:49:54 INFO - 2015-12-03 16:49:54,132 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:49:54 INFO - 2015-12-03 16:49:54,132 DEBUG : BROWSER_OUTPUT: |0;Richards;172.68174753928508 16:49:54 INFO - 2015-12-03 16:49:54,132 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.56318426424198 16:49:54 INFO - 2015-12-03 16:49:54,132 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 16:49:54 INFO - 2015-12-03 16:49:54,132 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 16:49:54 INFO - 2015-12-03 16:49:54,132 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 16:49:54 INFO - 2015-12-03 16:49:54,132 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 16:49:54 INFO - 2015-12-03 16:49:54,133 DEBUG : BROWSER_OUTPUT: |6;Boyer;11788.235294117647 16:49:54 INFO - 2015-12-03 16:49:54,133 DEBUG : BROWSER_OUTPUT: |7;RegExp;26947.36842105263 16:49:54 INFO - 2015-12-03 16:49:54,133 DEBUG : BROWSER_OUTPUT: |8;Splay;594.883997620464 16:49:54 INFO - 2015-12-03 16:49:54,133 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 16:49:54 INFO - 2015-12-03 16:49:54,133 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:49:54 INFO - 2015-12-03 16:49:54,134 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190194130__endTimestamp 16:49:54 INFO - 2015-12-03 16:49:54,134 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,134 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:49:54 INFO - 2015-12-03 16:49:54,134 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:49:54 INFO - 2015-12-03 16:49:54,134 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,135 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.68 Median:172.68 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,135 DEBUG : BROWSER_OUTPUT: Values: 172.7 16:49:54 INFO - 2015-12-03 16:49:54,135 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,135 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.56 Median:185.56 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,135 DEBUG : BROWSER_OUTPUT: Values: 185.6 16:49:54 INFO - 2015-12-03 16:49:54,136 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,136 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,136 DEBUG : BROWSER_OUTPUT: Values: 277.5 16:49:54 INFO - 2015-12-03 16:49:54,136 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,136 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,136 DEBUG : BROWSER_OUTPUT: Values: 5196.9 16:49:54 INFO - 2015-12-03 16:49:54,137 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,137 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,137 DEBUG : BROWSER_OUTPUT: Values: 2002.0 16:49:54 INFO - 2015-12-03 16:49:54,137 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,137 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,138 DEBUG : BROWSER_OUTPUT: Values: 779.4 16:49:54 INFO - 2015-12-03 16:49:54,138 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,139 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11788.24 Median:11788.24 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,139 DEBUG : BROWSER_OUTPUT: Values: 11788.2 16:49:54 INFO - 2015-12-03 16:49:54,139 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,140 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,140 DEBUG : BROWSER_OUTPUT: Values: 26947.4 16:49:54 INFO - 2015-12-03 16:49:54,140 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,140 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.88 Median:594.88 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,140 DEBUG : BROWSER_OUTPUT: Values: 594.9 16:49:54 INFO - 2015-12-03 16:49:54,140 DEBUG : BROWSER_OUTPUT: 16:49:54 INFO - 2015-12-03 16:49:54,140 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 16:49:54 INFO - 2015-12-03 16:49:54,141 DEBUG : BROWSER_OUTPUT: Values: 4845.4 16:49:54 INFO - 2015-12-03 16:49:54,141 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:49:54 INFO - 2015-12-03 16:49:54,141 DEBUG : BROWSER_OUTPUT: 16:49:55 INFO - 2015-12-03 16:49:55,045 INFO : Browser exited with error code: 0 16:49:55 INFO - 2015-12-03 16:49:55,059 INFO : Completed test v8_7 (00:00:40) 16:49:55 INFO - 2015-12-03 16:49:55,141 INFO : Completed test suite (00:20:18) 16:49:55 INFO - 2015-12-03 16:49:55,141 DEBUG : Working with test: dromaeo_css 16:49:55 INFO - 2015-12-03 16:49:55,141 DEBUG : Generating results file: dromaeo_css 16:49:55 INFO - 2015-12-03 16:49:55,142 DEBUG : Working with test: kraken 16:49:55 INFO - 2015-12-03 16:49:55,142 DEBUG : Generating results file: kraken 16:49:55 INFO - 2015-12-03 16:49:55,142 INFO : javascript benchmark 16:49:55 INFO - 2015-12-03 16:49:55,143 DEBUG : Working with test: v8_7 16:49:55 INFO - 2015-12-03 16:49:55,143 DEBUG : Generating results file: v8_7 16:49:55 INFO - 2015-12-03 16:49:55,143 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:49:55 INFO - 2015-12-03 16:49:55,191 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 16:49:55 INFO - 2015-12-03 16:49:55,191 DEBUG : process_Request line: dromaeo_css 6284.02 graph.html#tests=[[72,132,35]] 16:49:55 INFO - 2015-12-03 16:49:55,191 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:49:55 INFO - 2015-12-03 16:49:55,219 DEBUG : process_Request line: kraken 1515.70 graph.html#tests=[[232,132,35]] 16:49:55 INFO - 2015-12-03 16:49:55,219 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:49:55 INFO - 2015-12-03 16:49:55,248 DEBUG : process_Request line: v8_7 19835.90 graph.html#tests=[[230,132,35]] 16:49:55 INFO - 2015-12-03 16:49:55,250 INFO : javascript benchmark 16:49:55 INFO - 2015-12-03 16:49:55,253 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2602.8568428736417, 2696.460707858429, 2699.1362763915554, 2710.837349759016, 2720.768734657554, 4570.10882877839, 4592.448906131265, 4654.534546545339, 4678.625709943205, 4684.437867455906, 4549.9090018199695, 4625.514320996297, 4666.276727107295, 4688.390509233804, 4699.130660827749, 4141.8964525886795, 4268.253055715238, 4272.572742725733, 4305.4833419989645, 4372.475302963649, 4360.716553424033, 4384.0355121873135, 4394.516603173648, 4401.889952751175, 4432.047109871377, 4104.733192342488, 4209.789510524462, 4229.6404805591565, 4321.546237645033, 4335.176316499871, 4366.956330436687, 4377.649788016951, 4381.780910954471, 4389.319655453378, 4419.0719948810465, 4353.978230108829, 4355.891102722458, 4361.149575832714, 4377.978110109461, 4384.824607015716, 4444.8444304449185, 4531.161735079021, 4536.659750518725, 4569.748663823521, 4690.437147542317, 5036.496350364971, 5037.345145131109, 5039.748012599355, 5040.34475518184, 5086.92369614456, 5037.319961805146, 5053.722045287508, 5060.620453465968, 5086.186210206386, 5091.46539613339, 4530.569595888385, 4631.606313463326, 4635.23518619424, 4686.109639168581, 4691.1086893490465, 5029.2958985742025, 5093.083245015932, 5099.36257967754, 5105.081085404663, 5150.459201783834, 4884.462709101996, 4915.26271059344, 4916.532929371704, 4930.235813448921, 4973.527514886152, 4850.53919877611, 4963.5780958618925, 4968.378952630921, 5009.474005229471, 5017.37282839645, 4855.490173531728, 4892.3884514435695, 4915.606751459874, 4964.131277026506, 4970.925436118461, 4925.335079764186, 4969.627277954096, 4973.1297023020825, 4975.029869175549, 5018.272350509229, 4003.53959294679, 4164.208800327928, 4173.97913010433, 4177.498700156001, 4223.113146239324, 3589.10272431892, 3602.0994751312173, 3663.3222853772136, 3691.7046636269033, 3694.261147770403, 4281.443412356373, 4308.5045219799495, 4309.41822853917, 4323.3947247385395, 4362.17118747437, 5024.874378140503, 5035.84892453227, 5036.269740887551, 5037.82367617139, 5075.720835354091, 4191.015111448807, 4242.957570424318, 4276.2302785498905, 4277.550857159953, 4327.199468098412, 4385.627221686129, 4386.846460373871, 4411.845585404495, 4437.267850804646, 4476.41806565151, 4725.267583524559, 4748.169070412664, 4748.3352330674425, 4751.0, 4788.856334309976, 4814.5907597854575, 4921.975390123026, 4922.655414120977, 4964.627652925973, 5012.298278241122, 4731.3612662291525, 4740.762961851825, 4741.668083234141, 4785.377900872864, 4789.736564488987, 4944.950550494593, 4948.901021979468, 4961.280614310833, 4970.055689419143, 5007.3240112584335, 4815.903681926412, 4902.240152776183, 4928.827491037797, 4930.802767889244, 4997.675151115166, 4846.0, 4865.197242454955, 4869.391326084239, 4901.877453063702, 4905.7792399342825, 4872.244802055687, 4877.561019508261, 4878.365812444359, 4881.682690625098, 4917.188663870421, 4527.094581083862, 4652.232381656989, 4652.720836749806, 4674.298855171752, 4785.282207668877, 4906.215005599087, 4915.066137433876, 4925.901481970269, 4929.0388374268105, 4954.801807927643, 4812.0, 4813.614910807197, 4814.735189564468, 4814.831480898151, 4856.174450343379], "unit": "ms", "name": "dojo.html", "value": 4580.455013913918}, {"lowerIsBetter": false, "replicates": [556.6468653113387, 565.6662569084242, 573.1030936584245, 578.5429510686558, 586.7682265505125, 27853.442931141366, 28822.42355152896, 28887.855560722168, 35920.64079359206, 36332.81833590835, 39552.80223598885, 40140.799296003555, 40155.79922100393, 40223.59776402235, 40227.39658905119, 7904.604769761518, 8076.434649574532, 8080.555569443678, 8080.717174898879, 8081.43429959903, 7109.253528379523, 7245.384142347907, 10082.445465499395, 10335.896641033607, 10407.479626018707, 9925.950370248138, 10088.89911100887, 10100.191984641211, 10112.191024718042, 10114.0, 7123.074000379917, 7274.709011639528, 10041.347312424705, 10105.9494702526, 10151.441670708145, 10194.490275486196, 10475.685729428129, 10477.947610261976, 10481.58073677052, 10492.94753526235, 36477.63522364769, 36586.268274634356, 36792.63207367919, 36814.89555313345, 36852.78883267013, 2743.876525556335, 2966.480865848468, 3498.930021399583, 3546.6476349074305, 3618.4029635110173, 27302.5904611431, 27432.17703468899, 28135.859320703472, 28202.15393538197, 28296.162186896865, 3392.3215356928467, 3392.6607339266125, 3485.6514348565192, 3566.625504322035, 3580.427131658948, 235214.0, 238098.0, 238163.0, 238205.0, 238552.0, 48745.0, 49427.752861235465, 50407.747961259956, 51477.7426112867, 60129.699351503834, 56578.7171064142, 56940.0, 57246.42753572494, 57309.71345143248, 57365.42634573684, 13409.731805363837, 13655.590332290047, 13704.10923289983, 13738.587842364745, 13746.106503077268, 10074.14369778577, 10153.746156346002, 10160.949195253976, 10192.286539942133, 10198.490075496196, 18865.811341886405, 18977.33579324717, 19148.234070637296, 19154.329598463988, 19195.8080419194, 7483.8877416838795, 7688.692452301845, 7705.4220933430215, 7728.304452599293, 7800.765977020698, 817.3175398542284, 817.5626040068654, 862.4092496639696, 890.9955450222708, 954.3939598355095, 26402.207933762016, 29304.853475732485, 29326.853365733034, 30678.0, 30792.692073078983, 818.5988865455884, 879.8768172455862, 1023.6007956896816, 1111.6942840718705, 1120.3389999900098, 13669.384877680528, 13994.440222390991, 14554.490592829412, 14567.271636418136, 15081.622959426102, 310992.0, 315936.0, 316531.0, 316617.0, 316733.0, 47763.76118119387, 47803.5219647806, 47821.28268075982, 47866.760666196446, 48424.273635895486, 1214.368528365245, 1219.3354621731178, 1240.2157157182003, 1245.6636708088765, 1247.0584708545173, 26800.865995669898, 28134.437311253252, 28480.43039139164, 29505.082169658905, 30590.4591354526, 42152.57847421487, 42542.5745742551, 42632.78683606562, 42669.14661706811, 42769.78615107029, 235294.0, 236588.0, 240112.0, 240286.0, 240652.0, 34601.30797383988, 34970.65029349674, 38891.416628751154, 41320.807071787494, 43020.78489607532, 38399.232015360096, 38528.614713852505, 38797.41803873001, 39108.0, 39205.2158956825, 32633.510497343035, 36900.630993689716, 37972.81013594914, 38431.80784096062, 38923.2215355697, 33734.0, 34184.0, 34410.0, 34436.139096522784, 34706.65293347135, 31207.531887021258, 31882.20294492656, 37786.62213377941, 38168.427473588476, 38170.618293816704, 27808.44383112367, 30890.84554577213, 31147.84426077855, 31284.687153128176, 31294.68705312918, 25356.0, 26140.817469204834, 26695.466090678467, 26771.7322826777, 26928.596071058557], "unit": "ms", "name": "ext.html", "value": 17721.627381584378}, {"lowerIsBetter": false, "replicates": [329.2673800793234, 333.16708229426433, 338.1731666076443, 338.215340410248, 338.27102593910126, 12506.937465312662, 12899.355032248397, 14972.379833529143, 15081.62295942602, 15544.300506477222, 9062.184403403693, 9105.453672779639, 9305.0, 9325.720228393142, 9337.0, 4367.890802729926, 4541.863744087666, 4545.704529205591, 4548.681592288541, 4549.0, 3302.0, 3384.5092461593053, 5040.344755181821, 5191.558717509016, 5200.401953775327, 5044.596432285427, 5113.974430127844, 5147.613928955325, 5151.150060240056, 5172.6379153459275, 5732.684702341369, 5774.451427114417, 5794.101914203306, 5801.941980580183, 5811.389804070554, 5034.471380505068, 5135.281060651511, 5141.177411614124, 5160.587153027749, 5161.225816127573, 18569.350072747387, 18586.442406727685, 18659.906700466545, 19062.33281835143, 19295.324663636704, 1737.1661602430904, 1761.2866788950496, 1781.750554922312, 1853.0364210610408, 1936.070686070694, 8610.52642104684, 8851.424657397249, 9072.228860546862, 11039.39283339416, 12338.64274929757, 1690.9661806763918, 1693.2126561149003, 1705.1815128738276, 1713.9314427422887, 1726.1196789637374, 49371.50628493705, 50012.99974000536, 53307.73346133244, 54225.72887135579, 56032.0, 8805.339599530062, 9158.129977652112, 9578.0, 9584.233261339075, 9659.227261819178, 12611.873881261254, 12716.491340346467, 12755.744885102245, 12764.425600847984, 12791.616251512469, 6929.7228110875, 6945.583265004116, 6977.616231107338, 7007.334303241184, 7042.647867606599, 6808.217055038734, 6860.485463590251, 6867.0, 6887.345702158287, 6933.861322773617, 4213.389058586549, 4280.0, 4285.635720963691, 4314.697971142053, 4323.654107671378, 1570.740827763429, 1599.6480774229651, 1675.1373042882924, 1682.3102527963722, 1688.4765722626025, 862.5299211929513, 908.2688435809237, 952.1763674421713, 972.9270304727174, 1006.2402885821305, 15917.52247432579, 15935.36258549645, 16021.439249626206, 16042.197890105448, 16477.505674829776, 849.1338834388889, 852.6504133305315, 873.8907636545432, 931.1247427418206, 932.5896605493562, 8749.16882896124, 8842.778930526789, 9097.40866843653, 9126.680566180152, 9358.485283309346, 286561.0, 288670.0, 467378.0, 473059.0, 496847.0, 57177.42822571721, 60207.39792602018, 60273.57610176463, 62980.05529917055, 71699.24391486256, 983.8671779309844, 1026.1329176845554, 1030.5311083457009, 1037.2531777120462, 1061.23591014471, 14453.132812031312, 14497.92751036238, 14539.418423263374, 14580.635484112981, 14803.18582477974, 31770.0, 32709.672903271614, 32947.0, 33208.1697957553, 33214.50891183219, 41601.583984160985, 42940.141197176505, 43902.34146487741, 44430.55569444264, 44717.77641111774, 8285.088640249447, 8426.831463370821, 8462.534560599226, 8498.872516912128, 8509.276711479593, 9853.753656158653, 12955.611331660066, 16080.597985050468, 16167.110808905623, 16211.18944052769, 12860.871391285968, 13124.73750524965, 13142.474301027853, 13156.60530184096, 13808.861911380758, 13245.072844900764, 13288.601341959757, 13340.3329833506, 13360.265185414895, 13472.0, 13064.80402793978, 13297.534586289434, 13425.194488330731, 13733.0, 13778.379972901444, 8707.564621769014, 8721.825563488568, 8809.295256379346, 8847.42491738035, 9010.90989090127, 9239.584218710308, 9341.34610577253, 11193.440327983732, 13606.591802245948, 14028.22844743549], "unit": "ms", "name": "jquery.html", "value": 7990.370861986923}, {"lowerIsBetter": false, "replicates": [1232.291432426354, 1590.3002678821317, 1645.9259333330003, 1654.5946243170417, 1675.9497215083552, 5965.0, 7019.859602807947, 7302.160251571071, 7304.890426643605, 7307.707691692339, 7021.75423860165, 7148.142222933256, 7170.713171473135, 7171.247019062988, 7176.390006849411, 2077.4910147013966, 2108.8840113793813, 2109.6519074352714, 2109.968350474744, 2110.6517424624917, 2127.638301488743, 2133.605283022638, 2135.7970992755663, 2141.2933731868447, 2159.0608085482786, 2054.907529161184, 2058.4853786553363, 2067.4831292176955, 2088.2899814063217, 2089.101686274901, 2066.0496171761006, 2079.4281572567515, 2089.5403011337557, 2090.602785470756, 2090.874547527153, 2066.5124493197086, 2105.6841473778904, 2116.608427440928, 2126.946826329339, 2129.3505480828494, 6094.299155597118, 6233.812985610393, 7050.964745176241, 7126.358627723478, 7129.394001509878, 4097.692673049533, 4170.687198460128, 4172.5410204877435, 4173.269677806402, 4176.979115104405, 2736.165469531792, 2751.147144385247, 2770.8891644334203, 2783.498970185366, 2788.539890917996, 906.5240748606968, 910.7040211931148, 918.7611221082567, 922.8695195329171, 935.4387367579466, 9474.763130921714, 9540.236781057498, 9575.09036641518, 9606.183474404685, 9611.807763844754, 3978.76127432355, 4001.6598589119667, 4056.3977228994972, 4059.330210515232, 4104.363823607286, 8376.288015518749, 8380.664773408995, 8398.706045288385, 8401.873971890427, 8424.199701028392, 4231.259529582311, 4233.386159006926, 4238.533761286256, 4264.466941632296, 4269.060806622538, 3817.6564109230303, 3822.7324087313623, 3842.3852183650483, 3850.537935447764, 3861.3821788514265, 3346.6151392589677, 3355.328934213167, 3361.9831900840827, 3387.390269751419, 3393.3382990317145, 1069.9572017119228, 1071.6731396924013, 1075.5267682219799, 1082.3722241100143, 1085.6146068145852, 922.294444749767, 937.437537477508, 938.136914039072, 970.9611615535441, 1197.4252358867793, 6612.801615951529, 6668.266490686021, 6668.766593169215, 6692.832679182962, 6696.19645642526, 428.5136370219823, 429.57686678622156, 436.1952198194326, 452.4999875137925, 452.79171581072416, 4953.504649535018, 4984.651074424828, 5057.822976195889, 5058.608882557326, 5063.367079115111, 7265.12818461788, 8457.746267611981, 8556.74329770108, 8557.315414766803, 8560.186782255676, 8148.5518296494265, 8409.03296120954, 8462.0, 8488.193621605938, 8500.829983400297, 6779.72881084761, 6855.931440685529, 6879.621620810904, 6934.930650693529, 6937.618430986344, 6465.450436712932, 6474.2554606219, 6481.287058423664, 6549.770758023446, 6576.408123268929, 7488.363489103487, 7589.810254743676, 7728.536287822749, 7735.033120859893, 7738.4969976951315, 7560.168381478143, 7732.729354472792, 7872.84254314922, 7921.841563168589, 7925.960370198112, 6080.0, 6084.452399284086, 6091.0, 6103.8779224414375, 6136.386361363828, 6780.0, 6825.726970921306, 6826.0, 6830.795076147723, 6842.110525631636, 6339.144215531029, 6451.580647257913, 6501.0, 6515.934840651533, 6588.769393071219, 6290.716917738621, 6333.809985700436, 6449.3550644937, 6457.418832305115, 6645.9003114954285, 6477.578957367945, 6511.772087976898, 6519.08732777421, 6519.576227545194, 6527.0, 5773.393793651606, 5953.583249172516, 5974.4324289192455, 6085.2393450818645, 6106.72519736604, 6170.413810687977, 6198.690065496617, 6212.378762123752, 6212.943799554177, 6222.377762223741], "unit": "ms", "name": "mootools.html", "value": 4005.7302931161307}, {"lowerIsBetter": false, "replicates": [298.9312458134629, 300.3452473607536, 307.1400079776628, 307.91070589529033, 311.17383347213143, 5212.973935130319, 5255.527002569768, 5281.155015197569, 5321.361436627601, 5417.052015897222, 5134.589232861372, 5250.8687282817855, 5286.920696189561, 5294.788208471657, 5299.258103865462, 3913.1391093959282, 4022.8994275143064, 4035.656969157625, 4041.6968727345493, 4083.4895638045246, 3997.060690737674, 4023.135025969416, 4097.79511024449, 4102.466679331683, 4106.260873042851, 4054.331035379159, 4055.5944405559358, 4057.8985525361954, 4058.959410405888, 4066.512018557777, 4053.209624123297, 4055.0, 4059.9797001014954, 4065.451164092839, 4068.125353049079, 3531.611522732497, 3535.7878527288444, 3536.681698647134, 3536.9115772105647, 3537.663921927413, 5010.3737032870895, 5144.099782538041, 5151.278820965068, 5151.356080489939, 5151.7681704323395, 4679.766011699401, 4682.6019788318035, 4683.203855344565, 4694.600958918496, 4699.483056863743, 5579.69311687857, 5580.469855363734, 5591.860203494904, 5592.217089607459, 5596.468335508121, 3694.3350196964534, 3802.4106263529197, 3875.8255878485534, 3879.72841901067, 3881.2819628368843, 5752.884942301131, 5868.706564671792, 5896.056630939029, 5896.056630939029, 5905.704714764244, 3966.662833659171, 3967.861124860616, 3968.6825053995613, 3970.4242884781543, 3973.344398174269, 4019.959800402017, 4023.094803669151, 4027.3958906163725, 4027.7986100694848, 4027.9194416111513, 4567.13241235244, 4640.257558790578, 4643.721376717408, 4648.418947631546, 4669.60308373792, 5595.468430499096, 5602.4957753802355, 5602.663840169603, 5611.663300202001, 5618.325800903917, 1416.4759039155579, 1436.0737324425686, 1436.4685066525453, 1436.590571687064, 1437.0659071603332, 936.8594710793435, 949.2785483032944, 963.2679163835395, 966.9951650241704, 973.0658567774874, 4873.220284754422, 4881.267809828483, 4887.29134275528, 4888.120138375127, 4890.508394939578, 5810.854728631818, 5824.88350232993, 5825.7087145642545, 5827.271591051119, 5829.708514574254, 4875.171220892456, 4876.707397556158, 4882.340883980688, 4887.95112048882, 4888.535589119028, 3023.909282721522, 3098.4422803895513, 3120.1107684309864, 3127.8436078196455, 3145.811251324928, 5513.42109078549, 5515.0, 5519.503244707996, 5519.69641669704, 5522.585806064561, 6009.429104235091, 6013.338532761392, 6018.879622407528, 6024.457798798129, 6025.276966764016, 5504.614676972654, 5513.696746678971, 5513.862153446196, 5517.834464966058, 5519.061759500814, 5672.432756724294, 5812.18629391877, 5815.534757219328, 5816.331121920864, 5830.300363956352, 5455.0, 5703.914441283467, 5711.314642242791, 5714.399988001366, 5727.0, 5336.279602253801, 5410.161424979135, 5411.918821217606, 5414.485623865727, 5425.945740542544, 3989.4215338775134, 4033.3949907514107, 4033.7176397651883, 4036.2129384769687, 4040.7373520721058, 5825.3592104867585, 5840.386759390372, 5842.444967728059, 5843.970780146072, 5846.152307915243, 5491.972540137273, 5623.550115990793, 5626.718664066862, 5651.4348565143155, 5658.03813351723, 5648.689322087324, 5659.547236221175, 5661.037623603915, 5662.716864156858, 5665.20687103814, 5540.141278101901, 5543.972280138573, 5544.805931792368, 5545.417731138334, 5547.583931205095, 5543.3902270751, 5693.829185124453, 5697.088465845445, 5698.886022279448, 5700.486956173799, 5541.251930989426, 5546.972265138648, 5550.417206193453, 5554.1391084381985, 5557.749901254534], "unit": "ms", "name": "prototype.html", "value": 4190.876322632849}, {"lowerIsBetter": false, "replicates": [651.244556314675, 731.8828987362022, 739.9704011839526, 751.77070993347, 755.7506023012406, 12020.879791202085, 12029.278243305396, 12049.518019279218, 12080.69798255043, 12102.273863568182, 11611.245269057505, 11745.23655962364, 12809.423575939081, 13008.804867926989, 13023.869761302383, 773.4624436016957, 788.4165717369162, 788.4323287233183, 788.4953629677011, 789.1201310538765, 622.2874808344443, 630.8959021761403, 631.3844002097964, 770.1335997003371, 788.1999770233218, 810.2586133687669, 812.2892469089546, 817.6075483767795, 817.7464985854374, 818.1041759273616, 646.6217262901162, 809.5628360685223, 810.4610434061342, 810.9553974531399, 811.5698679699768, 479.820067474697, 587.597495715432, 595.9344472108064, 597.0357872036673, 598.5780025082306, 11788.469518871585, 11801.822972655416, 11895.286282823059, 11917.046636269077, 11957.820632690517, 10706.979198295716, 10945.507452164671, 11061.944690276498, 11349.489272982735, 11710.0, 9092.909070909272, 9149.496777677225, 9156.158101978754, 9159.129882661136, 9422.246220302359, 3075.7539396848424, 3082.075377386775, 3102.7672924530752, 3120.4851199552045, 3163.43058249515, 40247.0, 40758.388624170664, 41105.79447102745, 41273.79363103165, 41421.37867931953, 8615.483071015758, 8616.09530999236, 8624.870626940601, 8745.212930836255, 9032.548372581345, 15625.531234062997, 15638.139902305482, 15666.530004099895, 15695.764563531557, 15704.685906281811, 5866.911996320058, 5925.703714814242, 5974.0, 6043.456088952015, 6162.291336496271, 3416.1288871338147, 3467.8612855486003, 3505.9123521912156, 3536.540249767565, 3598.1364472526407, 2707.91876243713, 2719.0, 2720.91837244883, 2741.368286445035, 2848.1170837040586, 515.7215103843882, 525.7502686224013, 533.6531254684486, 535.7080391186812, 537.5780012690019, 416.91661667666585, 470.4613217865525, 528.0442399257356, 613.7084884679741, 628.5474458389951, 7319.707211711579, 7394.704211831574, 7396.704131834774, 7432.405407567489, 7466.887996680054, 520.6277511579239, 564.0383146734807, 592.2301008688687, 624.4941597306197, 631.3875540725489, 3719.6466335698065, 3735.495708079429, 3774.7168962327937, 3823.9426408603895, 3910.432987216838, 42090.57909420928, 44416.55583444189, 46240.768796155804, 51009.0, 51106.0, 43069.0, 43597.564024359985, 43668.344974825406, 43833.0, 44172.779136104116, 38777.806110969264, 38908.02729931774, 38956.80521597431, 39054.41418378727, 39153.0, 7997.7600671979935, 8039.598020099089, 8113.594320283844, 8381.245687888118, 8488.278496327634, 32380.676193237767, 32483.675163248066, 32553.674463255065, 32620.347593048482, 33077.84227552024, 38076.23847523089, 39521.0, 41075.794621026704, 41499.1700166001, 42327.0, 9988.550515226687, 10217.489125543842, 10221.9488902555, 10275.588976440858, 10447.791044179226, 9462.2430205582, 9520.952395237979, 10270.127039201752, 11116.388598627153, 11816.586419475278, 10673.0, 11100.167487438313, 11107.72230694239, 11180.552777888794, 11366.431678416211, 10681.89318106809, 10725.41010244444, 10753.408562529135, 10969.23215374916, 11162.832557511481, 9996.650117246152, 10405.375677459377, 10519.789604208027, 10551.788964220827, 10759.408232546972, 9292.535373231176, 9457.24342052648, 9459.195968342769, 9759.12167904892, 9908.653197138066, 8607.096254893397, 8822.33832462555, 9019.278457723498, 9021.684241051795, 9283.953580232055], "unit": "ms", "name": "yui.html", "value": 5654.7381784712525}], "name": "dromaeo_css", "value": 6284.021691717677}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 105.0, 111.0, 114.0, 113.0, 101.0, 113.0, 110.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [148.0, 130.0, 165.0, 171.0, 129.0, 153.0, 152.0, 135.0, 169.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 82.0, 90.0, 74.0, 72.0, 73.0, 101.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 132.0, 94.0, 96.0, 96.0, 134.0, 95.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 98.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 70.0, 70.0, 70.0, 69.0, 71.0, 70.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 70.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [82.0, 90.0, 86.0, 85.0, 84.0, 83.0, 85.0, 84.0, 84.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 125.0, 123.0, 124.0, 119.0, 127.0, 126.0, 119.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 144.0, 156.0, 145.0, 134.0, 144.0, 133.0, 157.0, 149.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 67.0, 69.0, 68.0, 68.0, 70.0, 67.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1515.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.68174753928508], "unit": "score", "name": "Richards", "value": 204.43388200000004}, {"lowerIsBetter": false, "replicates": [185.56318426424198], "unit": "score", "name": "DeltaBlue", "value": 356.309902}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [11788.235294117647], "unit": "score", "name": "Boyer", "value": 56.536282435129706}, {"lowerIsBetter": false, "replicates": [26947.36842105263], "unit": "score", "name": "RegExp", "value": 33.80608398437501}, {"lowerIsBetter": false, "replicates": [594.883997620464], "unit": "score", "name": "Splay", "value": 136.98637100000005}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19835.903925207615}]} 16:49:55 INFO - RETURN: dromaeo_css: 6284.02 16:49:55 INFO - RETURN: kraken: 1515.70 16:49:55 INFO - RETURN: v8_7: 19835.90 16:49:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19835.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6284.02"}}} 16:49:55 INFO - Return code: 0 16:49:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:49:55 INFO - # TBPL SUCCESS # 16:49:55 INFO - Running post-action listener: _resource_record_post_action 16:49:55 INFO - Running post-run listener: _resource_record_post_run 16:49:56 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508026880; Read time: 108; Write time: 311096 16:49:56 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 230932480; Read time: 0; Write time: 177188 16:49:56 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276230144; Read time: 108; Write time: 133872 16:49:56 INFO - Running post-run listener: _upload_blobber_files 16:49:56 INFO - Blob upload gear active. 16:49:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:49:56 INFO - Copying logs to upload dir... 16:49:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.865853 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-03 16:49:55.921330) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:49:55.924423) ========= 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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009950 build_url: 'https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/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 16:49:55.978516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:49:55.979069) ========= 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=3e14eba40af1795cf0357910000001c3-1449188319.767963-1135194590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:49:56.029657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 16:49:56.029957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 16:49:56.030245) ========= ========= Total master_lag: 0.24 =========