builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1449188918.61 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.609906) ========= 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.610435) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.610779) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.643365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.643690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.668137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.668390) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.717836) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.718164) ========= 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.718540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.718832) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 16:28:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-03 16:28:38 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.831282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.831626) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022068 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.882981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:38.883369) ========= 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=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 16:28:39,084 truncating revision to first 12 chars 2015-12-03 16:28:39,084 Setting DEBUG logging. 2015-12-03 16:28:39,084 attempt 1/10 2015-12-03 16:28:39,084 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:39,479 unpacking tar archive at: fx-team-d05e74081475/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:39.677513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:39.677888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:39.699153) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 16:28:39.699426) ========= 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:39.699801) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 16:28:39.700126) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:28:39 INFO - MultiFileLogger online at 20151203 16:28:39 in /builds/slave/test 16:28:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:39 INFO - {'append_to_log': False, 16:28:39 INFO - 'base_work_dir': '/builds/slave/test', 16:28:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:28:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:39 INFO - 'branch': 'Fx-Team-Non-PGO', 16:28:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:39 INFO - 'config_files': ('talos/linux_config.py',), 16:28:39 INFO - 'default_actions': ('clobber', 16:28:39 INFO - 'read-buildbot-config', 16:28:39 INFO - 'download-and-extract', 16:28:39 INFO - 'populate-webroot', 16:28:39 INFO - 'create-virtualenv', 16:28:39 INFO - 'install', 16:28:39 INFO - 'run-tests'), 16:28:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:39 INFO - 'download_minidump_stackwalk': True, 16:28:39 INFO - 'download_symbols': 'ondemand', 16:28:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:39 INFO - 'installer_path': 'installer.exe', 16:28:39 INFO - 'log_level': 'info', 16:28:39 INFO - 'log_name': 'talos', 16:28:39 INFO - 'log_to_console': True, 16:28:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:28:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:28:39 INFO - 'opt_config_files': (), 16:28:39 INFO - 'pip_index': False, 16:28:39 INFO - 'sps_profile': False, 16:28:39 INFO - 'sps_profile_interval': 0, 16:28:39 INFO - 'suite': 'dromaeojs-e10s', 16:28:39 INFO - 'system_bits': '64', 16:28:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:39 INFO - 'title': 'talos-linux64-ix-045', 16:28:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:39 INFO - 'use_talos_json': True, 16:28:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:39 INFO - 'work_dir': 'build'} 16:28:39 INFO - ##### 16:28:39 INFO - ##### Running clobber step. 16:28:39 INFO - ##### 16:28:39 INFO - Running pre-action listener: _resource_record_pre_action 16:28:39 INFO - Running main action method: clobber 16:28:39 INFO - rmtree: /builds/slave/test/build 16:28:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:40 INFO - Running post-action listener: _resource_record_post_action 16:28:40 INFO - ##### 16:28:40 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 16:28:40 INFO - Using buildbot properties: 16:28:40 INFO - { 16:28:40 INFO - "properties": { 16:28:40 INFO - "buildnumber": 796, 16:28:40 INFO - "product": "firefox", 16:28:40 INFO - "script_repo_revision": "production", 16:28:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:28:40 INFO - "repository": "", 16:28:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:28:40 INFO - "buildid": "20151203154241", 16:28:40 INFO - "slavename": "talos-linux64-ix-045", 16:28:40 INFO - "pgo_build": "False", 16:28:40 INFO - "basedir": "/builds/slave/test", 16:28:40 INFO - "project": "", 16:28:40 INFO - "platform": "ubuntu64_hw", 16:28:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:28:40 INFO - "slavebuilddir": "test", 16:28:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:28:40 INFO - "branch": "fx-team", 16:28:40 INFO - "repo_path": "integration/fx-team", 16:28:40 INFO - "stage_platform": "linux64", 16:28:40 INFO - "builduid": "5fa54660a384465383934c7ef28efe75", 16:28:40 INFO - "revision": "d05e740814759b053ffaec0ef924e2f916833d31" 16:28:40 INFO - }, 16:28:40 INFO - "sourcestamp": { 16:28:40 INFO - "repository": "", 16:28:40 INFO - "hasPatch": false, 16:28:40 INFO - "project": "", 16:28:40 INFO - "branch": "fx-team-linux64-talos", 16:28:40 INFO - "changes": [ 16:28:40 INFO - { 16:28:40 INFO - "category": null, 16:28:40 INFO - "files": [ 16:28:40 INFO - { 16:28:40 INFO - "url": null, 16:28:40 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:40 INFO - } 16:28:40 INFO - ], 16:28:40 INFO - "repository": "", 16:28:40 INFO - "rev": "d05e740814759b053ffaec0ef924e2f916833d31", 16:28:40 INFO - "who": "dtownsend@mozilla.com", 16:28:40 INFO - "when": 1449188858, 16:28:40 INFO - "number": 6741642, 16:28:40 INFO - "comments": "Bug 1229519: Fix toolkit/components/contentprefs to pass eslint checks. r=mconley", 16:28:40 INFO - "project": "", 16:28:40 INFO - "at": "Thu 03 Dec 2015 16:27:38", 16:28:40 INFO - "branch": "fx-team-linux64-talos", 16:28:40 INFO - "revlink": "", 16:28:40 INFO - "properties": [ 16:28:40 INFO - [ 16:28:40 INFO - "buildid", 16:28:40 INFO - "20151203154241", 16:28:40 INFO - "Change" 16:28:40 INFO - ], 16:28:40 INFO - [ 16:28:40 INFO - "builduid", 16:28:40 INFO - "5fa54660a384465383934c7ef28efe75", 16:28:40 INFO - "Change" 16:28:40 INFO - ], 16:28:40 INFO - [ 16:28:40 INFO - "pgo_build", 16:28:40 INFO - "False", 16:28:40 INFO - "Change" 16:28:40 INFO - ] 16:28:40 INFO - ], 16:28:40 INFO - "revision": "d05e740814759b053ffaec0ef924e2f916833d31" 16:28:40 INFO - } 16:28:40 INFO - ], 16:28:40 INFO - "revision": "d05e740814759b053ffaec0ef924e2f916833d31" 16:28:40 INFO - } 16:28:40 INFO - } 16:28:40 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:40 INFO - Running post-action listener: _resource_record_post_action 16:28:40 INFO - ##### 16:28:40 INFO - ##### Running download-and-extract 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: download_and_extract 16:28:40 INFO - mkdir: /builds/slave/test/build/tests 16:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:40 INFO - https://queue.taskcluster.net/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:28:40 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:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eeix5E7uSl-_JWX8U19orQ/artifacts/public/build/test_packages.json 16:28:40 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:40 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:43 INFO - Downloaded 1302 bytes. 16:28:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:28:43 INFO - Using the following test package requirements: 16:28:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:28:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:43 INFO - u'jsshell-linux-x86_64.zip'], 16:28:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:28:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:28:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:28:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:28:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:28:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:43 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:43 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:43 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:43 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:43 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:45 INFO - Downloaded 21788775 bytes. 16:28:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:28:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:28:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:28:46 INFO - Return code: 0 16:28:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:46 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:46 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:46 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:46 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:46 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:50 INFO - Return code: 0 16:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:50 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:50 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:50 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:50 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:50 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:52 INFO - Downloaded 11132001 bytes. 16:28:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 16:28:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:28:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:28:52 INFO - Return code: 0 16:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:52 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:52 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:52 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:52 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:52 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:54 INFO - Downloaded 57688660 bytes. 16:28:54 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:54 INFO - mkdir: /builds/slave/test/properties 16:28:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:54 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:54 INFO - Contents: 16:28:54 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:54 INFO - Running post-action listener: _resource_record_post_action 16:28:54 INFO - Running post-action listener: set_extra_try_arguments 16:28:54 INFO - ##### 16:28:54 INFO - ##### Running populate-webroot step. 16:28:54 INFO - ##### 16:28:54 INFO - Running pre-action listener: _resource_record_pre_action 16:28:54 INFO - Running main action method: populate_webroot 16:28:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:28:54 INFO - '../fennec_ids.txt'], 16:28:54 INFO - 'tests': ['tcheck2']}, 16:28:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:54 INFO - '--tppagecycles', 16:28:54 INFO - '7'], 16:28:54 INFO - 'tests': ['tsvgm']}}, 16:28:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:28:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:28:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:28:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'tests': ['damp', 'tps']}, 16:28:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['damp', 'tps']}, 16:28:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:28:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:54 INFO - 'other': {'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore']}, 16:28:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore']}, 16:28:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore']}, 16:28:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore']}, 16:28:54 INFO - 'other_l64': {'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore']}, 16:28:54 INFO - 'other_nol64': {'tests': ['a11yr', 16:28:54 INFO - 'ts_paint', 16:28:54 INFO - 'tpaint', 16:28:54 INFO - 'sessionrestore', 16:28:54 INFO - 'sessionrestore_no_auto_restore']}, 16:28:54 INFO - 'svgr': {'tests': ['tsvgx', 16:28:54 INFO - 'tsvgr_opacity', 16:28:54 INFO - 'tart', 16:28:54 INFO - 'tscrollx', 16:28:54 INFO - 'cart']}, 16:28:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['tsvgx', 16:28:54 INFO - 'tsvgr_opacity', 16:28:54 INFO - 'tart', 16:28:54 INFO - 'tscrollx', 16:28:54 INFO - 'cart']}, 16:28:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'tests': ['tp5o']}, 16:28:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'talos_options': ['--e10s'], 16:28:54 INFO - 'tests': ['tp5o']}, 16:28:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'talos_options': ['--xperf_path', 16:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:54 INFO - 'tests': ['tp5n']}, 16:28:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:54 INFO - 'talos_options': ['--e10s', 16:28:54 INFO - '--xperf_path', 16:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:54 INFO - 'tests': ['tp5n']}}, 16:28:54 INFO - 'talos.zip': {'path': '', 16:28:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:54 INFO - Running post-action listener: _resource_record_post_action 16:28:54 INFO - ##### 16:28:54 INFO - ##### Running create-virtualenv step. 16:28:54 INFO - ##### 16:28:54 INFO - Running pre-action listener: _resource_record_pre_action 16:28:54 INFO - Running main action method: create_virtualenv 16:28:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:28:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:54 INFO - Using real prefix '/usr' 16:28:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:56 INFO - Installing pip.................done. 16:28:56 INFO - Return code: 0 16:28:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:28:56 INFO - Using env: {'DISPLAY': ':0', 16:28:56 INFO - 'HOME': '/home/cltbld', 16:28:56 INFO - 'LANG': 'en_US.UTF-8', 16:28:56 INFO - 'LANGUAGE': 'en_US:en', 16:28:56 INFO - 'LOGNAME': 'cltbld', 16:28:56 INFO - 'MAIL': '/var/mail/cltbld', 16:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:56 INFO - 'MOZ_NO_REMOTE': '1', 16:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:56 INFO - 'NO_EM_RESTART': '1', 16:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:56 INFO - 'PWD': '/builds/slave/test', 16:28:56 INFO - 'SHELL': '/bin/bash', 16:28:56 INFO - 'SHLVL': '1', 16:28:56 INFO - 'TERM': 'linux', 16:28:56 INFO - 'TMOUT': '86400', 16:28:56 INFO - 'USER': 'cltbld', 16:28:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:56 INFO - '_': '/tools/buildbot/bin/python'} 16:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:28:57 INFO - Cleaning up... 16:28:57 INFO - Return code: 0 16:28:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:28:57 INFO - Using env: {'DISPLAY': ':0', 16:28:57 INFO - 'HOME': '/home/cltbld', 16:28:57 INFO - 'LANG': 'en_US.UTF-8', 16:28:57 INFO - 'LANGUAGE': 'en_US:en', 16:28:57 INFO - 'LOGNAME': 'cltbld', 16:28:57 INFO - 'MAIL': '/var/mail/cltbld', 16:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:57 INFO - 'MOZ_NO_REMOTE': '1', 16:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:57 INFO - 'NO_EM_RESTART': '1', 16:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:57 INFO - 'PWD': '/builds/slave/test', 16:28:57 INFO - 'SHELL': '/bin/bash', 16:28:57 INFO - 'SHLVL': '1', 16:28:57 INFO - 'TERM': 'linux', 16:28:57 INFO - 'TMOUT': '86400', 16:28:57 INFO - 'USER': 'cltbld', 16:28:57 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:57 INFO - '_': '/tools/buildbot/bin/python'} 16:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:57 INFO - Downloading/unpacking psutil>=0.7.1 16:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:28:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:59 INFO - Installing collected packages: psutil 16:28:59 INFO - Running setup.py install for psutil 16:28:59 INFO - building 'psutil._psutil_linux' extension 16:28:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:28:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:28:59 INFO - building 'psutil._psutil_posix' extension 16:28:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:28:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:59 INFO - Successfully installed psutil 16:28:59 INFO - Cleaning up... 16:28:59 INFO - Return code: 0 16:28:59 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:59 INFO - '_': '/tools/buildbot/bin/python'} 16:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:29:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:29:01 INFO - Installing collected packages: mozsystemmonitor 16:29:01 INFO - Running setup.py install for mozsystemmonitor 16:29:01 INFO - Successfully installed mozsystemmonitor 16:29:01 INFO - Cleaning up... 16:29:01 INFO - Return code: 0 16:29:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:29:01 INFO - Using env: {'DISPLAY': ':0', 16:29:01 INFO - 'HOME': '/home/cltbld', 16:29:01 INFO - 'LANG': 'en_US.UTF-8', 16:29:01 INFO - 'LANGUAGE': 'en_US:en', 16:29:01 INFO - 'LOGNAME': 'cltbld', 16:29:01 INFO - 'MAIL': '/var/mail/cltbld', 16:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:01 INFO - 'MOZ_NO_REMOTE': '1', 16:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:01 INFO - 'NO_EM_RESTART': '1', 16:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:01 INFO - 'PWD': '/builds/slave/test', 16:29:01 INFO - 'SHELL': '/bin/bash', 16:29:01 INFO - 'SHLVL': '1', 16:29:01 INFO - 'TERM': 'linux', 16:29:01 INFO - 'TMOUT': '86400', 16:29:01 INFO - 'USER': 'cltbld', 16:29:01 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:01 INFO - '_': '/tools/buildbot/bin/python'} 16:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:02 INFO - Downloading/unpacking blobuploader==1.2.4 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:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:03 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:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:04 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:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:04 INFO - Downloading docopt-0.6.1.tar.gz 16:29:04 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:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:04 INFO - Running setup.py install for blobuploader 16:29:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:04 INFO - Running setup.py install for requests 16:29:04 INFO - Running setup.py install for docopt 16:29:05 INFO - Successfully installed blobuploader requests docopt 16:29:05 INFO - Cleaning up... 16:29:05 INFO - Return code: 0 16:29:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:05 INFO - Using env: {'DISPLAY': ':0', 16:29:05 INFO - 'HOME': '/home/cltbld', 16:29:05 INFO - 'LANG': 'en_US.UTF-8', 16:29:05 INFO - 'LANGUAGE': 'en_US:en', 16:29:05 INFO - 'LOGNAME': 'cltbld', 16:29:05 INFO - 'MAIL': '/var/mail/cltbld', 16:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:05 INFO - 'MOZ_NO_REMOTE': '1', 16:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:05 INFO - 'NO_EM_RESTART': '1', 16:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:05 INFO - 'PWD': '/builds/slave/test', 16:29:05 INFO - 'SHELL': '/bin/bash', 16:29:05 INFO - 'SHLVL': '1', 16:29:05 INFO - 'TERM': 'linux', 16:29:05 INFO - 'TMOUT': '86400', 16:29:05 INFO - 'USER': 'cltbld', 16:29:05 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:05 INFO - '_': '/tools/buildbot/bin/python'} 16:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:05 INFO - Running setup.py (path:/tmp/pip-5oNBSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:05 INFO - Running setup.py (path:/tmp/pip-szDXSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:05 INFO - Running setup.py (path:/tmp/pip-N8xd1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:05 INFO - Running setup.py (path:/tmp/pip-dhxkyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:05 INFO - Running setup.py (path:/tmp/pip-KHdcFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:05 INFO - Running setup.py (path:/tmp/pip-vq96Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:05 INFO - Running setup.py (path:/tmp/pip-4R6Oey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:05 INFO - Running setup.py (path:/tmp/pip-uHUa0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:05 INFO - Running setup.py (path:/tmp/pip-nP7_tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:05 INFO - Running setup.py (path:/tmp/pip-yeaai0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:06 INFO - Running setup.py (path:/tmp/pip-rYCDkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:06 INFO - Running setup.py (path:/tmp/pip-5MzqUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:06 INFO - Running setup.py (path:/tmp/pip-CFPKxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:06 INFO - Running setup.py (path:/tmp/pip-g1RUyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:06 INFO - Running setup.py (path:/tmp/pip-9bXs6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:06 INFO - Running setup.py (path:/tmp/pip-xseiQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:06 INFO - Running setup.py (path:/tmp/pip-jlEszB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:06 INFO - Running setup.py install for manifestparser 16:29:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:06 INFO - Running setup.py install for mozcrash 16:29:06 INFO - Running setup.py install for mozdebug 16:29:06 INFO - Running setup.py install for mozdevice 16:29:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:29:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:29:06 INFO - Running setup.py install for mozfile 16:29:07 INFO - Running setup.py install for mozhttpd 16:29:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Running setup.py install for mozinfo 16:29:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Running setup.py install for mozInstall 16:29:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Running setup.py install for mozleak 16:29:07 INFO - Running setup.py install for mozlog 16:29:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Running setup.py install for moznetwork 16:29:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Running setup.py install for mozprocess 16:29:07 INFO - Running setup.py install for mozprofile 16:29:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:29:07 INFO - Running setup.py install for mozrunner 16:29:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:29:08 INFO - Running setup.py install for mozscreenshot 16:29:08 INFO - Running setup.py install for moztest 16:29:08 INFO - Running setup.py install for mozversion 16:29:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:29:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:08 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', '--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 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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', '--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 --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': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 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-w9ITGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:08 INFO - Running setup.py (path:/tmp/pip-IE1sJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:08 INFO - Running setup.py (path:/tmp/pip-iPcqbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:08 INFO - Running setup.py (path:/tmp/pip-75q_eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:08 INFO - Running setup.py (path:/tmp/pip-cSbiot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:08 INFO - Running setup.py (path:/tmp/pip-a4uS19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:08 INFO - Running setup.py (path:/tmp/pip-moKZqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:09 INFO - Running setup.py (path:/tmp/pip-SpBdAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:09 INFO - Running setup.py (path:/tmp/pip-943F3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:09 INFO - Running setup.py (path:/tmp/pip-2ElXlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:09 INFO - Running setup.py (path:/tmp/pip-5rUuLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:09 INFO - Running setup.py (path:/tmp/pip-44uVMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:09 INFO - Running setup.py (path:/tmp/pip-gglvNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:09 INFO - Running setup.py (path:/tmp/pip-yM0Td9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:09 INFO - Running setup.py (path:/tmp/pip-87yWy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:09 INFO - Running setup.py (path:/tmp/pip-VE9MW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:09 INFO - Running setup.py (path:/tmp/pip-AbKWNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:09 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:09 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:09 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:09 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:09 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:09 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:11 INFO - Downloading blessings-1.5.1.tar.gz 16:29:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:29:11 INFO - Installing collected packages: blessings 16:29:11 INFO - Running setup.py install for blessings 16:29:11 INFO - Successfully installed blessings 16:29:11 INFO - Cleaning up... 16:29:11 INFO - Return code: 0 16:29:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:29:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:11 INFO - Reading from file tmpfile_stdout 16:29:11 INFO - Current package versions: 16:29:11 INFO - argparse == 1.2.1 16:29:11 INFO - blessings == 1.5.1 16:29:11 INFO - blobuploader == 1.2.4 16:29:11 INFO - docopt == 0.6.1 16:29:11 INFO - manifestparser == 1.1 16:29:11 INFO - mozInstall == 1.12 16:29:11 INFO - mozcrash == 0.16 16:29:11 INFO - mozdebug == 0.1 16:29:11 INFO - mozdevice == 0.47 16:29:11 INFO - mozfile == 1.2 16:29:11 INFO - mozhttpd == 0.7 16:29:11 INFO - mozinfo == 0.9 16:29:11 INFO - mozleak == 0.1 16:29:11 INFO - mozlog == 3.1 16:29:11 INFO - moznetwork == 0.27 16:29:11 INFO - mozprocess == 0.22 16:29:11 INFO - mozprofile == 0.27 16:29:11 INFO - mozrunner == 6.11 16:29:11 INFO - mozscreenshot == 0.1 16:29:11 INFO - mozsystemmonitor == 0.0 16:29:11 INFO - moztest == 0.7 16:29:11 INFO - mozversion == 1.4 16:29:11 INFO - psutil == 3.1.1 16:29:11 INFO - requests == 1.2.3 16:29:11 INFO - wsgiref == 0.1.2 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/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 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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/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: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/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: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': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:11 INFO - '_': '/tools/buildbot/bin/python'} 16:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 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 mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:12 INFO - Cleaning up... 16:29:12 INFO - Return code: 0 16:29:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:29:12 INFO - Using env: {'DISPLAY': ':0', 16:29:12 INFO - 'HOME': '/home/cltbld', 16:29:12 INFO - 'LANG': 'en_US.UTF-8', 16:29:12 INFO - 'LANGUAGE': 'en_US:en', 16:29:12 INFO - 'LOGNAME': 'cltbld', 16:29:12 INFO - 'MAIL': '/var/mail/cltbld', 16:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:12 INFO - 'MOZ_NO_REMOTE': '1', 16:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:12 INFO - 'NO_EM_RESTART': '1', 16:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:12 INFO - 'PWD': '/builds/slave/test', 16:29:12 INFO - 'SHELL': '/bin/bash', 16:29:12 INFO - 'SHLVL': '1', 16:29:12 INFO - 'TERM': 'linux', 16:29:12 INFO - 'TMOUT': '86400', 16:29:12 INFO - 'USER': 'cltbld', 16:29:12 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:12 INFO - '_': '/tools/buildbot/bin/python'} 16:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:12 INFO - Downloading/unpacking jsonschema 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 jsonschema-2.5.1-py2.py3-none-any.whl 16:29:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:29:14 INFO - Downloading/unpacking functools32 (from jsonschema) 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:29:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:29:14 INFO - warning: no files found matching '*.txt' 16:29:14 INFO - no previously-included directories found matching 'build' 16:29:14 INFO - no previously-included directories found matching 'dist' 16:29:14 INFO - no previously-included directories found matching '.git*' 16:29:14 INFO - Installing collected packages: jsonschema, functools32 16:29:14 INFO - Running setup.py install for functools32 16:29:14 INFO - warning: no files found matching '*.txt' 16:29:14 INFO - no previously-included directories found matching 'build' 16:29:14 INFO - no previously-included directories found matching 'dist' 16:29:14 INFO - no previously-included directories found matching '.git*' 16:29:14 INFO - Successfully installed jsonschema functools32 16:29:14 INFO - Cleaning up... 16:29:14 INFO - Return code: 0 16:29:14 INFO - Installing flake8 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', '--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 0x7fc82ad3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', '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', '--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:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 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': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:14 INFO - '_': '/tools/buildbot/bin/python'} 16:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:14 INFO - Downloading/unpacking flake8 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:16 INFO - Downloading flake8-2.5.0-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%2Fflake8-2.5.0-py2.py3-none-any.whl 16:29:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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:16 INFO - Downloading mccabe-0.3.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%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:29:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:16 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:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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:16 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:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:29:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:29:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:29:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:29:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:29:17 INFO - no previously-included directories found matching 'docs/_build' 16:29:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:29:17 INFO - Running setup.py install for pep8 16:29:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:29:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:29:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:29:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:29:17 INFO - no previously-included directories found matching 'docs/_build' 16:29:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:29:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:29:17 INFO - Cleaning up... 16:29:17 INFO - Return code: 0 16:29:17 INFO - Running post-action listener: _resource_record_post_action 16:29:17 INFO - Running post-action listener: _start_resource_monitoring 16:29:17 INFO - Starting resource monitoring. 16:29:17 INFO - ##### 16:29:17 INFO - ##### Running install step. 16:29:17 INFO - ##### 16:29:17 INFO - Running pre-action listener: _resource_record_pre_action 16:29:17 INFO - Running main action method: install 16:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:17 INFO - Reading from file tmpfile_stdout 16:29:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:29:17 INFO - Reading from file tmpfile_stdout 16:29:17 INFO - Output received: 16:29:17 INFO - Usage: mozinstall [options] installer 16:29:17 INFO - Options: 16:29:17 INFO - -h, --help show this help message and exit 16:29:17 INFO - -d DEST, --destination=DEST 16:29:17 INFO - Directory to install application into. [default: 16:29:17 INFO - "/builds/slave/test"] 16:29:17 INFO - --app=APP Application being installed. [default: firefox] 16:29:17 INFO - mkdir: /builds/slave/test/build/application 16:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:29:32 INFO - Reading from file tmpfile_stdout 16:29:32 INFO - Output received: 16:29:32 INFO - /builds/slave/test/build/application/firefox/firefox 16:29:32 INFO - Running post-action listener: _resource_record_post_action 16:29:32 INFO - ##### 16:29:32 INFO - ##### Running run-tests step. 16:29:32 INFO - ##### 16:29:32 INFO - Running pre-action listener: _resource_record_pre_action 16:29:32 INFO - Running main action method: run_tests 16:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:32 INFO - Python 2.7.3 16:29:32 INFO - Return code: 0 16:29:32 INFO - grabbing minidump binary from tooltool 16:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:29:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17530b0>, '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 0x1753fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:29:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:29:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:32 INFO - Return code: 0 16:29:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:29:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:29:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:29:33 INFO - Return code: 0 16:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--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-045', '--webServer', 'localhost'] in /builds/slave/test/build 16:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --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-045 --webServer localhost 16:29:33 INFO - Using env: {'DISPLAY': ':0', 16:29:33 INFO - 'HOME': '/home/cltbld', 16:29:33 INFO - 'LANG': 'en_US.UTF-8', 16:29:33 INFO - 'LANGUAGE': 'en_US:en', 16:29:33 INFO - 'LOGNAME': 'cltbld', 16:29:33 INFO - 'MAIL': '/var/mail/cltbld', 16:29:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:33 INFO - 'MOZ_NO_REMOTE': '1', 16:29:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:33 INFO - 'NO_EM_RESTART': '1', 16:29:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:33 INFO - 'PWD': '/builds/slave/test', 16:29:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:33 INFO - 'SHELL': '/bin/bash', 16:29:33 INFO - 'SHLVL': '1', 16:29:33 INFO - 'TERM': 'linux', 16:29:33 INFO - 'TMOUT': '86400', 16:29:33 INFO - 'USER': 'cltbld', 16:29:33 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105', 16:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:33 INFO - '_': '/tools/buildbot/bin/python'} 16:29:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--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-045', '--webServer', 'localhost'] with output_timeout 3600 16:29:33 INFO - mozversion INFO | application_buildid: 20151203154241 16:29:33 INFO - mozversion INFO | application_changeset: d05e740814759b053ffaec0ef924e2f916833d31 16:29:33 INFO - mozversion INFO | application_display_name: Nightly 16:29:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:33 INFO - mozversion INFO | application_name: Firefox 16:29:33 INFO - mozversion INFO | application_remotingname: firefox 16:29:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:29:33 INFO - mozversion INFO | application_vendor: Mozilla 16:29:33 INFO - mozversion INFO | application_version: 45.0a1 16:29:33 INFO - mozversion INFO | platform_buildid: 20151203154241 16:29:33 INFO - mozversion INFO | platform_changeset: d05e740814759b053ffaec0ef924e2f916833d31 16:29:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:29:33 INFO - mozversion INFO | platform_version: 45.0a1 16:29:33 INFO - 2015-12-03 16:29:33,330 DEBUG : using testdate: 1449188973 16:29:33 INFO - 2015-12-03 16:29:33,330 DEBUG : actual date: 1449188973 16:29:33 INFO - 2015-12-03 16:29:33,338 INFO : starting webserver on 'localhost:55857' 16:29:33 INFO - 2015-12-03 16:29:33,339 INFO : Starting test suite talos-linux64-ix-045.e 16:29:33 INFO - 2015-12-03 16:29:33,340 INFO : Starting test dromaeo_css 16:29:33 INFO - 2015-12-03 16:29:33,340 DEBUG : operating with platform_type : linux_ 16:29:33 INFO - 2015-12-03 16:29:33,340 INFO : Initialising browser for dromaeo_css test... 16:29:33 INFO - 2015-12-03 16:29:33,356 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAMdFJv/profile http://localhost:55857/getInfo.html 16:29:38 INFO - 2015-12-03 16:29:38,200 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:29:38 INFO - 2015-12-03 16:29:38,200 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:29:38 INFO - 2015-12-03 16:29:38,200 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:29:38 INFO - 2015-12-03 16:29:38,200 DEBUG : BROWSER_OUTPUT: __metrics 16:29:38 INFO - 2015-12-03 16:29:38,337 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:39 INFO - 2015-12-03 16:29:39,232 INFO : Browser initialized. 16:29:39 INFO - 2015-12-03 16:29:39,233 INFO : Running cycle 1/1 for dromaeo_css test... 16:29:39 INFO - 2015-12-03 16:29:39,233 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAMdFJv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:29:51 INFO - 2015-12-03 16:29:51,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 143077376 16:29:51 INFO - 2015-12-03 16:29:51,223 DEBUG : BROWSER_OUTPUT: 16:30:40 INFO - 2015-12-03 16:30:40,860 DEBUG : BROWSER_OUTPUT: 1449189040859 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:52 INFO - 2015-12-03 16:32:52,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55857/tests/dromaeo/cssquery-ext.html) 16:32:53 INFO - 2015-12-03 16:32:53,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 146804736 16:32:53 INFO - 2015-12-03 16:32:53,947 DEBUG : BROWSER_OUTPUT: 16:35:55 INFO - 2015-12-03 16:35:55,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/dromaeo/cssquery-ext.html (next: http://localhost:55857/tests/dromaeo/cssquery-jquery.html) 16:35:56 INFO - 2015-12-03 16:35:56,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 145215488 16:35:56 INFO - 2015-12-03 16:35:56,544 DEBUG : BROWSER_OUTPUT: 16:38:58 INFO - 2015-12-03 16:38:58,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55857/tests/dromaeo/cssquery-mootools.html) 16:38:58 INFO - 2015-12-03 16:38:58,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 144769024 16:38:58 INFO - 2015-12-03 16:38:58,922 DEBUG : BROWSER_OUTPUT: 16:42:00 INFO - 2015-12-03 16:42:00,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55857/tests/dromaeo/cssquery-prototype.html) 16:42:01 INFO - 2015-12-03 16:42:01,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 144146432 16:42:01 INFO - 2015-12-03 16:42:01,322 DEBUG : BROWSER_OUTPUT: 16:45:03 INFO - 2015-12-03 16:45:03,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55857/tests/dromaeo/cssquery-yui.html) 16:45:04 INFO - 2015-12-03 16:45:04,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 143912960 16:45:04 INFO - 2015-12-03 16:45:04,582 DEBUG : BROWSER_OUTPUT: 16:48:06 INFO - 2015-12-03 16:48:06,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/dromaeo/cssquery-yui.html (next: http://localhost:55857/tests/dromaeo/cssquery-dojo.html) 16:48:07 INFO - 2015-12-03 16:48:07,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 147247104 16:48:07 INFO - 2015-12-03 16:48:07,176 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,176 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:48:07 INFO - 2015-12-03 16:48:07,176 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:48:07 INFO - 2015-12-03 16:48:07,176 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:48:07 INFO - 2015-12-03 16:48:07,176 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:48:07 INFO - 2015-12-03 16:48:07,177 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2648.8145829791915;2700.0819721294756;2721.1156374178386;2737.0967580698357;2747;4532.342810292505;4724.811007559698;4731.337612734215;4748.978969521552;4785.66500344976;4610.354550362952;4657.184992626286;4678.415198100238;4751.786169622366;4752.90494190116;4291.699581029321;4319.6760242981745;4355.978220108895;4397.208502469554;4404.559544045602;4334.241507736134;4376.256036473807;4380.145871555048;4391.604755571998;4449.911001779962;4172.958270417287;4249.7237679551035;4268.445102136702;4315.482142142947;4341.6526677865695;4320.330348795942;4326.351047342892;4330;4334.631556317717;4368.148211098837;4354.390385346022;4357.259265924768;4370.7159034662645;4376.6498680105515;4432.20220360335;4419.292913133883;4519.141363140992;4538.591526762607;4641.3270075839155;4689.742064186468;5057.115004874169;5142.4600416956055;5144.511271429208;5151.665141765773;5194.740262986836;5175.327207463006;5183.663061901002;5185.844424667228;5189.299444575009;5192.247124166975;4560.680752347337;4652.720836749806;4682.227432473672;4732.077244937204;4779.0680817241;5159.871003224875;5172.637915345965;5193;5193.610479214074;5232.084385232645;4822.228443449101;4970.726610036482;4971.055499455092;4977.576905963034;4996.050750357494;4961.404631444249;4985.326980857538;5017.322661440732;5053.01466214092;5100.897982040338;5025.095482813055;5072.137736584789;5078.035173317058;5079.187330027178;5116.744162791845;4733.763311834395;4865.12427762999;5021.874453138701;5025.547700706954;5029.497050294941;4185.121124563815;4259.637930775919;4261.190373828963;4280.657547396201;4298.742075475481;3677.9816100919325;3702.7222958278235;3707.073231692077;3728.925421491555;3747.606501317377;4178.039051018222;4220.514640816284;4288.35674648799;4352.6735494837385;4360.694751367374;5095.464976177522;5111.028904508132;5125.923111153335;5126.128558145049;5129.358830146231;4389.824407023747;4399.406080179199;4401.40581021558;4403.977980110143;4444.755538445352;4322.178786030644;4420.447444069491;4452.9554704453185;4512.278035514302;4522.841700540465;4793.18515852306;4800.711957282574;4831.444383895897;4854.053459575349;4865.0756356292195;5086.0845047891735;5088.465711100429;5103.744812759422;5107.795688172431;5154.690718556899;4644.187267228289;4766.237402015661;4785.449673287477;4885;4910.803567857246;4967.304577359245;4987.451380348231;4991.07665081961;4991.800327986985;5036.244563315532;4850.102730994778;5072.4420313766195;5074;5078.568321692697;5113.846584602468;4790.520947905182;4850.05423942342;4857.368542089505;4864.92702609454;4867.5132486751045;4951.5048495150195;4953.554180123806;4954.083494553519;4961.131801934719;4963.057019166346;4816.34979277807;4849.4908034657265;4865.610751139971;4900.754962251945;4906.190478571139;4747.952520474751;4815.927761083657;4861.975690121527;4935.087008903364;4987.950120498748;4842.443119041214;4865.781039853145;4877.219644856806;4895.16782147043;4898.461169271449 16:48:07 INFO - 2015-12-03 16:48:07,177 DEBUG : BROWSER_OUTPUT: |1;ext.html;533.4398881174768;553.3746866041373;579.9507041901438;580.8673087479416;584.663818304475;36294.45558316627;37124.62875371245;37163.07092322694;37199.256014879684;37265.62734372659;39343.60656393435;39770;39820.80089599548;39871;39943.600563994354;7805.960970195141;7955.681772729084;7962.721304754335;8002.63988120533;8014.479058861155;7792.571408572526;7866.292033716964;7889.408294377916;7913.920860791405;7946.410717856423;7908.881366779503;7947;8006.199380062006;8035.116137224901;8040.437169398145;7895.447318687694;7993.760187194393;8002.359811215118;8024.358051355877;8041.035075790884;7830.099538553082;7940.285374316281;7961.920380796176;7970.242826931432;7972.362211023163;36162.8191859039;36625.26749465022;36703.79777213376;36835.26329473422;36961.44557831635;2773.4314465534517;2877.438899414615;2888.2057434205553;2930.897418590339;2972.0637999030237;27476.725232747616;27765.583516247272;27798.3050423739;27849.58225626617;28080;2900.7824413168887;2930.5311150216075;2943.0876428307292;2985.2238418011257;2987.9691506430245;210872;211010;211584;211637;212266.93866530724;49741.751291243316;51260.74369628128;52682.473175268526;54383.45616543863;55206.72396638071;54550.727246363516;54646.453535464934;54783.178252326245;55136.44863551393;55483.445165548634;13928.791068133985;14207;14294.49969251092;14295.142291462545;14306.57080287593;10772.515236814206;10903.945480272707;10907.83638245427;10945.4527273636;10985.450727463594;18580;18815.341463048728;18910.338138165098;18964.336248231244;19000.429987100408;7307.269273072757;7565.962170189114;7571.583562904093;7606.581638009962;7653.387728981668;843.2158092973593;849.3714651158222;982.4645568165367;1003.1874181912674;1031.8400647899587;24973;25680.871595642275;25975.350616234744;26004.34989125287;26351.10137884831;962.3071388600197;975.4732444480044;1002.8896821349646;1036.5646428500047;1040.6149724601946;13925.860741392456;14138.293085345691;14517.604595241666;14562;14599.197044162673;263167;267522;268053;268640;269565;44975.32537011948;45004.77497612491;45162.77418612886;45233.547664522936;45416.772916135866;1206.113506572686;1207.6739280394245;1209.3409092044856;1210.5702475621204;1238.3622434446268;23835.880820595787;24215.75784242135;24400;25821.3544661385;25883.482330353665;36577.63422365742;36579.45130823093;36591.45112823363;36734.8163259182;36969;204843;204908;208031;208432;208776;24342.63486047675;24832.37919051966;27118.457630847668;28100;28249.717502824707;33797.32405351928;33903;33942.83028584841;34441;34741.65258347485;28625.713742862306;29212.415751685272;29287.560686590143;29291.70708292975;29701.108966731033;28900.710992889803;29033.419331612826;30460.695393045786;31884.362312754078;32019.839900800347;32338.83830580832;32352.191195219366;32510.18724531811;32634.83682581572;35902.64097358993;27959.860200698866;28007.159785206477;29418.852905736192;29627.851860740557;29854.25364365908;22981.655275170553;23299.068037278317;23352.299431017098;23455.648165277875;23489.41276468102 16:48:07 INFO - 2015-12-03 16:48:07,177 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.3096528255946;331.9701226889581;338.0635639279198;339.32982359839315;339.4162041288983;14779.187144707037;15162.848371516282;15707;15784.131872746995;16392.426265080725;9493.762655933606;9503.714888553355;9504.904950950488;11975.862293082166;15040;4498.550144985508;4516.435445569296;4622.607078398323;4635.351050852883;4637.536246375369;4502.212112880249;4535.387722657432;4560.270356742922;4562.749048802315;4568.360429539867;3358.5969683638;3458.170039190589;4512.278035514319;4557.065801510682;5107.591392688576;5214.32213812202;5240.659357141773;5260.55285300748;5261.684298942076;5282.920756188661;5000.374953130859;5050.166722490784;5074.137396642543;5158.92261616076;5160.845174644766;18369;18487.722684159748;18533;19323.806761932483;19409.4177174685;1853.6934643382701;1880.482867211514;1893.583411649435;1912.3498010676299;1941.805819418061;8998.235150012257;9107.863382049274;9119.270458363315;9147.817043659155;9170.495622740747;1735.9392421265195;1749.650069985995;1771.645670865819;1782.2603619497893;1784.4914199453224;54319.45680543184;55625.44374556243;56089;56175.43824561743;56319;9068.455892646462;9072.27421806254;9137.63449462014;9518.286128540249;9631.181349585224;11179.161562882653;11182.776344473064;11195.104391648649;11201.383923884265;11257;6855.280195579492;6929.653517324215;7044.682989265495;7073.82315442118;7108.218096009435;6919.135108111486;6944.062551555577;6993.510454268152;7017.649117544102;7122.608256545836;3694.8891533254045;3785.6782173515558;3869.4776205212497;3893.4354518594646;4170.52039015511;1751.4920673004685;1767.2842498788011;1798.856091512676;1802.1619946724836;1833.3683022110333;374.64408811628516;376.1086225645184;377.70916394376724;917.1653795046609;924.9537523123952;9589.328746987643;9706.174975127193;9708.320417570701;9736.805263894683;9738.610455581698;378.51739032732934;381.3421847313418;384.71915501683367;387.1193035843422;418.38497408809;5236.659617124875;5421.728913554307;5439.129739241782;5464.808731694451;5557.527610153183;462358;470976;473483;474264;483451;66236.66881665561;69294.3070569298;70490.64754676193;70891.64554177196;72654;1050.9369437833755;1057.3399762373153;1061.5382308695741;1075.5912753153752;1081.3403823667556;14540;14689.338979745724;14750;15131.243437828285;15136.697266054396;29717.257068572595;30061.69938300589;31485.842570787;32317.192070198435;32600.184995374355;41107;42305;42764.35853462138;42941;44031;8710.869336959824;8785.780355490908;9023.4134781239;9057.68298109563;9096.954515227382;10416.531256093645;10435.58257669715;10487.737806554896;10509.474526273809;15227.695446091238;13000.609981700563;13771.311434428439;13905.374258158205;13960.441582336593;14211;12896.29070401137;13636.250006249751;13665.931670341584;13903.582892513241;13962.092463989808;14294.785578216542;14382.28088595587;14398.712025759636;14528.636784080483;14852;8845.601947912231;8939.776505587412;9020.503872286825;9036.186743193144;9046.457212567268;9652.469114198786;13907.796569865834;14004.159750415009;14059.156450612996;14097.788533171806 16:48:07 INFO - 2015-12-03 16:48:07,178 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1499;1610.460495733929;1681.3778901806327;1688.6622675464905;1696.033261041207;7160.212376638566;7161.964190179048;7328.0473538440065;7385.4460915431355;7409.888851667222;7392.815179620512;7478.102627684685;7499.775006749793;7501.0998680158455;7511.924880751191;2140.9464763380884;2168.1544197762887;2173.739151301846;2180.8364372672036;2182.432567532437;2120.130746393979;2127.0853532980814;2138.919845478031;2142.357292812158;2150.9784902150936;2002.469345623411;2050.579631175613;2058.577991511744;2129.936101916945;2149.8605738958377;2113.355426594888;2132.7760585138494;2143.474848662072;2151.4513798981316;2159.07159921233;2129.6379615465407;2159.91360345586;2160.8919554022395;2163.5456554123652;2164.9242276520245;6918;7031.367176954048;7048.118985126859;7064;7085.681144348517;4114.547399786051;4188.497380314382;4190.874273771792;4216.936745948813;4222.113356195203;2755.641766570333;2789.986050069737;2811.0723461257735;2825.110090321542;2831.2214141111153;878.1306506558525;899.1547944931743;902.255639097747;913.3423934767023;920.5627327019679;9665.613375464973;9729.513524323755;9732.2214222862;9738.513074346254;9766.511674416322;3813.9618603813606;3902.6292502212245;3924.274009308287;3940.310445671996;3959.1092004298803;7990;8006.119326874039;8026.5986700664735;8029.959850200828;8060.395470339748;4239.47006624172;4247.065645558034;4262.680298977589;4273.615374616299;4294.914101717948;3898.2203559288255;3913.8434462621176;3914.941275880864;3915.47141135943;3922.7842468663926;3108.7668424867775;3125.9843700781353;3133.6396314423678;3161.4783560712685;3188.28263640679;937.990620093804;944.4427787605346;948.672707915768;949.4208532794989;951.46242373059;845.5687599324266;869.752120645613;876.1063715010781;876.1370050500252;915.7619019055094;6507.804765857032;6661.16735408074;6672;6672.766453174116;6694.297098804555;1036.7667274863247;1037.5071840875523;1042.9165666746642;1061.861957945462;1062.7980683670078;5089.414717307557;5098.668586541863;5099.031184075014;5108.463611320833;5126.4617215191865;8448.197421244971;8518.403711740242;8627.525486098324;8632.870506942401;8688.174623410765;8546.444481108709;8610.741677749678;8679.652813887375;8709.651613935499;8719.258862996716;6839.039974600407;6869;6922.06552115468;6925.134358205224;6944.236134025253;6540.869182616416;6576.079348891255;6597.0764093026055;6605.669716514059;6622.503312251697;7343.77968660941;7541.208173141741;7544.547327160388;7614.581198034161;7684;7620.314171724572;7695.23047695226;7725.420593455401;7757.26306000929;7835;6337.556371054166;6418.518611104279;6454.903176452263;6457.257415397289;6471.417572418505;6469.159009328757;6682.131322927989;6684.364985326386;6709.899351509829;6895.793126206222;6299.559030867978;6374.3306952771145;6439.710213040518;6592.736290548324;6659.2008958925235;5386.730663466889;6529.9878518829655;6573.80278591643;6573.901391479036;6643.734250629921;6583.736650534117;6632.403083722488;6633.1045308882685;6649.301823308483;6651.368120028589;5739.339975902824;5822.0684690449325;5858.560607954335;5887.4406931341455;5952.434518720715;6244.718987645658;6285.622862628257;6286.591371560834;6290.119383286252;6300.936990630218 16:48:07 INFO - 2015-12-03 16:48:07,182 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.9321009562753;290.23523016850595;296.62476966637206;297.287995251373;298.9745871600914;5437.809676661323;5523.530499907508;5529.640573362729;5579;5609.663420194791;5489.64317319374;5490.835274941748;5504.587155963299;5507.779688812443;5510.035743744848;4201.075763332077;4231.048014196812;4233.618974292313;4236.449261595988;4237.173751118533;4235.08945576701;4246.044639956016;4247.915041699164;4248.511421186572;4255.2978758504805;4038.959610403888;4164.500259968808;4184.727992680466;4196.160767846428;4210.663146948252;4156.667466602665;4157.605027522411;4168.103857670615;4168.458100446937;4172.123853990651;3568.4468907319147;3570.1967057411875;3575.8748443804343;3576.588692300367;3577.338192434408;5255.369355677305;5280.07598670235;5300.443453437372;5310.654807437543;5333.226682131108;4656.41794775653;4771.141194584973;4772.6420518461255;4775.5463230993;4791.2813078038225;5602.327720673505;5696.344920334173;5707.315122185323;5764.971175144139;5789.363170051291;3907.492026036597;3927.7446965947406;3930.233604447134;3933.213357328546;3940.960590394088;6032.969835150796;6113.480354169901;6116.052011938156;6126.326104128542;6127.632342059535;3914.5498267699577;4009.4186342980106;4010.5588385277597;4043.2722110020477;4048.2308361411237;4093.3246014407887;4096.549379568245;4098.344264917599;4104.117614712851;4104.179164167179;4758.286257061469;4762.857114286577;4771.570558649738;4772.188727916263;4776.2119250324;5808.738606762706;5809.88380232393;5811.88376232473;5812.215350927655;5841.561882858718;1407.774756039029;1414.1303098594497;1426.2369632246698;1459.7445447046937;1460.9561713148623;955.350361754;973.1679414100984;975.7511834482161;980.4950450517989;981.3670182732097;4951.752412379438;4953.2074868020945;4953.529414705597;4956.553910148032;4960.23116416956;5859.589828712034;5879.412058794086;5896.587238893322;5940.6435613863305;5951.732172052268;4928.285398617252;4934.7285899275885;4950.356453661073;4967.534577299705;4999.075171093359;3167.382360439738;3187.6174859017065;3215.244417561871;3228.338190670907;3262.5269335946155;5718.228039214736;5731.168980497804;5732.914006289909;5750.7987220447085;5769.336526299446;6242.032484964838;6275.090111933744;6276.905846412307;6280.497560195174;6296.748130074746;5610.663360198401;5717.199592057115;5733.77064917407;5735.569832262597;5741.282339707536;6061.818145455643;6098.573099883143;6106.053561697944;6109.358517355614;6125.234345706786;5974.61165024272;5982.820515384546;5987.491063259672;5997.250343707036;5998;5686.9715651421475;5695.686737229492;5705.343885453226;5714.685692286964;5739.339975902824;3924.4505769192906;4068.877933661995;4082.0407204307558;4104.630583247522;4133.0700592366475;5926.7925622603;6034.456898878946;6034.69826508664;6050.062240352752;6065.3934606539;5781.161731548986;5782.710864456676;5860.2967643883;5872.471477567039;5879.118132280192;5820.708964551671;5822.184894114743;5825.679587622722;5825.912611310749;5862.970685146547;5687.0616348302065;5692.373838877803;5692.743826527733;5729.3984131665575;5730.799422020209;5670.914936275876;5883.911741323969;5910.497607703393;5919;5922.55580831448;5747.971260143672;5752.6836024019085;5765.106408506688;5766.106253530542;5790.160426738184 16:48:07 INFO - 2015-12-03 16:48:07,182 DEBUG : BROWSER_OUTPUT: |5;yui.html;756.5460723565861;785.6975064600127;788.4796034617153;789.5420656019513;792.5046845721424;11579.53681852726;11881.821772673416;11961.641150765468;12003.039756819455;12040.157188996774;10858.511366988485;11575;11630.360330181837;11671.533138674464;11776.234544754585;780.6174974262613;799.7001124578284;800.65171650332;800.6997375984006;802.181774589918;778.1401551285833;778.3695206882443;785.1794874356283;787.2757063501592;788.2550989315099;823.4770920465518;831.1356189562847;831.5966756123275;832.0431503770652;833.8665813469846;820.0733171516149;821.6959724901794;825.4923222218353;825.9752207433756;828.668532586964;611.4985711716395;614.9846253843644;615.0159744408954;615.9568830181889;616.0451300484232;11712.648620541397;11814.763704725943;11829.645110646694;11842;11891.643250702493;11200.943995280053;11261.887381126166;11328.320300781897;11562.364069976147;11652.592159274385;8886.73339799807;9014.36899417041;9108.362414630978;9114.680986165453;9155.542222888895;3099.8295093769834;3173.5557022016937;3199.1842080269384;3206.567113439679;3225.2904361040532;36425.81787091074;36498.817505912564;37806.243875122345;37810.62189378126;37832.43251351232;8151.714689985822;8551.401401901807;8707.695230666895;9101.180893719596;9246.583903724348;16177.514674559781;16690.666186676197;16702.58243543897;16703.33186672544;16746.6650666986;6270.090836828635;6297.559170857996;6300.527460440485;6412.583182093149;6463.838404039937;3548.0952357148763;3551.48503467001;3591.3356029134693;3594.281143771256;3594.8562057517406;2630;2648.2584876234687;2655.137080448862;2659.7872170226337;2660.135455976815;465.8416138512854;468.05686541618667;468.6368064749846;472.5274725274725;477.2197457157503;479.08016608112507;521.6087934049463;572.3160822816777;605.5609682979805;606.7087797856965;7041.964790176119;7199;7311.89032164518;7469.477136600386;7530.5858177799655;550.229678450165;556.8301667991302;576.5531712922435;582.3535875178549;606.7148440233084;3294.92903843087;3480.8607655693995;3500.299940012008;3517.2437925846066;3564.6791788739138;48704.512954870705;48900;48943.75528122336;49193.75403122961;49276.7536162324;44276.3358549622;44720.77639611781;44886.32670509945;45137.774311128895;45657.54342456599;38264.42603360952;38505.614943850764;38944.805275972874;39002;39126.804365978554;7586.848263034819;7855.096663883498;8095.07747862154;8150.2664760171865;8366.205210504992;31186.376272474878;32347.514787277738;32658.34683306273;32715.34569308553;33036.66963330336;40289.395659064554;40492.59507405006;40736.79631601823;41057.794711026254;41068;9773.560189791619;9939.801203976025;10014.449205293779;10059.899401005896;10171.338862974178;11009.394483303495;11069.169812263952;11352.432378381212;11626;12054.216475929388;10202.489875506046;10265.640702575374;10318.226133040202;10458.320209186379;10942.945285273523;10826.729331766768;10882.891171088188;10888.67333979982;10899.618513352312;11067.667969960914;10311.639092631722;10371.27401081917;10536.473176341306;10552.155827533932;10563.049325560736;9030.954845225731;9232.95383523078;9273.350865439354;9299.67451139207;9371.625134994523;8907.55462226899;8922.643094276156;8975.640974360953;9288.170151521306;9605.423674579548 16:48:07 INFO - 2015-12-03 16:48:07,182 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:48:07 INFO - 2015-12-03 16:48:07,182 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:48:07 INFO - 2015-12-03 16:48:07,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,332 16:48:07 INFO - 2015-12-03 16:48:07,182 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190087169__endTimestamp 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4665.83 Median:4800.71 stddev:492.24 (10.3%) stddev-sans-first:467.63 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: Values: 2648.8 2700.1 2721.1 2737.1 2747.0 4532.3 4724.8 4731.3 4749.0 4785.7 4610.4 4657.2 4678.4 4751.8 4752.9 4291.7 4319.7 4356.0 4397.2 4404.6 4334.2 4376.3 4380.1 4391.6 4449.9 4173.0 4249.7 4268.4 4315.5 4341.7 4320.3 4326.4 4330.0 4334.6 4368.1 4354.4 4357.3 4370.7 4376.6 4432.2 4419.3 4519.1 4538.6 4641.3 4689.7 5057.1 5142.5 5144.5 5151.7 5194.7 5175.3 5183.7 5185.8 5189.3 5192.2 4560.7 4652.7 4682.2 4732.1 4779.1 5159.9 5172.6 5193.0 5193.6 5232.1 4822.2 4970.7 4971.1 4977.6 4996.1 4961.4 4985.3 5017.3 5053.0 5100.9 5025.1 5072.1 5078.0 5079.2 5116.7 4733.8 4865.1 5021.9 5025.5 5029.5 4185.1 4259.6 4261.2 4280.7 4298.7 3678.0 3702.7 3707.1 3728.9 3747.6 4178.0 4220.5 4288.4 4352.7 4360.7 5095.5 5111.0 5125.9 5126.1 5129.4 4389.8 4399.4 4401.4 4404.0 4444.8 4322.2 4420.4 4453.0 4512.3 4522.8 4793.2 4800.7 4831.4 4854.1 4865.1 5086.1 5088.5 5103.7 5107.8 5154.7 4644.2 4766.2 4785.4 4885.0 4910.8 4967.3 4987.5 4991.1 4991.8 5036.2 4850.1 5072.4 5074.0 5078.6 5113.8 4790.5 4850.1 4857.4 4864.9 4867.5 4951.5 4953.6 4954.1 4961.1 4963.1 4816.3 4849.5 4865.6 4900.8 4906.2 4748.0 4815.9 4862.0 4935.1 4988.0 4842.4 4865.8 4877.2 4895.2 4898.5 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38558.34 Median:16421.11 stddev:59910.88 (364.8%) stddev-sans-first:60010.92 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: Values: 533.4 553.4 580.0 580.9 584.7 36294.5 37124.6 37163.1 37199.3 37265.6 39343.6 39770.0 39820.8 39871.0 39943.6 7806.0 7955.7 7962.7 8002.6 8014.5 7792.6 7866.3 7889.4 7913.9 7946.4 7908.9 7947.0 8006.2 8035.1 8040.4 7895.4 7993.8 8002.4 8024.4 8041.0 7830.1 7940.3 7961.9 7970.2 7972.4 36162.8 36625.3 36703.8 36835.3 36961.4 2773.4 2877.4 2888.2 2930.9 2972.1 27476.7 27765.6 27798.3 27849.6 28080.0 2900.8 2930.5 2943.1 2985.2 2988.0 210872.0 211010.0 211584.0 211637.0 212266.9 49741.8 51260.7 52682.5 54383.5 55206.7 54550.7 54646.5 54783.2 55136.4 55483.4 13928.8 14207.0 14294.5 14295.1 14306.6 10772.5 10903.9 10907.8 10945.5 10985.5 18580.0 18815.3 18910.3 18964.3 19000.4 7307.3 7566.0 7571.6 7606.6 7653.4 843.2 849.4 982.5 1003.2 1031.8 24973.0 25680.9 25975.4 26004.3 26351.1 962.3 975.5 1002.9 1036.6 1040.6 13925.9 14138.3 14517.6 14562.0 14599.2 263167.0 267522.0 268053.0 268640.0 269565.0 44975.3 45004.8 45162.8 45233.5 45416.8 1206.1 1207.7 1209.3 1210.6 1238.4 23835.9 24215.8 24400.0 25821.4 25883.5 36577.6 36579.5 36591.5 36734.8 36969.0 204843.0 204908.0 208031.0 208432.0 208776.0 24342.6 24832.4 27118.5 28100.0 28249.7 33797.3 33903.0 33942.8 34441.0 34741.7 28625.7 29212.4 29287.6 29291.7 29701.1 28900.7 29033.4 30460.7 31884.4 32019.8 32338.8 32352.2 32510.2 32634.8 35902.6 27959.9 28007.2 29418.9 29627.9 29854.3 22981.7 23299.1 23352.3 23455.6 23489.4 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25310.75 Median:2294.45 stddev:77328.34 (3370.2%) stddev-sans-first:77522.52 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: Values: 330.3 332.0 338.1 339.3 339.4 14779.2 15162.8 15707.0 15784.1 16392.4 9493.8 9503.7 9504.9 11975.9 15040.0 4498.6 4516.4 4622.6 4635.4 4637.5 4502.2 4535.4 4560.3 4562.7 4568.4 3358.6 3458.2 4512.3 4557.1 5107.6 5214.3 5240.7 5260.6 5261.7 5282.9 5000.4 5050.2 5074.1 5158.9 5160.8 18369.0 18487.7 18533.0 19323.8 19409.4 1853.7 1880.5 1893.6 1912.3 1941.8 8998.2 9107.9 9119.3 9147.8 9170.5 1735.9 1749.7 1771.6 1782.3 1784.5 54319.5 55625.4 56089.0 56175.4 56319.0 9068.5 9072.3 9137.6 9518.3 9631.2 11179.2 11182.8 11195.1 11201.4 11257.0 6855.3 6929.7 7044.7 7073.8 7108.2 6919.1 6944.1 6993.5 7017.6 7122.6 3694.9 3785.7 3869.5 3893.4 4170.5 1751.5 1767.3 1798.9 1802.2 1833.4 374.6 376.1 377.7 917.2 925.0 9589.3 9706.2 9708.3 9736.8 9738.6 378.5 381.3 384.7 387.1 418.4 5236.7 5421.7 5439.1 5464.8 5557.5 462358.0 470976.0 473483.0 474264.0 483451.0 66236.7 69294.3 70490.6 70891.6 72654.0 1050.9 1057.3 1061.5 1075.6 1081.3 14540.0 14689.3 14750.0 15131.2 15136.7 29717.3 30061.7 31485.8 32317.2 32600.2 41107.0 42305.0 42764.4 42941.0 44031.0 8710.9 8785.8 9023.4 9057.7 9097.0 10416.5 10435.6 10487.7 10509.5 15227.7 13000.6 13771.3 13905.4 13960.4 14211.0 12896.3 13636.3 13665.9 13903.6 13962.1 14294.8 14382.3 14398.7 14528.6 14852.0 8845.6 8939.8 9020.5 9036.2 9046.5 9652.5 13907.8 14004.2 14059.2 14097.8 16:48:07 INFO - 2015-12-03 16:48:07,183 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,184 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5007.99 Median:6518.90 stddev:2590.09 (39.7%) stddev-sans-first:2583.93 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: Values: 1499.0 1610.5 1681.4 1688.7 1696.0 7160.2 7162.0 7328.0 7385.4 7409.9 7392.8 7478.1 7499.8 7501.1 7511.9 2140.9 2168.2 2173.7 2180.8 2182.4 2120.1 2127.1 2138.9 2142.4 2151.0 2002.5 2050.6 2058.6 2129.9 2149.9 2113.4 2132.8 2143.5 2151.5 2159.1 2129.6 2159.9 2160.9 2163.5 2164.9 6918.0 7031.4 7048.1 7064.0 7085.7 4114.5 4188.5 4190.9 4216.9 4222.1 2755.6 2790.0 2811.1 2825.1 2831.2 878.1 899.2 902.3 913.3 920.6 9665.6 9729.5 9732.2 9738.5 9766.5 3814.0 3902.6 3924.3 3940.3 3959.1 7990.0 8006.1 8026.6 8030.0 8060.4 4239.5 4247.1 4262.7 4273.6 4294.9 3898.2 3913.8 3914.9 3915.5 3922.8 3108.8 3126.0 3133.6 3161.5 3188.3 938.0 944.4 948.7 949.4 951.5 845.6 869.8 876.1 876.1 915.8 6507.8 6661.2 6672.0 6672.8 6694.3 1036.8 1037.5 1042.9 1061.9 1062.8 5089.4 5098.7 5099.0 5108.5 5126.5 8448.2 8518.4 8627.5 8632.9 8688.2 8546.4 8610.7 8679.7 8709.7 8719.3 6839.0 6869.0 6922.1 6925.1 6944.2 6540.9 6576.1 6597.1 6605.7 6622.5 7343.8 7541.2 7544.5 7614.6 7684.0 7620.3 7695.2 7725.4 7757.3 7835.0 6337.6 6418.5 6454.9 6457.3 6471.4 6469.2 6682.1 6684.4 6709.9 6895.8 6299.6 6374.3 6439.7 6592.7 6659.2 5386.7 6530.0 6573.8 6573.9 6643.7 6583.7 6632.4 6633.1 6649.3 6651.4 5739.3 5822.1 5858.6 5887.4 5952.4 6244.7 6285.6 6286.6 6290.1 6300.9 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4783.99 Median:5516.78 stddev:1443.99 (26.2%) stddev-sans-first:1408.07 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: Values: 288.9 290.2 296.6 297.3 299.0 5437.8 5523.5 5529.6 5579.0 5609.7 5489.6 5490.8 5504.6 5507.8 5510.0 4201.1 4231.0 4233.6 4236.4 4237.2 4235.1 4246.0 4247.9 4248.5 4255.3 4039.0 4164.5 4184.7 4196.2 4210.7 4156.7 4157.6 4168.1 4168.5 4172.1 3568.4 3570.2 3575.9 3576.6 3577.3 5255.4 5280.1 5300.4 5310.7 5333.2 4656.4 4771.1 4772.6 4775.5 4791.3 5602.3 5696.3 5707.3 5765.0 5789.4 3907.5 3927.7 3930.2 3933.2 3941.0 6033.0 6113.5 6116.1 6126.3 6127.6 3914.5 4009.4 4010.6 4043.3 4048.2 4093.3 4096.5 4098.3 4104.1 4104.2 4758.3 4762.9 4771.6 4772.2 4776.2 5808.7 5809.9 5811.9 5812.2 5841.6 1407.8 1414.1 1426.2 1459.7 1461.0 955.4 973.2 975.8 980.5 981.4 4951.8 4953.2 4953.5 4956.6 4960.2 5859.6 5879.4 5896.6 5940.6 5951.7 4928.3 4934.7 4950.4 4967.5 4999.1 3167.4 3187.6 3215.2 3228.3 3262.5 5718.2 5731.2 5732.9 5750.8 5769.3 6242.0 6275.1 6276.9 6280.5 6296.7 5610.7 5717.2 5733.8 5735.6 5741.3 6061.8 6098.6 6106.1 6109.4 6125.2 5974.6 5982.8 5987.5 5997.3 5998.0 5687.0 5695.7 5705.3 5714.7 5739.3 3924.5 4068.9 4082.0 4104.6 4133.1 5926.8 6034.5 6034.7 6050.1 6065.4 5781.2 5782.7 5860.3 5872.5 5879.1 5820.7 5822.2 5825.7 5825.9 5863.0 5687.1 5692.4 5692.7 5729.4 5730.8 5670.9 5883.9 5910.5 5919.0 5922.6 5748.0 5752.7 5765.1 5766.1 5790.2 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12125.68 Median:45012.05 stddev:13627.96 (30.3%) stddev-sans-first:13639.44 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: Values: 756.5 785.7 788.5 789.5 792.5 11579.5 11881.8 11961.6 12003.0 12040.2 10858.5 11575.0 11630.4 11671.5 11776.2 780.6 799.7 800.7 800.7 802.2 778.1 778.4 785.2 787.3 788.3 823.5 831.1 831.6 832.0 833.9 820.1 821.7 825.5 826.0 828.7 611.5 615.0 615.0 616.0 616.0 11712.6 11814.8 11829.6 11842.0 11891.6 11200.9 11261.9 11328.3 11562.4 11652.6 8886.7 9014.4 9108.4 9114.7 9155.5 3099.8 3173.6 3199.2 3206.6 3225.3 36425.8 36498.8 37806.2 37810.6 37832.4 8151.7 8551.4 8707.7 9101.2 9246.6 16177.5 16690.7 16702.6 16703.3 16746.7 6270.1 6297.6 6300.5 6412.6 6463.8 3548.1 3551.5 3591.3 3594.3 3594.9 2630.0 2648.3 2655.1 2659.8 2660.1 465.8 468.1 468.6 472.5 477.2 479.1 521.6 572.3 605.6 606.7 7042.0 7199.0 7311.9 7469.5 7530.6 550.2 556.8 576.6 582.4 606.7 3294.9 3480.9 3500.3 3517.2 3564.7 48704.5 48900.0 48943.8 49193.8 49276.8 44276.3 44720.8 44886.3 45137.8 45657.5 38264.4 38505.6 38944.8 39002.0 39126.8 7586.8 7855.1 8095.1 8150.3 8366.2 31186.4 32347.5 32658.3 32715.3 33036.7 40289.4 40492.6 40736.8 41057.8 41068.0 9773.6 9939.8 10014.4 10059.9 10171.3 11009.4 11069.2 11352.4 11626.0 12054.2 10202.5 10265.6 10318.2 10458.3 10942.9 10826.7 10882.9 10888.7 10899.6 11067.7 10311.6 10371.3 10536.5 10552.2 10563.0 9031.0 9233.0 9273.4 9299.7 9371.6 8907.6 8922.6 8975.6 9288.2 9605.4 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:48:07 INFO - 2015-12-03 16:48:07,185 DEBUG : BROWSER_OUTPUT: 16:48:07 INFO - 2015-12-03 16:48:07,844 INFO : Browser exited with error code: 0 16:48:07 INFO - 2015-12-03 16:48:07,861 INFO : Completed test dromaeo_css (00:18:34) 16:48:07 INFO - 2015-12-03 16:48:07,861 INFO : Starting test kraken 16:48:07 INFO - 2015-12-03 16:48:07,861 DEBUG : operating with platform_type : linux_ 16:48:07 INFO - 2015-12-03 16:48:07,861 INFO : Initialising browser for kraken test... 16:48:07 INFO - 2015-12-03 16:48:07,867 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLcsQdw/profile http://localhost:55857/getInfo.html 16:48:12 INFO - 2015-12-03 16:48:12,567 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:48:12 INFO - 2015-12-03 16:48:12,567 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:48:12 INFO - 2015-12-03 16:48:12,567 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:48:12 INFO - 2015-12-03 16:48:12,567 DEBUG : BROWSER_OUTPUT: __metrics 16:48:12 INFO - 2015-12-03 16:48:12,684 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:13 INFO - 2015-12-03 16:48:13,588 INFO : Browser initialized. 16:48:13 INFO - 2015-12-03 16:48:13,589 INFO : Running cycle 1/1 for kraken test... 16:48:13 INFO - 2015-12-03 16:48:13,589 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLcsQdw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:48:25 INFO - 2015-12-03 16:48:25,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 143073280 16:48:25 INFO - 2015-12-03 16:48:25,639 DEBUG : BROWSER_OUTPUT: 16:48:28 INFO - 2015-12-03 16:48:28,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55857/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:28 INFO - 2015-12-03 16:48:28,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 143441920 16:48:28 INFO - 2015-12-03 16:48:28,841 DEBUG : BROWSER_OUTPUT: 16:48:31 INFO - 2015-12-03 16:48:31,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55857/tests/kraken/driver.html?testName=audio-dft) 16:48:32 INFO - 2015-12-03 16:48:32,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 144687104 16:48:32 INFO - 2015-12-03 16:48:32,168 DEBUG : BROWSER_OUTPUT: 16:48:35 INFO - 2015-12-03 16:48:35,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55857/tests/kraken/driver.html?testName=audio-fft) 16:48:35 INFO - 2015-12-03 16:48:35,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 139649024 16:48:35 INFO - 2015-12-03 16:48:35,649 DEBUG : BROWSER_OUTPUT: 16:48:37 INFO - 2015-12-03 16:48:37,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55857/tests/kraken/driver.html?testName=audio-oscillator) 16:48:38 INFO - 2015-12-03 16:48:38,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 138842112 16:48:38 INFO - 2015-12-03 16:48:38,301 DEBUG : BROWSER_OUTPUT: 16:48:40 INFO - 2015-12-03 16:48:40,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:41 INFO - 2015-12-03 16:48:41,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 140455936 16:48:41 INFO - 2015-12-03 16:48:41,117 DEBUG : BROWSER_OUTPUT: 16:48:44 INFO - 2015-12-03 16:48:44,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55857/tests/kraken/driver.html?testName=imaging-darkroom) 16:48:44 INFO - 2015-12-03 16:48:44,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 141774848 16:48:44 INFO - 2015-12-03 16:48:44,774 DEBUG : BROWSER_OUTPUT: 16:48:48 INFO - 2015-12-03 16:48:48,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55857/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:48 INFO - 2015-12-03 16:48:48,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 137895936 16:48:48 INFO - 2015-12-03 16:48:48,841 DEBUG : BROWSER_OUTPUT: 16:48:51 INFO - 2015-12-03 16:48:51,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55857/tests/kraken/driver.html?testName=json-parse-financial) 16:48:52 INFO - 2015-12-03 16:48:52,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 139870208 16:48:52 INFO - 2015-12-03 16:48:52,356 DEBUG : BROWSER_OUTPUT: 16:48:54 INFO - 2015-12-03 16:48:54,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:48:54 INFO - 2015-12-03 16:48:54,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 140906496 16:48:54 INFO - 2015-12-03 16:48:54,726 DEBUG : BROWSER_OUTPUT: 16:48:56 INFO - 2015-12-03 16:48:56,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:48:57 INFO - 2015-12-03 16:48:57,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 140718080 16:48:57 INFO - 2015-12-03 16:48:57,233 DEBUG : BROWSER_OUTPUT: 16:48:59 INFO - 2015-12-03 16:48:59,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:00 INFO - 2015-12-03 16:49:00,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 140414976 16:49:00 INFO - 2015-12-03 16:49:00,041 DEBUG : BROWSER_OUTPUT: 16:49:02 INFO - 2015-12-03 16:49:02,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:03 INFO - 2015-12-03 16:49:03,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 140627968 16:49:03 INFO - 2015-12-03 16:49:03,203 DEBUG : BROWSER_OUTPUT: 16:49:05 INFO - 2015-12-03 16:49:05,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:06 INFO - 2015-12-03 16:49:06,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 140300288 16:49:06 INFO - 2015-12-03 16:49:06,386 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55857/tests/kraken/driver.html?testName=ai-astar) 16:49:08 INFO - 2015-12-03 16:49:08,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 16:49:08 INFO - 2015-12-03 16:49:08,377 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,379 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:49:08 INFO - 2015-12-03 16:49:08,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:49:08 INFO - 2015-12-03 16:49:08,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:49:08 INFO - 2015-12-03 16:49:08,379 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:49:08 INFO - 2015-12-03 16:49:08,379 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;113;115;113;124;113;113;112;113 16:49:08 INFO - 2015-12-03 16:49:08,379 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;129;158;170;144;162;163;137;166;129 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;164;159;161;167;169;161;162;163 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;74;73;138;72;79;71;79 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;133;93;94;93;133;95;95;130 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;110;110;110;110;111;109;120;111 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;147;147;147;147;147;149 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;96;95;96;95;96 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;74;72;73;73;73;74;73;74 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;72;67;68;68;68;67;68;68;69 16:49:08 INFO - 2015-12-03 16:49:08,380 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;86;86;84;85;90;86;86;99 16:49:08 INFO - 2015-12-03 16:49:08,381 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;122;120;125;128;124;129;124;123;119 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;159;150;146;149;146;146;147;149;146;136 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;72;69;69;74;69;70;69;69 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,796 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190148378__endTimestamp 16:49:08 INFO - 2015-12-03 16:49:08,382 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,385 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:49:08 INFO - 2015-12-03 16:49:08,385 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:49:08 INFO - 2015-12-03 16:49:08,385 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,385 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:4.20 (3.7%) stddev-sans-first:4.44 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 113.0 115.0 113.0 124.0 113.0 113.0 112.0 113.0 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.20 Median:160.00 stddev:15.35 (9.6%) stddev-sans-first:16.25 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: Values: 154.0 129.0 158.0 170.0 144.0 162.0 163.0 137.0 166.0 129.0 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:2.95 (1.8%) stddev-sans-first:3.12 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 159.0 161.0 167.0 169.0 161.0 162.0 163.0 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:72.50 stddev:20.51 (28.3%) stddev-sans-first:21.54 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 74.0 73.0 138.0 72.0 79.0 71.0 79.0 16:49:08 INFO - 2015-12-03 16:49:08,386 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.50 stddev:18.25 (19.3%) stddev-sans-first:18.95 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 133.0 93.0 94.0 93.0 133.0 95.0 95.0 130.0 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.30 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:3.32 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 110.0 110.0 110.0 110.0 111.0 109.0 120.0 111.0 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 149.0 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.30 Median:73.50 stddev:0.67 (0.9%) stddev-sans-first:0.71 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 74.0 72.0 73.0 73.0 73.0 74.0 73.0 74.0 16:49:08 INFO - 2015-12-03 16:49:08,387 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.50 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: Values: 67.0 72.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 69.0 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:4.65 (5.4%) stddev-sans-first:4.72 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 86.0 86.0 84.0 85.0 90.0 86.0 86.0 99.0 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:3.17 (2.6%) stddev-sans-first:3.31 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: Values: 122.0 122.0 120.0 125.0 128.0 124.0 129.0 124.0 123.0 119.0 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,388 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:148.00 stddev:5.62 (3.8%) stddev-sans-first:4.11 16:49:08 INFO - 2015-12-03 16:49:08,389 DEBUG : BROWSER_OUTPUT: Values: 159.0 150.0 146.0 149.0 146.0 146.0 147.0 149.0 146.0 136.0 16:49:08 INFO - 2015-12-03 16:49:08,389 DEBUG : BROWSER_OUTPUT: 16:49:08 INFO - 2015-12-03 16:49:08,389 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.78 (2.5%) stddev-sans-first:1.87 16:49:08 INFO - 2015-12-03 16:49:08,389 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 69.0 69.0 74.0 69.0 70.0 69.0 69.0 16:49:08 INFO - 2015-12-03 16:49:08,389 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:49:08 INFO - 2015-12-03 16:49:08,389 DEBUG : BROWSER_OUTPUT: 16:49:09 INFO - 2015-12-03 16:49:09,272 INFO : Browser exited with error code: 0 16:49:09 INFO - 2015-12-03 16:49:09,327 INFO : Completed test kraken (00:01:01) 16:49:09 INFO - 2015-12-03 16:49:09,327 INFO : Starting test v8_7 16:49:09 INFO - 2015-12-03 16:49:09,327 DEBUG : operating with platform_type : linux_ 16:49:09 INFO - 2015-12-03 16:49:09,328 INFO : Initialising browser for v8_7 test... 16:49:09 INFO - 2015-12-03 16:49:09,334 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_08B0L/profile http://localhost:55857/getInfo.html 16:49:13 INFO - 2015-12-03 16:49:13,994 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:49:13 INFO - 2015-12-03 16:49:13,994 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:49:13 INFO - 2015-12-03 16:49:13,994 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:49:13 INFO - 2015-12-03 16:49:13,994 DEBUG : BROWSER_OUTPUT: __metrics 16:49:14 INFO - 2015-12-03 16:49:14,119 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:15 INFO - 2015-12-03 16:49:15,032 INFO : Browser initialized. 16:49:15 INFO - 2015-12-03 16:49:15,033 INFO : Running cycle 1/1 for v8_7 test... 16:49:15 INFO - 2015-12-03 16:49:15,033 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_08B0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:49:27 INFO - 2015-12-03 16:49:27,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 142770176 16:49:27 INFO - 2015-12-03 16:49:27,041 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55857/tests/v8_7/run.html (next: http://localhost:55857/tests/v8_7/run.html) 16:49:48 INFO - 2015-12-03 16:49:48,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 138027008 16:49:48 INFO - 2015-12-03 16:49:48,743 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,743 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:49:48 INFO - 2015-12-03 16:49:48,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:49:48 INFO - 2015-12-03 16:49:48,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |0;Richards;166.55562958027983 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.16803670426305 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1049.3179433368311 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |5;Earley;695.1388888888889 16:49:48 INFO - 2015-12-03 16:49:48,744 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 16:49:48 INFO - 2015-12-03 16:49:48,745 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 16:49:48 INFO - 2015-12-03 16:49:48,745 DEBUG : BROWSER_OUTPUT: |8;Splay;593.8242280285035 16:49:48 INFO - 2015-12-03 16:49:48,745 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 16:49:48 INFO - 2015-12-03 16:49:48,745 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:49:48 INFO - 2015-12-03 16:49:48,745 DEBUG : BROWSER_OUTPUT: __startTimestamp1449190188736__endTimestamp 16:49:48 INFO - 2015-12-03 16:49:48,745 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,745 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: Values: 166.6 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.17 Median:191.17 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: Values: 191.2 16:49:48 INFO - 2015-12-03 16:49:48,746 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,747 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,747 DEBUG : BROWSER_OUTPUT: Values: 278.0 16:49:48 INFO - 2015-12-03 16:49:48,747 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,747 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,747 DEBUG : BROWSER_OUTPUT: Values: 5154.6 16:49:48 INFO - 2015-12-03 16:49:48,747 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,747 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1049.32 Median:1049.32 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: Values: 1049.3 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.14 Median:695.14 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: Values: 695.1 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: Values: 12280.5 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: Values: 25897.4 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.82 Median:593.82 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: Values: 593.8 16:49:48 INFO - 2015-12-03 16:49:48,748 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-12-03 16:49:48,749 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 16:49:48 INFO - 2015-12-03 16:49:48,749 DEBUG : BROWSER_OUTPUT: Values: 4826.9 16:49:48 INFO - 2015-12-03 16:49:48,749 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:49:48 INFO - 2015-12-03 16:49:48,749 DEBUG : BROWSER_OUTPUT: 16:49:49 INFO - 2015-12-03 16:49:49,708 INFO : Browser exited with error code: 0 16:49:49 INFO - 2015-12-03 16:49:49,723 INFO : Completed test v8_7 (00:00:40) 16:49:50 INFO - 2015-12-03 16:49:50,212 INFO : Completed test suite (00:20:16) 16:49:50 INFO - 2015-12-03 16:49:50,212 DEBUG : Working with test: dromaeo_css 16:49:50 INFO - 2015-12-03 16:49:50,212 DEBUG : Generating results file: dromaeo_css 16:49:50 INFO - 2015-12-03 16:49:50,213 DEBUG : Working with test: kraken 16:49:50 INFO - 2015-12-03 16:49:50,213 DEBUG : Generating results file: kraken 16:49:50 INFO - 2015-12-03 16:49:50,213 INFO : javascript benchmark 16:49:50 INFO - 2015-12-03 16:49:50,214 DEBUG : Working with test: v8_7 16:49:50 INFO - 2015-12-03 16:49:50,214 DEBUG : Generating results file: v8_7 16:49:50 INFO - 2015-12-03 16:49:50,214 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:49:50 INFO - 2015-12-03 16:49:50,267 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 16:49:50 INFO - 2015-12-03 16:49:50,268 DEBUG : process_Request line: dromaeo_css 6217.42 graph.html#tests=[[72,132,43]] 16:49:50 INFO - 2015-12-03 16:49:50,268 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:49:50 INFO - 2015-12-03 16:49:50,296 DEBUG : process_Request line: kraken 1538.00 graph.html#tests=[[232,132,43]] 16:49:50 INFO - 2015-12-03 16:49:50,297 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:49:50 INFO - 2015-12-03 16:49:50,326 DEBUG : process_Request line: v8_7 21443.24 graph.html#tests=[[230,132,43]] 16:49:50 INFO - 2015-12-03 16:49:50,328 INFO : javascript benchmark 16:49:50 INFO - 2015-12-03 16:49:50,332 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2648.8145829791915, 2700.0819721294756, 2721.1156374178386, 2737.0967580698357, 2747.0, 4532.342810292505, 4724.811007559698, 4731.337612734215, 4748.978969521552, 4785.66500344976, 4610.354550362952, 4657.184992626286, 4678.415198100238, 4751.786169622366, 4752.90494190116, 4291.699581029321, 4319.6760242981745, 4355.978220108895, 4397.208502469554, 4404.559544045602, 4334.241507736134, 4376.256036473807, 4380.145871555048, 4391.604755571998, 4449.911001779962, 4172.958270417287, 4249.7237679551035, 4268.445102136702, 4315.482142142947, 4341.6526677865695, 4320.330348795942, 4326.351047342892, 4330.0, 4334.631556317717, 4368.148211098837, 4354.390385346022, 4357.259265924768, 4370.7159034662645, 4376.6498680105515, 4432.20220360335, 4419.292913133883, 4519.141363140992, 4538.591526762607, 4641.3270075839155, 4689.742064186468, 5057.115004874169, 5142.4600416956055, 5144.511271429208, 5151.665141765773, 5194.740262986836, 5175.327207463006, 5183.663061901002, 5185.844424667228, 5189.299444575009, 5192.247124166975, 4560.680752347337, 4652.720836749806, 4682.227432473672, 4732.077244937204, 4779.0680817241, 5159.871003224875, 5172.637915345965, 5193.0, 5193.610479214074, 5232.084385232645, 4822.228443449101, 4970.726610036482, 4971.055499455092, 4977.576905963034, 4996.050750357494, 4961.404631444249, 4985.326980857538, 5017.322661440732, 5053.01466214092, 5100.897982040338, 5025.095482813055, 5072.137736584789, 5078.035173317058, 5079.187330027178, 5116.744162791845, 4733.763311834395, 4865.12427762999, 5021.874453138701, 5025.547700706954, 5029.497050294941, 4185.121124563815, 4259.637930775919, 4261.190373828963, 4280.657547396201, 4298.742075475481, 3677.9816100919325, 3702.7222958278235, 3707.073231692077, 3728.925421491555, 3747.606501317377, 4178.039051018222, 4220.514640816284, 4288.35674648799, 4352.6735494837385, 4360.694751367374, 5095.464976177522, 5111.028904508132, 5125.923111153335, 5126.128558145049, 5129.358830146231, 4389.824407023747, 4399.406080179199, 4401.40581021558, 4403.977980110143, 4444.755538445352, 4322.178786030644, 4420.447444069491, 4452.9554704453185, 4512.278035514302, 4522.841700540465, 4793.18515852306, 4800.711957282574, 4831.444383895897, 4854.053459575349, 4865.0756356292195, 5086.0845047891735, 5088.465711100429, 5103.744812759422, 5107.795688172431, 5154.690718556899, 4644.187267228289, 4766.237402015661, 4785.449673287477, 4885.0, 4910.803567857246, 4967.304577359245, 4987.451380348231, 4991.07665081961, 4991.800327986985, 5036.244563315532, 4850.102730994778, 5072.4420313766195, 5074.0, 5078.568321692697, 5113.846584602468, 4790.520947905182, 4850.05423942342, 4857.368542089505, 4864.92702609454, 4867.5132486751045, 4951.5048495150195, 4953.554180123806, 4954.083494553519, 4961.131801934719, 4963.057019166346, 4816.34979277807, 4849.4908034657265, 4865.610751139971, 4900.754962251945, 4906.190478571139, 4747.952520474751, 4815.927761083657, 4861.975690121527, 4935.087008903364, 4987.950120498748, 4842.443119041214, 4865.781039853145, 4877.219644856806, 4895.16782147043, 4898.461169271449], "unit": "ms", "name": "dojo.html", "value": 4635.077241578668}, {"lowerIsBetter": false, "replicates": [533.4398881174768, 553.3746866041373, 579.9507041901438, 580.8673087479416, 584.663818304475, 36294.45558316627, 37124.62875371245, 37163.07092322694, 37199.256014879684, 37265.62734372659, 39343.60656393435, 39770.0, 39820.80089599548, 39871.0, 39943.600563994354, 7805.960970195141, 7955.681772729084, 7962.721304754335, 8002.63988120533, 8014.479058861155, 7792.571408572526, 7866.292033716964, 7889.408294377916, 7913.920860791405, 7946.410717856423, 7908.881366779503, 7947.0, 8006.199380062006, 8035.116137224901, 8040.437169398145, 7895.447318687694, 7993.760187194393, 8002.359811215118, 8024.358051355877, 8041.035075790884, 7830.099538553082, 7940.285374316281, 7961.920380796176, 7970.242826931432, 7972.362211023163, 36162.8191859039, 36625.26749465022, 36703.79777213376, 36835.26329473422, 36961.44557831635, 2773.4314465534517, 2877.438899414615, 2888.2057434205553, 2930.897418590339, 2972.0637999030237, 27476.725232747616, 27765.583516247272, 27798.3050423739, 27849.58225626617, 28080.0, 2900.7824413168887, 2930.5311150216075, 2943.0876428307292, 2985.2238418011257, 2987.9691506430245, 210872.0, 211010.0, 211584.0, 211637.0, 212266.93866530724, 49741.751291243316, 51260.74369628128, 52682.473175268526, 54383.45616543863, 55206.72396638071, 54550.727246363516, 54646.453535464934, 54783.178252326245, 55136.44863551393, 55483.445165548634, 13928.791068133985, 14207.0, 14294.49969251092, 14295.142291462545, 14306.57080287593, 10772.515236814206, 10903.945480272707, 10907.83638245427, 10945.4527273636, 10985.450727463594, 18580.0, 18815.341463048728, 18910.338138165098, 18964.336248231244, 19000.429987100408, 7307.269273072757, 7565.962170189114, 7571.583562904093, 7606.581638009962, 7653.387728981668, 843.2158092973593, 849.3714651158222, 982.4645568165367, 1003.1874181912674, 1031.8400647899587, 24973.0, 25680.871595642275, 25975.350616234744, 26004.34989125287, 26351.10137884831, 962.3071388600197, 975.4732444480044, 1002.8896821349646, 1036.5646428500047, 1040.6149724601946, 13925.860741392456, 14138.293085345691, 14517.604595241666, 14562.0, 14599.197044162673, 263167.0, 267522.0, 268053.0, 268640.0, 269565.0, 44975.32537011948, 45004.77497612491, 45162.77418612886, 45233.547664522936, 45416.772916135866, 1206.113506572686, 1207.6739280394245, 1209.3409092044856, 1210.5702475621204, 1238.3622434446268, 23835.880820595787, 24215.75784242135, 24400.0, 25821.3544661385, 25883.482330353665, 36577.63422365742, 36579.45130823093, 36591.45112823363, 36734.8163259182, 36969.0, 204843.0, 204908.0, 208031.0, 208432.0, 208776.0, 24342.63486047675, 24832.37919051966, 27118.457630847668, 28100.0, 28249.717502824707, 33797.32405351928, 33903.0, 33942.83028584841, 34441.0, 34741.65258347485, 28625.713742862306, 29212.415751685272, 29287.560686590143, 29291.70708292975, 29701.108966731033, 28900.710992889803, 29033.419331612826, 30460.695393045786, 31884.362312754078, 32019.839900800347, 32338.83830580832, 32352.191195219366, 32510.18724531811, 32634.83682581572, 35902.64097358993, 27959.860200698866, 28007.159785206477, 29418.852905736192, 29627.851860740557, 29854.25364365908, 22981.655275170553, 23299.068037278317, 23352.299431017098, 23455.648165277875, 23489.41276468102], "unit": "ms", "name": "ext.html", "value": 16400.416115461863}, {"lowerIsBetter": false, "replicates": [330.3096528255946, 331.9701226889581, 338.0635639279198, 339.32982359839315, 339.4162041288983, 14779.187144707037, 15162.848371516282, 15707.0, 15784.131872746995, 16392.426265080725, 9493.762655933606, 9503.714888553355, 9504.904950950488, 11975.862293082166, 15040.0, 4498.550144985508, 4516.435445569296, 4622.607078398323, 4635.351050852883, 4637.536246375369, 4502.212112880249, 4535.387722657432, 4560.270356742922, 4562.749048802315, 4568.360429539867, 3358.5969683638, 3458.170039190589, 4512.278035514319, 4557.065801510682, 5107.591392688576, 5214.32213812202, 5240.659357141773, 5260.55285300748, 5261.684298942076, 5282.920756188661, 5000.374953130859, 5050.166722490784, 5074.137396642543, 5158.92261616076, 5160.845174644766, 18369.0, 18487.722684159748, 18533.0, 19323.806761932483, 19409.4177174685, 1853.6934643382701, 1880.482867211514, 1893.583411649435, 1912.3498010676299, 1941.805819418061, 8998.235150012257, 9107.863382049274, 9119.270458363315, 9147.817043659155, 9170.495622740747, 1735.9392421265195, 1749.650069985995, 1771.645670865819, 1782.2603619497893, 1784.4914199453224, 54319.45680543184, 55625.44374556243, 56089.0, 56175.43824561743, 56319.0, 9068.455892646462, 9072.27421806254, 9137.63449462014, 9518.286128540249, 9631.181349585224, 11179.161562882653, 11182.776344473064, 11195.104391648649, 11201.383923884265, 11257.0, 6855.280195579492, 6929.653517324215, 7044.682989265495, 7073.82315442118, 7108.218096009435, 6919.135108111486, 6944.062551555577, 6993.510454268152, 7017.649117544102, 7122.608256545836, 3694.8891533254045, 3785.6782173515558, 3869.4776205212497, 3893.4354518594646, 4170.52039015511, 1751.4920673004685, 1767.2842498788011, 1798.856091512676, 1802.1619946724836, 1833.3683022110333, 374.64408811628516, 376.1086225645184, 377.70916394376724, 917.1653795046609, 924.9537523123952, 9589.328746987643, 9706.174975127193, 9708.320417570701, 9736.805263894683, 9738.610455581698, 378.51739032732934, 381.3421847313418, 384.71915501683367, 387.1193035843422, 418.38497408809, 5236.659617124875, 5421.728913554307, 5439.129739241782, 5464.808731694451, 5557.527610153183, 462358.0, 470976.0, 473483.0, 474264.0, 483451.0, 66236.66881665561, 69294.3070569298, 70490.64754676193, 70891.64554177196, 72654.0, 1050.9369437833755, 1057.3399762373153, 1061.5382308695741, 1075.5912753153752, 1081.3403823667556, 14540.0, 14689.338979745724, 14750.0, 15131.243437828285, 15136.697266054396, 29717.257068572595, 30061.69938300589, 31485.842570787, 32317.192070198435, 32600.184995374355, 41107.0, 42305.0, 42764.35853462138, 42941.0, 44031.0, 8710.869336959824, 8785.780355490908, 9023.4134781239, 9057.68298109563, 9096.954515227382, 10416.531256093645, 10435.58257669715, 10487.737806554896, 10509.474526273809, 15227.695446091238, 13000.609981700563, 13771.311434428439, 13905.374258158205, 13960.441582336593, 14211.0, 12896.29070401137, 13636.250006249751, 13665.931670341584, 13903.582892513241, 13962.092463989808, 14294.785578216542, 14382.28088595587, 14398.712025759636, 14528.636784080483, 14852.0, 8845.601947912231, 8939.776505587412, 9020.503872286825, 9036.186743193144, 9046.457212567268, 9652.469114198786, 13907.796569865834, 14004.159750415009, 14059.156450612996, 14097.788533171806], "unit": "ms", "name": "jquery.html", "value": 7563.282995764271}, {"lowerIsBetter": false, "replicates": [1499.0, 1610.460495733929, 1681.3778901806327, 1688.6622675464905, 1696.033261041207, 7160.212376638566, 7161.964190179048, 7328.0473538440065, 7385.4460915431355, 7409.888851667222, 7392.815179620512, 7478.102627684685, 7499.775006749793, 7501.0998680158455, 7511.924880751191, 2140.9464763380884, 2168.1544197762887, 2173.739151301846, 2180.8364372672036, 2182.432567532437, 2120.130746393979, 2127.0853532980814, 2138.919845478031, 2142.357292812158, 2150.9784902150936, 2002.469345623411, 2050.579631175613, 2058.577991511744, 2129.936101916945, 2149.8605738958377, 2113.355426594888, 2132.7760585138494, 2143.474848662072, 2151.4513798981316, 2159.07159921233, 2129.6379615465407, 2159.91360345586, 2160.8919554022395, 2163.5456554123652, 2164.9242276520245, 6918.0, 7031.367176954048, 7048.118985126859, 7064.0, 7085.681144348517, 4114.547399786051, 4188.497380314382, 4190.874273771792, 4216.936745948813, 4222.113356195203, 2755.641766570333, 2789.986050069737, 2811.0723461257735, 2825.110090321542, 2831.2214141111153, 878.1306506558525, 899.1547944931743, 902.255639097747, 913.3423934767023, 920.5627327019679, 9665.613375464973, 9729.513524323755, 9732.2214222862, 9738.513074346254, 9766.511674416322, 3813.9618603813606, 3902.6292502212245, 3924.274009308287, 3940.310445671996, 3959.1092004298803, 7990.0, 8006.119326874039, 8026.5986700664735, 8029.959850200828, 8060.395470339748, 4239.47006624172, 4247.065645558034, 4262.680298977589, 4273.615374616299, 4294.914101717948, 3898.2203559288255, 3913.8434462621176, 3914.941275880864, 3915.47141135943, 3922.7842468663926, 3108.7668424867775, 3125.9843700781353, 3133.6396314423678, 3161.4783560712685, 3188.28263640679, 937.990620093804, 944.4427787605346, 948.672707915768, 949.4208532794989, 951.46242373059, 845.5687599324266, 869.752120645613, 876.1063715010781, 876.1370050500252, 915.7619019055094, 6507.804765857032, 6661.16735408074, 6672.0, 6672.766453174116, 6694.297098804555, 1036.7667274863247, 1037.5071840875523, 1042.9165666746642, 1061.861957945462, 1062.7980683670078, 5089.414717307557, 5098.668586541863, 5099.031184075014, 5108.463611320833, 5126.4617215191865, 8448.197421244971, 8518.403711740242, 8627.525486098324, 8632.870506942401, 8688.174623410765, 8546.444481108709, 8610.741677749678, 8679.652813887375, 8709.651613935499, 8719.258862996716, 6839.039974600407, 6869.0, 6922.06552115468, 6925.134358205224, 6944.236134025253, 6540.869182616416, 6576.079348891255, 6597.0764093026055, 6605.669716514059, 6622.503312251697, 7343.77968660941, 7541.208173141741, 7544.547327160388, 7614.581198034161, 7684.0, 7620.314171724572, 7695.23047695226, 7725.420593455401, 7757.26306000929, 7835.0, 6337.556371054166, 6418.518611104279, 6454.903176452263, 6457.257415397289, 6471.417572418505, 6469.159009328757, 6682.131322927989, 6684.364985326386, 6709.899351509829, 6895.793126206222, 6299.559030867978, 6374.3306952771145, 6439.710213040518, 6592.736290548324, 6659.2008958925235, 5386.730663466889, 6529.9878518829655, 6573.80278591643, 6573.901391479036, 6643.734250629921, 6583.736650534117, 6632.403083722488, 6633.1045308882685, 6649.301823308483, 6651.368120028589, 5739.339975902824, 5822.0684690449325, 5858.560607954335, 5887.4406931341455, 5952.434518720715, 6244.718987645658, 6285.622862628257, 6286.591371560834, 6290.119383286252, 6300.936990630218], "unit": "ms", "name": "mootools.html", "value": 4103.09562780562}, {"lowerIsBetter": false, "replicates": [288.9321009562753, 290.23523016850595, 296.62476966637206, 297.287995251373, 298.9745871600914, 5437.809676661323, 5523.530499907508, 5529.640573362729, 5579.0, 5609.663420194791, 5489.64317319374, 5490.835274941748, 5504.587155963299, 5507.779688812443, 5510.035743744848, 4201.075763332077, 4231.048014196812, 4233.618974292313, 4236.449261595988, 4237.173751118533, 4235.08945576701, 4246.044639956016, 4247.915041699164, 4248.511421186572, 4255.2978758504805, 4038.959610403888, 4164.500259968808, 4184.727992680466, 4196.160767846428, 4210.663146948252, 4156.667466602665, 4157.605027522411, 4168.103857670615, 4168.458100446937, 4172.123853990651, 3568.4468907319147, 3570.1967057411875, 3575.8748443804343, 3576.588692300367, 3577.338192434408, 5255.369355677305, 5280.07598670235, 5300.443453437372, 5310.654807437543, 5333.226682131108, 4656.41794775653, 4771.141194584973, 4772.6420518461255, 4775.5463230993, 4791.2813078038225, 5602.327720673505, 5696.344920334173, 5707.315122185323, 5764.971175144139, 5789.363170051291, 3907.492026036597, 3927.7446965947406, 3930.233604447134, 3933.213357328546, 3940.960590394088, 6032.969835150796, 6113.480354169901, 6116.052011938156, 6126.326104128542, 6127.632342059535, 3914.5498267699577, 4009.4186342980106, 4010.5588385277597, 4043.2722110020477, 4048.2308361411237, 4093.3246014407887, 4096.549379568245, 4098.344264917599, 4104.117614712851, 4104.179164167179, 4758.286257061469, 4762.857114286577, 4771.570558649738, 4772.188727916263, 4776.2119250324, 5808.738606762706, 5809.88380232393, 5811.88376232473, 5812.215350927655, 5841.561882858718, 1407.774756039029, 1414.1303098594497, 1426.2369632246698, 1459.7445447046937, 1460.9561713148623, 955.350361754, 973.1679414100984, 975.7511834482161, 980.4950450517989, 981.3670182732097, 4951.752412379438, 4953.2074868020945, 4953.529414705597, 4956.553910148032, 4960.23116416956, 5859.589828712034, 5879.412058794086, 5896.587238893322, 5940.6435613863305, 5951.732172052268, 4928.285398617252, 4934.7285899275885, 4950.356453661073, 4967.534577299705, 4999.075171093359, 3167.382360439738, 3187.6174859017065, 3215.244417561871, 3228.338190670907, 3262.5269335946155, 5718.228039214736, 5731.168980497804, 5732.914006289909, 5750.7987220447085, 5769.336526299446, 6242.032484964838, 6275.090111933744, 6276.905846412307, 6280.497560195174, 6296.748130074746, 5610.663360198401, 5717.199592057115, 5733.77064917407, 5735.569832262597, 5741.282339707536, 6061.818145455643, 6098.573099883143, 6106.053561697944, 6109.358517355614, 6125.234345706786, 5974.61165024272, 5982.820515384546, 5987.491063259672, 5997.250343707036, 5998.0, 5686.9715651421475, 5695.686737229492, 5705.343885453226, 5714.685692286964, 5739.339975902824, 3924.4505769192906, 4068.877933661995, 4082.0407204307558, 4104.630583247522, 4133.0700592366475, 5926.7925622603, 6034.456898878946, 6034.69826508664, 6050.062240352752, 6065.3934606539, 5781.161731548986, 5782.710864456676, 5860.2967643883, 5872.471477567039, 5879.118132280192, 5820.708964551671, 5822.184894114743, 5825.679587622722, 5825.912611310749, 5862.970685146547, 5687.0616348302065, 5692.373838877803, 5692.743826527733, 5729.3984131665575, 5730.799422020209, 5670.914936275876, 5883.911741323969, 5910.497607703393, 5919.0, 5922.55580831448, 5747.971260143672, 5752.6836024019085, 5765.106408506688, 5766.106253530542, 5790.160426738184], "unit": "ms", "name": "prototype.html", "value": 4311.410080256462}, {"lowerIsBetter": false, "replicates": [756.5460723565861, 785.6975064600127, 788.4796034617153, 789.5420656019513, 792.5046845721424, 11579.53681852726, 11881.821772673416, 11961.641150765468, 12003.039756819455, 12040.157188996774, 10858.511366988485, 11575.0, 11630.360330181837, 11671.533138674464, 11776.234544754585, 780.6174974262613, 799.7001124578284, 800.65171650332, 800.6997375984006, 802.181774589918, 778.1401551285833, 778.3695206882443, 785.1794874356283, 787.2757063501592, 788.2550989315099, 823.4770920465518, 831.1356189562847, 831.5966756123275, 832.0431503770652, 833.8665813469846, 820.0733171516149, 821.6959724901794, 825.4923222218353, 825.9752207433756, 828.668532586964, 611.4985711716395, 614.9846253843644, 615.0159744408954, 615.9568830181889, 616.0451300484232, 11712.648620541397, 11814.763704725943, 11829.645110646694, 11842.0, 11891.643250702493, 11200.943995280053, 11261.887381126166, 11328.320300781897, 11562.364069976147, 11652.592159274385, 8886.73339799807, 9014.36899417041, 9108.362414630978, 9114.680986165453, 9155.542222888895, 3099.8295093769834, 3173.5557022016937, 3199.1842080269384, 3206.567113439679, 3225.2904361040532, 36425.81787091074, 36498.817505912564, 37806.243875122345, 37810.62189378126, 37832.43251351232, 8151.714689985822, 8551.401401901807, 8707.695230666895, 9101.180893719596, 9246.583903724348, 16177.514674559781, 16690.666186676197, 16702.58243543897, 16703.33186672544, 16746.6650666986, 6270.090836828635, 6297.559170857996, 6300.527460440485, 6412.583182093149, 6463.838404039937, 3548.0952357148763, 3551.48503467001, 3591.3356029134693, 3594.281143771256, 3594.8562057517406, 2630.0, 2648.2584876234687, 2655.137080448862, 2659.7872170226337, 2660.135455976815, 465.8416138512854, 468.05686541618667, 468.6368064749846, 472.5274725274725, 477.2197457157503, 479.08016608112507, 521.6087934049463, 572.3160822816777, 605.5609682979805, 606.7087797856965, 7041.964790176119, 7199.0, 7311.89032164518, 7469.477136600386, 7530.5858177799655, 550.229678450165, 556.8301667991302, 576.5531712922435, 582.3535875178549, 606.7148440233084, 3294.92903843087, 3480.8607655693995, 3500.299940012008, 3517.2437925846066, 3564.6791788739138, 48704.512954870705, 48900.0, 48943.75528122336, 49193.75403122961, 49276.7536162324, 44276.3358549622, 44720.77639611781, 44886.32670509945, 45137.774311128895, 45657.54342456599, 38264.42603360952, 38505.614943850764, 38944.805275972874, 39002.0, 39126.804365978554, 7586.848263034819, 7855.096663883498, 8095.07747862154, 8150.2664760171865, 8366.205210504992, 31186.376272474878, 32347.514787277738, 32658.34683306273, 32715.34569308553, 33036.66963330336, 40289.395659064554, 40492.59507405006, 40736.79631601823, 41057.794711026254, 41068.0, 9773.560189791619, 9939.801203976025, 10014.449205293779, 10059.899401005896, 10171.338862974178, 11009.394483303495, 11069.169812263952, 11352.432378381212, 11626.0, 12054.216475929388, 10202.489875506046, 10265.640702575374, 10318.226133040202, 10458.320209186379, 10942.945285273523, 10826.729331766768, 10882.891171088188, 10888.67333979982, 10899.618513352312, 11067.667969960914, 10311.639092631722, 10371.27401081917, 10536.473176341306, 10552.155827533932, 10563.049325560736, 9030.954845225731, 9232.95383523078, 9273.350865439354, 9299.67451139207, 9371.625134994523, 8907.55462226899, 8922.643094276156, 8975.640974360953, 9288.170151521306, 9605.423674579548], "unit": "ms", "name": "yui.html", "value": 5678.936799185763}], "name": "dromaeo_css", "value": 6217.421185991408}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 113.0, 115.0, 113.0, 124.0, 113.0, 113.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 158.0, 170.0, 144.0, 162.0, 163.0, 137.0, 166.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 159.0, 161.0, 167.0, 169.0, 161.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 74.0, 73.0, 138.0, 72.0, 79.0, 71.0, 79.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 93.0, 94.0, 93.0, 133.0, 95.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 120.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 111.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 72.0, 73.0, 73.0, 73.0, 74.0, 73.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 73.3}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 86.0, 86.0, 84.0, 85.0, 90.0, 86.0, 86.0, 99.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 120.0, 125.0, 128.0, 124.0, 129.0, 124.0, 123.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [159.0, 150.0, 146.0, 149.0, 146.0, 146.0, 147.0, 149.0, 146.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 69.0, 69.0, 74.0, 69.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1538.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [191.16803670426305], "unit": "score", "name": "DeltaBlue", "value": 345.8632580000001}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1049.3179433368311], "unit": "score", "name": "RayTrace", "value": 705.2095169999998}, {"lowerIsBetter": false, "replicates": [695.1388888888889], "unit": "score", "name": "Earley", "value": 958.7479720279722}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [593.8242280285035], "unit": "score", "name": "Splay", "value": 137.23084400000005}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21443.238309969645}]} 16:49:50 INFO - RETURN: dromaeo_css: 6217.42 16:49:50 INFO - RETURN: kraken: 1538.00 16:49:50 INFO - RETURN: v8_7: 21443.24 16:49:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21443.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1538.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6217.42"}}} 16:49:50 INFO - Return code: 0 16:49:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:49:50 INFO - # TBPL SUCCESS # 16:49:50 INFO - Running post-action listener: _resource_record_post_action 16:49:50 INFO - Running post-run listener: _resource_record_post_run 16:49:51 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523411456; Read time: 16; Write time: 435936 16:49:51 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 248107008; Read time: 0; Write time: 294136 16:49:51 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275304448; Read time: 16; Write time: 141800 16:49:51 INFO - Running post-run listener: _upload_blobber_files 16:49:51 INFO - Blob upload gear active. 16:49:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:49:51 INFO - Copying logs to upload dir... 16:49:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.698871 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-03 16:49:51.437469) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:49:51.445496) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 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.010012 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.38 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:49:51.831082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:49:51.831439) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1449187729.311906-318700105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:49:51.847477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 16:49:51.847771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 16:49:51.851049) ========= ========= Total master_lag: 0.55 =========