builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1449168086.58 results: success (0) buildid: 20151203100125 builduid: 92bdcf1f5a4145ea82aded83b6f2791e revision: f416176fa1693802b5d7f5fc9b8fd737e48e736e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.585492) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.586006) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.586353) ========= 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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005698 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.608451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.608772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.624151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.624909) ========= 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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.678205) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.678886) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.679584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.680286) ========= 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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 10:41:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-03 10:41:27 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.879845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.880198) ========= 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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:26.930541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 10:41:26.930923) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f416176fa1693802b5d7f5fc9b8fd737e48e736e --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 f416176fa1693802b5d7f5fc9b8fd737e48e736e --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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 10:41:27,239 truncating revision to first 12 chars 2015-12-03 10:41:27,239 Setting DEBUG logging. 2015-12-03 10:41:27,239 attempt 1/10 2015-12-03 10:41:27,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f416176fa169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 10:41:28,572 unpacking tar archive at: fx-team-f416176fa169/testing/mozharness/ program finished with exit code 0 elapsedTime=1.604082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 10:41:28.551862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:28.552229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:28.563081) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:28.563453) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 10:41:28.563884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-03 10:41:28.564217) ========= /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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:41:28 INFO - MultiFileLogger online at 20151203 10:41:28 in /builds/slave/test 10:41:28 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 10:41:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:41:28 INFO - {'append_to_log': False, 10:41:28 INFO - 'base_work_dir': '/builds/slave/test', 10:41:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:41:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:41:28 INFO - 'branch': 'Fx-Team-Non-PGO', 10:41:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:41:28 INFO - 'config_files': ('talos/linux_config.py',), 10:41:28 INFO - 'default_actions': ('clobber', 10:41:28 INFO - 'read-buildbot-config', 10:41:28 INFO - 'download-and-extract', 10:41:28 INFO - 'populate-webroot', 10:41:28 INFO - 'create-virtualenv', 10:41:28 INFO - 'install', 10:41:28 INFO - 'run-tests'), 10:41:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:41:28 INFO - 'download_minidump_stackwalk': True, 10:41:28 INFO - 'download_symbols': 'ondemand', 10:41:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:41:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:41:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:41:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:41:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:41:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:41:28 INFO - 'installer_path': 'installer.exe', 10:41:28 INFO - 'log_level': 'info', 10:41:28 INFO - 'log_name': 'talos', 10:41:28 INFO - 'log_to_console': True, 10:41:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:41:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:41:28 INFO - 'opt_config_files': (), 10:41:28 INFO - 'pip_index': False, 10:41:28 INFO - 'sps_profile': False, 10:41:28 INFO - 'sps_profile_interval': 0, 10:41:28 INFO - 'suite': 'dromaeojs-e10s', 10:41:28 INFO - 'system_bits': '64', 10:41:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:41:28 INFO - 'title': 'talos-linux64-ix-025', 10:41:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:41:28 INFO - 'use_talos_json': True, 10:41:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:41:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:41:28 INFO - 'work_dir': 'build'} 10:41:28 INFO - ##### 10:41:28 INFO - ##### Running clobber step. 10:41:28 INFO - ##### 10:41:28 INFO - Running pre-action listener: _resource_record_pre_action 10:41:28 INFO - Running main action method: clobber 10:41:28 INFO - rmtree: /builds/slave/test/build 10:41:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:41:29 INFO - Running post-action listener: _resource_record_post_action 10:41:29 INFO - ##### 10:41:29 INFO - ##### Running read-buildbot-config step. 10:41:29 INFO - ##### 10:41:29 INFO - Running pre-action listener: _resource_record_pre_action 10:41:29 INFO - Running main action method: read_buildbot_config 10:41:29 INFO - Using buildbot properties: 10:41:29 INFO - { 10:41:29 INFO - "properties": { 10:41:29 INFO - "buildnumber": 520, 10:41:29 INFO - "product": "firefox", 10:41:29 INFO - "script_repo_revision": "production", 10:41:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:41:29 INFO - "repository": "", 10:41:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:41:29 INFO - "buildid": "20151203100125", 10:41:29 INFO - "slavename": "talos-linux64-ix-025", 10:41:29 INFO - "pgo_build": "False", 10:41:29 INFO - "basedir": "/builds/slave/test", 10:41:29 INFO - "project": "", 10:41:29 INFO - "platform": "ubuntu64_hw", 10:41:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:41:29 INFO - "slavebuilddir": "test", 10:41:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:41:29 INFO - "branch": "fx-team", 10:41:29 INFO - "repo_path": "integration/fx-team", 10:41:29 INFO - "stage_platform": "linux64", 10:41:29 INFO - "builduid": "92bdcf1f5a4145ea82aded83b6f2791e", 10:41:29 INFO - "revision": "f416176fa1693802b5d7f5fc9b8fd737e48e736e" 10:41:29 INFO - }, 10:41:29 INFO - "sourcestamp": { 10:41:29 INFO - "repository": "", 10:41:29 INFO - "hasPatch": false, 10:41:29 INFO - "project": "", 10:41:29 INFO - "branch": "fx-team-linux64-talos", 10:41:29 INFO - "changes": [ 10:41:29 INFO - { 10:41:29 INFO - "category": null, 10:41:29 INFO - "files": [ 10:41:29 INFO - { 10:41:29 INFO - "url": null, 10:41:29 INFO - "name": "https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:41:29 INFO - } 10:41:29 INFO - ], 10:41:29 INFO - "repository": "", 10:41:29 INFO - "rev": "f416176fa1693802b5d7f5fc9b8fd737e48e736e", 10:41:29 INFO - "who": "mbanner@mozilla.com", 10:41:29 INFO - "when": 1449167824, 10:41:29 INFO - "number": 6740153, 10:41:29 INFO - "comments": "Bug 1230147 - Loop is attempting to load OpenTok SDK's configs from the wrong places. r=mikedeboer", 10:41:29 INFO - "project": "", 10:41:29 INFO - "at": "Thu 03 Dec 2015 10:37:04", 10:41:29 INFO - "branch": "fx-team-linux64-talos", 10:41:29 INFO - "revlink": "", 10:41:29 INFO - "properties": [ 10:41:29 INFO - [ 10:41:29 INFO - "buildid", 10:41:29 INFO - "20151203100125", 10:41:29 INFO - "Change" 10:41:29 INFO - ], 10:41:29 INFO - [ 10:41:29 INFO - "builduid", 10:41:29 INFO - "92bdcf1f5a4145ea82aded83b6f2791e", 10:41:29 INFO - "Change" 10:41:29 INFO - ], 10:41:29 INFO - [ 10:41:29 INFO - "pgo_build", 10:41:29 INFO - "False", 10:41:29 INFO - "Change" 10:41:29 INFO - ] 10:41:29 INFO - ], 10:41:29 INFO - "revision": "f416176fa1693802b5d7f5fc9b8fd737e48e736e" 10:41:29 INFO - } 10:41:29 INFO - ], 10:41:29 INFO - "revision": "f416176fa1693802b5d7f5fc9b8fd737e48e736e" 10:41:29 INFO - } 10:41:29 INFO - } 10:41:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:41:29 INFO - Running post-action listener: _resource_record_post_action 10:41:29 INFO - ##### 10:41:29 INFO - ##### Running download-and-extract step. 10:41:29 INFO - ##### 10:41:29 INFO - Running pre-action listener: _resource_record_pre_action 10:41:29 INFO - Running main action method: download_and_extract 10:41:29 INFO - mkdir: /builds/slave/test/build/tests 10:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:29 INFO - https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:41:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/test_packages.json 10:41:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/test_packages.json 10:41:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:41:30 INFO - Downloaded 1302 bytes. 10:41:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:41:30 INFO - Using the following test package requirements: 10:41:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:41:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:41:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:30 INFO - u'jsshell-linux-x86_64.zip'], 10:41:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:41:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:41:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:41:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:41:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:41:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:41:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:41:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:41:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:41:30 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')]} 10:41:30 INFO - https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:31 INFO - Downloaded 21788775 bytes. 10:41:31 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 10:41:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:41:31 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 10:41:32 INFO - Return code: 0 10:41:32 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 10:41: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')]} 10:41:32 INFO - https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:41:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:41:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:41:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:33 INFO - Downloaded 21788775 bytes. 10:41:33 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 10:41:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:41:33 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 10:41:35 INFO - Return code: 0 10:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:35 INFO - https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:35 INFO - Downloaded 11132001 bytes. 10:41:35 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 10:41:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:41:35 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 10:41:36 INFO - Return code: 0 10:41:36 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')]} 10:41:36 INFO - https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RtVuLHnrRquz1YT8DjOsHg/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 10:41:38 INFO - Downloaded 57685620 bytes. 10:41:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:41:38 INFO - mkdir: /builds/slave/test/properties 10:41:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:41:38 INFO - Writing to file /builds/slave/test/properties/build_url 10:41:38 INFO - Contents: 10:41:38 INFO - build_url:https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:41:38 INFO - Running post-action listener: _resource_record_post_action 10:41:38 INFO - Running post-action listener: set_extra_try_arguments 10:41:38 INFO - ##### 10:41:38 INFO - ##### Running populate-webroot step. 10:41:38 INFO - ##### 10:41:38 INFO - Running pre-action listener: _resource_record_pre_action 10:41:38 INFO - Running main action method: populate_webroot 10:41:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:41:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:41:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:41:38 INFO - '../fennec_ids.txt'], 10:41:38 INFO - 'tests': ['tcheck2']}, 10:41:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:41:38 INFO - '--tppagecycles', 10:41:38 INFO - '7'], 10:41:38 INFO - 'tests': ['tsvgm']}}, 10:41:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:41:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:41:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:41:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:41:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:41:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:41:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'tests': ['damp', 'tps']}, 10:41:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['damp', 'tps']}, 10:41:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:41:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:41:38 INFO - 'other': {'tests': ['a11yr', 10:41:38 INFO - 'ts_paint', 10:41:38 INFO - 'tpaint', 10:41:38 INFO - 'sessionrestore', 10:41:38 INFO - 'sessionrestore_no_auto_restore']}, 10:41:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['a11yr', 10:41:38 INFO - 'ts_paint', 10:41:38 INFO - 'tpaint', 10:41:38 INFO - 'sessionrestore', 10:41:38 INFO - 'sessionrestore_no_auto_restore']}, 10:41:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['a11yr', 10:41:38 INFO - 'ts_paint', 10:41:38 INFO - 'tpaint', 10:41:38 INFO - 'sessionrestore', 10:41:38 INFO - 'sessionrestore_no_auto_restore']}, 10:41:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['a11yr', 10:41:38 INFO - 'ts_paint', 10:41:38 INFO - 'tpaint', 10:41:38 INFO - 'sessionrestore', 10:41:38 INFO - 'sessionrestore_no_auto_restore']}, 10:41:38 INFO - 'other_l64': {'tests': ['a11yr', 10:41:38 INFO - 'ts_paint', 10:41:38 INFO - 'tpaint', 10:41:38 INFO - 'sessionrestore', 10:41:38 INFO - 'sessionrestore_no_auto_restore']}, 10:41:38 INFO - 'other_nol64': {'tests': ['a11yr', 10:41:38 INFO - 'ts_paint', 10:41:38 INFO - 'tpaint', 10:41:38 INFO - 'sessionrestore', 10:41:38 INFO - 'sessionrestore_no_auto_restore']}, 10:41:38 INFO - 'svgr': {'tests': ['tsvgx', 10:41:38 INFO - 'tsvgr_opacity', 10:41:38 INFO - 'tart', 10:41:38 INFO - 'tscrollx', 10:41:38 INFO - 'cart']}, 10:41:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['tsvgx', 10:41:38 INFO - 'tsvgr_opacity', 10:41:38 INFO - 'tart', 10:41:38 INFO - 'tscrollx', 10:41:38 INFO - 'cart']}, 10:41:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'tests': ['tp5o']}, 10:41:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'talos_options': ['--e10s'], 10:41:38 INFO - 'tests': ['tp5o']}, 10:41:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'talos_options': ['--xperf_path', 10:41:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:41:38 INFO - 'tests': ['tp5n']}, 10:41:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:41:38 INFO - 'talos_options': ['--e10s', 10:41:38 INFO - '--xperf_path', 10:41:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:41:38 INFO - 'tests': ['tp5n']}}, 10:41:38 INFO - 'talos.zip': {'path': '', 10:41:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:41:38 INFO - Running post-action listener: _resource_record_post_action 10:41:38 INFO - ##### 10:41:38 INFO - ##### Running create-virtualenv step. 10:41:38 INFO - ##### 10:41:38 INFO - Running pre-action listener: _resource_record_pre_action 10:41:38 INFO - Running main action method: create_virtualenv 10:41:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:41:38 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 10:41:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:41:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:41:38 INFO - Using real prefix '/usr' 10:41:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:41:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:41:41 INFO - Installing pip.................done. 10:41:41 INFO - Return code: 0 10:41:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:41 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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:41 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 10:41:41 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 10:41:41 INFO - Using env: {'DISPLAY': ':0', 10:41:41 INFO - 'HOME': '/home/cltbld', 10:41:41 INFO - 'LANG': 'en_US.UTF-8', 10:41:41 INFO - 'LANGUAGE': 'en_US:en', 10:41:41 INFO - 'LOGNAME': 'cltbld', 10:41:41 INFO - 'MAIL': '/var/mail/cltbld', 10:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:41 INFO - 'MOZ_NO_REMOTE': '1', 10:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:41 INFO - 'NO_EM_RESTART': '1', 10:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:41 INFO - 'PWD': '/builds/slave/test', 10:41:41 INFO - 'SHELL': '/bin/bash', 10:41:41 INFO - 'SHLVL': '1', 10:41:41 INFO - 'TERM': 'linux', 10:41:41 INFO - 'TMOUT': '86400', 10:41:41 INFO - 'USER': 'cltbld', 10:41:41 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:41 INFO - '_': '/tools/buildbot/bin/python'} 10:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:41 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 10:41:41 INFO - Cleaning up... 10:41:41 INFO - Return code: 0 10:41:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:41 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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:41 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 10:41:41 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 10:41:41 INFO - Using env: {'DISPLAY': ':0', 10:41:41 INFO - 'HOME': '/home/cltbld', 10:41:41 INFO - 'LANG': 'en_US.UTF-8', 10:41:41 INFO - 'LANGUAGE': 'en_US:en', 10:41:41 INFO - 'LOGNAME': 'cltbld', 10:41:41 INFO - 'MAIL': '/var/mail/cltbld', 10:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:41 INFO - 'MOZ_NO_REMOTE': '1', 10:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:41 INFO - 'NO_EM_RESTART': '1', 10:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:41 INFO - 'PWD': '/builds/slave/test', 10:41:41 INFO - 'SHELL': '/bin/bash', 10:41:41 INFO - 'SHLVL': '1', 10:41:41 INFO - 'TERM': 'linux', 10:41:41 INFO - 'TMOUT': '86400', 10:41:41 INFO - 'USER': 'cltbld', 10:41:41 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:41 INFO - '_': '/tools/buildbot/bin/python'} 10:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:41 INFO - Downloading/unpacking psutil>=0.7.1 10:41:41 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 10:41:41 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 10:41:41 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 10:41:41 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 10:41:41 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 10:41:41 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 10:41:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:41:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:41:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:43 INFO - Installing collected packages: psutil 10:41:43 INFO - Running setup.py install for psutil 10:41:43 INFO - building 'psutil._psutil_linux' extension 10:41:43 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 10:41:43 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 10:41:43 INFO - building 'psutil._psutil_posix' extension 10:41:43 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 10:41:43 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 10:41:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:43 INFO - Successfully installed psutil 10:41:43 INFO - Cleaning up... 10:41:43 INFO - Return code: 0 10:41:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:41: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')]} 10:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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')]} 10:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:43 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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:43 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 10:41:43 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 10:41:43 INFO - Using env: {'DISPLAY': ':0', 10:41:43 INFO - 'HOME': '/home/cltbld', 10:41:43 INFO - 'LANG': 'en_US.UTF-8', 10:41:43 INFO - 'LANGUAGE': 'en_US:en', 10:41:43 INFO - 'LOGNAME': 'cltbld', 10:41:43 INFO - 'MAIL': '/var/mail/cltbld', 10:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:43 INFO - 'MOZ_NO_REMOTE': '1', 10:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:43 INFO - 'NO_EM_RESTART': '1', 10:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:43 INFO - 'PWD': '/builds/slave/test', 10:41:43 INFO - 'SHELL': '/bin/bash', 10:41:43 INFO - 'SHLVL': '1', 10:41:43 INFO - 'TERM': 'linux', 10:41:43 INFO - 'TMOUT': '86400', 10:41:43 INFO - 'USER': 'cltbld', 10:41:43 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:43 INFO - '_': '/tools/buildbot/bin/python'} 10:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:41:44 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 10:41:44 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 10:41:44 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 10:41:44 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 10:41:44 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 10:41:44 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 10:41:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:41:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:41:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:41:45 INFO - Installing collected packages: mozsystemmonitor 10:41:45 INFO - Running setup.py install for mozsystemmonitor 10:41:45 INFO - Successfully installed mozsystemmonitor 10:41:45 INFO - Cleaning up... 10:41:46 INFO - Return code: 0 10:41:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:41: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')]} 10:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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')]} 10:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:46 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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:46 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 10:41:46 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 10:41:46 INFO - Using env: {'DISPLAY': ':0', 10:41:46 INFO - 'HOME': '/home/cltbld', 10:41:46 INFO - 'LANG': 'en_US.UTF-8', 10:41:46 INFO - 'LANGUAGE': 'en_US:en', 10:41:46 INFO - 'LOGNAME': 'cltbld', 10:41:46 INFO - 'MAIL': '/var/mail/cltbld', 10:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:46 INFO - 'MOZ_NO_REMOTE': '1', 10:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:46 INFO - 'NO_EM_RESTART': '1', 10:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:46 INFO - 'PWD': '/builds/slave/test', 10:41:46 INFO - 'SHELL': '/bin/bash', 10:41:46 INFO - 'SHLVL': '1', 10:41:46 INFO - 'TERM': 'linux', 10:41:46 INFO - 'TMOUT': '86400', 10:41:46 INFO - 'USER': 'cltbld', 10:41:46 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:46 INFO - '_': '/tools/buildbot/bin/python'} 10:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:41:46 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 10:41:46 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 10:41:46 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 10:41:46 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 10:41:46 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 10:41:46 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 10:41:47 INFO - Downloading blobuploader-1.2.4.tar.gz 10:41:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:41:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:41:47 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 10:41:47 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 10:41:47 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 10:41:47 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 10:41:47 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 10:41:47 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 10:41:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:41:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:41:48 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 10:41:48 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 10:41:48 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 10:41:48 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 10:41:48 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 10:41:48 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 10:41:48 INFO - Downloading docopt-0.6.1.tar.gz 10:41:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:41:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:41:48 INFO - Running setup.py install for blobuploader 10:41:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:41:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:41:48 INFO - Running setup.py install for requests 10:41:49 INFO - Running setup.py install for docopt 10:41:49 INFO - Successfully installed blobuploader requests docopt 10:41:49 INFO - Cleaning up... 10:41:49 INFO - Return code: 0 10:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:49 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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:49 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 10:41:49 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 10:41:49 INFO - Using env: {'DISPLAY': ':0', 10:41:49 INFO - 'HOME': '/home/cltbld', 10:41:49 INFO - 'LANG': 'en_US.UTF-8', 10:41:49 INFO - 'LANGUAGE': 'en_US:en', 10:41:49 INFO - 'LOGNAME': 'cltbld', 10:41:49 INFO - 'MAIL': '/var/mail/cltbld', 10:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:49 INFO - 'MOZ_NO_REMOTE': '1', 10:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:49 INFO - 'NO_EM_RESTART': '1', 10:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:49 INFO - 'PWD': '/builds/slave/test', 10:41:49 INFO - 'SHELL': '/bin/bash', 10:41:49 INFO - 'SHLVL': '1', 10:41:49 INFO - 'TERM': 'linux', 10:41:49 INFO - 'TMOUT': '86400', 10:41:49 INFO - 'USER': 'cltbld', 10:41:49 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:49 INFO - '_': '/tools/buildbot/bin/python'} 10:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:41:49 INFO - Running setup.py (path:/tmp/pip-mIB2Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:41:49 INFO - Running setup.py (path:/tmp/pip-NYqX41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:41:49 INFO - Running setup.py (path:/tmp/pip-AV4OFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:41:49 INFO - Running setup.py (path:/tmp/pip-1wGyHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:41:49 INFO - Running setup.py (path:/tmp/pip-WDWuvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:41:49 INFO - Running setup.py (path:/tmp/pip-ft0dC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:41:49 INFO - Running setup.py (path:/tmp/pip-bh8JMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:41:49 INFO - Running setup.py (path:/tmp/pip-jp5cDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:41:50 INFO - Running setup.py (path:/tmp/pip-4iv4gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:41:50 INFO - Running setup.py (path:/tmp/pip-aJ1Bhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:41:50 INFO - Running setup.py (path:/tmp/pip-6cRj56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:41:50 INFO - Running setup.py (path:/tmp/pip-27lKFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:41:50 INFO - Running setup.py (path:/tmp/pip-XhTp_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:41:50 INFO - Running setup.py (path:/tmp/pip-6etDNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:50 INFO - Running setup.py (path:/tmp/pip-TBTcA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:41:50 INFO - Running setup.py (path:/tmp/pip-XWkbyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:41:50 INFO - Running setup.py (path:/tmp/pip-KRPdZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:41:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:41:50 INFO - Running setup.py install for manifestparser 10:41:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:41:50 INFO - Running setup.py install for mozcrash 10:41:50 INFO - Running setup.py install for mozdebug 10:41:50 INFO - Running setup.py install for mozdevice 10:41:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Running setup.py install for mozfile 10:41:51 INFO - Running setup.py install for mozhttpd 10:41:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Running setup.py install for mozinfo 10:41:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Running setup.py install for mozInstall 10:41:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Running setup.py install for mozleak 10:41:51 INFO - Running setup.py install for mozlog 10:41:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Running setup.py install for moznetwork 10:41:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:41:51 INFO - Running setup.py install for mozprocess 10:41:51 INFO - Running setup.py install for mozprofile 10:41:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:41:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:41:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:41:52 INFO - Running setup.py install for mozrunner 10:41:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:41:52 INFO - Running setup.py install for mozscreenshot 10:41:52 INFO - Running setup.py install for moztest 10:41:52 INFO - Running setup.py install for mozversion 10:41:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:41:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:41:52 INFO - Cleaning up... 10:41:52 INFO - Return code: 0 10:41:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41: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')]} 10:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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')]} 10:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:52 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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:52 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 10:41:52 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 10:41:52 INFO - Using env: {'DISPLAY': ':0', 10:41:52 INFO - 'HOME': '/home/cltbld', 10:41:52 INFO - 'LANG': 'en_US.UTF-8', 10:41:52 INFO - 'LANGUAGE': 'en_US:en', 10:41:52 INFO - 'LOGNAME': 'cltbld', 10:41:52 INFO - 'MAIL': '/var/mail/cltbld', 10:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:52 INFO - 'MOZ_NO_REMOTE': '1', 10:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:52 INFO - 'NO_EM_RESTART': '1', 10:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:52 INFO - 'PWD': '/builds/slave/test', 10:41:52 INFO - 'SHELL': '/bin/bash', 10:41:52 INFO - 'SHLVL': '1', 10:41:52 INFO - 'TERM': 'linux', 10:41:52 INFO - 'TMOUT': '86400', 10:41:52 INFO - 'USER': 'cltbld', 10:41:52 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:52 INFO - '_': '/tools/buildbot/bin/python'} 10:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:41:52 INFO - Running setup.py (path:/tmp/pip-87yOPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:41:52 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)) 10:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:41:52 INFO - Running setup.py (path:/tmp/pip-4JbOEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:41:52 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)) 10:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:41:52 INFO - Running setup.py (path:/tmp/pip-CsYssl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:41:52 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)) 10:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:41:52 INFO - Running setup.py (path:/tmp/pip-K0S6XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:41:52 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)) 10:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:41:52 INFO - Running setup.py (path:/tmp/pip-CJ6psE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:41:53 INFO - Running setup.py (path:/tmp/pip-SdOUB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:41:53 INFO - Running setup.py (path:/tmp/pip-GZZXgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:41:53 INFO - Running setup.py (path:/tmp/pip-KnnNWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:41:53 INFO - Running setup.py (path:/tmp/pip-cR0VVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:41:53 INFO - Running setup.py (path:/tmp/pip-kVuLl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:41:53 INFO - Running setup.py (path:/tmp/pip-51wcHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:41:53 INFO - Running setup.py (path:/tmp/pip-U0BPtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:41:53 INFO - Running setup.py (path:/tmp/pip-LKDWRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:41:53 INFO - Running setup.py (path:/tmp/pip-gOJfFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:53 INFO - Running setup.py (path:/tmp/pip-BlBIZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:41:53 INFO - Running setup.py (path:/tmp/pip-jjQ8r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:41:53 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)) 10:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:41:53 INFO - Running setup.py (path:/tmp/pip-UsKTOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:41:53 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)) 10:41:53 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)) 10:41:53 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)) 10:41:53 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)) 10:41:53 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)) 10:41:53 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)) 10:41:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:41:53 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 10:41:53 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 10:41:53 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 10:41:53 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 10:41:53 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 10:41:53 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 10:41:55 INFO - Downloading blessings-1.5.1.tar.gz 10:41:55 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 10:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:41:55 INFO - Installing collected packages: blessings 10:41:55 INFO - Running setup.py install for blessings 10:41:55 INFO - Successfully installed blessings 10:41:55 INFO - Cleaning up... 10:41:55 INFO - Return code: 0 10:41:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:41:56 INFO - Reading from file tmpfile_stdout 10:41:56 INFO - Current package versions: 10:41:56 INFO - argparse == 1.2.1 10:41:56 INFO - blessings == 1.5.1 10:41:56 INFO - blobuploader == 1.2.4 10:41:56 INFO - docopt == 0.6.1 10:41:56 INFO - manifestparser == 1.1 10:41:56 INFO - mozInstall == 1.12 10:41:56 INFO - mozcrash == 0.16 10:41:56 INFO - mozdebug == 0.1 10:41:56 INFO - mozdevice == 0.47 10:41:56 INFO - mozfile == 1.2 10:41:56 INFO - mozhttpd == 0.7 10:41:56 INFO - mozinfo == 0.9 10:41:56 INFO - mozleak == 0.1 10:41:56 INFO - mozlog == 3.1 10:41:56 INFO - moznetwork == 0.27 10:41:56 INFO - mozprocess == 0.22 10:41:56 INFO - mozprofile == 0.27 10:41:56 INFO - mozrunner == 6.11 10:41:56 INFO - mozscreenshot == 0.1 10:41:56 INFO - mozsystemmonitor == 0.0 10:41:56 INFO - moztest == 0.7 10:41:56 INFO - mozversion == 1.4 10:41:56 INFO - psutil == 3.1.1 10:41:56 INFO - requests == 1.2.3 10:41:56 INFO - wsgiref == 0.1.2 10:41:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41: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')]} 10:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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')]} 10:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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', '-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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:56 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 10:41:56 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 10:41:56 INFO - Using env: {'DISPLAY': ':0', 10:41:56 INFO - 'HOME': '/home/cltbld', 10:41:56 INFO - 'LANG': 'en_US.UTF-8', 10:41:56 INFO - 'LANGUAGE': 'en_US:en', 10:41:56 INFO - 'LOGNAME': 'cltbld', 10:41:56 INFO - 'MAIL': '/var/mail/cltbld', 10:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:56 INFO - 'MOZ_NO_REMOTE': '1', 10:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:56 INFO - 'NO_EM_RESTART': '1', 10:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:56 INFO - 'PWD': '/builds/slave/test', 10:41:56 INFO - 'SHELL': '/bin/bash', 10:41:56 INFO - 'SHLVL': '1', 10:41:56 INFO - 'TERM': 'linux', 10:41:56 INFO - 'TMOUT': '86400', 10:41:56 INFO - 'USER': 'cltbld', 10:41:56 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:56 INFO - '_': '/tools/buildbot/bin/python'} 10:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 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)) 10:41:56 INFO - Cleaning up... 10:41:56 INFO - Return code: 0 10:41:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:41: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')]} 10:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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')]} 10:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41: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', 'jsonschema'] in /builds/slave/test/build 10:41: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 jsonschema 10:41:56 INFO - Using env: {'DISPLAY': ':0', 10:41:56 INFO - 'HOME': '/home/cltbld', 10:41:56 INFO - 'LANG': 'en_US.UTF-8', 10:41:56 INFO - 'LANGUAGE': 'en_US:en', 10:41:56 INFO - 'LOGNAME': 'cltbld', 10:41:56 INFO - 'MAIL': '/var/mail/cltbld', 10:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:56 INFO - 'MOZ_NO_REMOTE': '1', 10:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:56 INFO - 'NO_EM_RESTART': '1', 10:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:56 INFO - 'PWD': '/builds/slave/test', 10:41:56 INFO - 'SHELL': '/bin/bash', 10:41:56 INFO - 'SHLVL': '1', 10:41:56 INFO - 'TERM': 'linux', 10:41:56 INFO - 'TMOUT': '86400', 10:41:56 INFO - 'USER': 'cltbld', 10:41:56 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:56 INFO - '_': '/tools/buildbot/bin/python'} 10:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:56 INFO - Downloading/unpacking jsonschema 10:41:56 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 10:41:56 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 10:41:56 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 10:41:56 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 10:41:56 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 10:41:56 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 10:41:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:41:58 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 10:41:58 INFO - Downloading/unpacking functools32 (from jsonschema) 10:41:58 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 10:41:58 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 10:41:58 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 10:41:58 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 10:41:58 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 10:41:58 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 10:41:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:41:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:41:58 INFO - warning: no files found matching '*.txt' 10:41:58 INFO - no previously-included directories found matching 'build' 10:41:58 INFO - no previously-included directories found matching 'dist' 10:41:58 INFO - no previously-included directories found matching '.git*' 10:41:58 INFO - Installing collected packages: jsonschema, functools32 10:41:58 INFO - Running setup.py install for functools32 10:41:58 INFO - warning: no files found matching '*.txt' 10:41:58 INFO - no previously-included directories found matching 'build' 10:41:58 INFO - no previously-included directories found matching 'dist' 10:41:58 INFO - no previously-included directories found matching '.git*' 10:41:58 INFO - Successfully installed jsonschema functools32 10:41:58 INFO - Cleaning up... 10:41:58 INFO - Return code: 0 10:41:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:41:58 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')]} 10:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:58 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')]} 10:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:58 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 0x7f23889f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, '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': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', '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 10:41:58 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 10:41:58 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 10:41:58 INFO - Using env: {'DISPLAY': ':0', 10:41:58 INFO - 'HOME': '/home/cltbld', 10:41:58 INFO - 'LANG': 'en_US.UTF-8', 10:41:58 INFO - 'LANGUAGE': 'en_US:en', 10:41:58 INFO - 'LOGNAME': 'cltbld', 10:41:58 INFO - 'MAIL': '/var/mail/cltbld', 10:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:58 INFO - 'MOZ_NO_REMOTE': '1', 10:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:58 INFO - 'NO_EM_RESTART': '1', 10:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:58 INFO - 'PWD': '/builds/slave/test', 10:41:58 INFO - 'SHELL': '/bin/bash', 10:41:58 INFO - 'SHLVL': '1', 10:41:58 INFO - 'TERM': 'linux', 10:41:58 INFO - 'TMOUT': '86400', 10:41:58 INFO - 'USER': 'cltbld', 10:41:58 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:58 INFO - '_': '/tools/buildbot/bin/python'} 10:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:58 INFO - Downloading/unpacking flake8 10:41:58 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 10:41:58 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 10:41:58 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 10:41:58 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 10:41:58 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 10:41:58 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 10:42:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:42:00 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 10:42:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:42:00 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 10:42:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:00 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 10:42:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:42:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:42:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:01 INFO - no previously-included directories found matching 'docs/_build' 10:42:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:42:01 INFO - Running setup.py install for pep8 10:42:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:42:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:42:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:42:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:42:01 INFO - no previously-included directories found matching 'docs/_build' 10:42:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:42:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:42:01 INFO - Cleaning up... 10:42:01 INFO - Return code: 0 10:42:01 INFO - Running post-action listener: _resource_record_post_action 10:42:01 INFO - Running post-action listener: _start_resource_monitoring 10:42:01 INFO - Starting resource monitoring. 10:42:01 INFO - ##### 10:42:01 INFO - ##### Running install step. 10:42:01 INFO - ##### 10:42:01 INFO - Running pre-action listener: _resource_record_pre_action 10:42:01 INFO - Running main action method: install 10:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:42:01 INFO - Reading from file tmpfile_stdout 10:42:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:42:01 INFO - Reading from file tmpfile_stdout 10:42:01 INFO - Output received: 10:42:01 INFO - Usage: mozinstall [options] installer 10:42:01 INFO - Options: 10:42:01 INFO - -h, --help show this help message and exit 10:42:01 INFO - -d DEST, --destination=DEST 10:42:01 INFO - Directory to install application into. [default: 10:42:01 INFO - "/builds/slave/test"] 10:42:01 INFO - --app=APP Application being installed. [default: firefox] 10:42:01 INFO - mkdir: /builds/slave/test/build/application 10:42:01 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'] 10:42:01 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 10:42:16 INFO - Reading from file tmpfile_stdout 10:42:16 INFO - Output received: 10:42:16 INFO - /builds/slave/test/build/application/firefox/firefox 10:42:16 INFO - Running post-action listener: _resource_record_post_action 10:42:16 INFO - ##### 10:42:16 INFO - ##### Running run-tests step. 10:42:16 INFO - ##### 10:42:16 INFO - Running pre-action listener: _resource_record_pre_action 10:42:16 INFO - Running main action method: run_tests 10:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:42:16 INFO - Python 2.7.3 10:42:16 INFO - Return code: 0 10:42:16 INFO - grabbing minidump binary from tooltool 10:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:42:16 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 0x14fe0b0>, '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 0x14fefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ff440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:42:16 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 10:42:16 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 10:42:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:42:16 INFO - Return code: 0 10:42:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:42:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:42:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:42:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:42:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:42:17 INFO - Return code: 0 10:42:17 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/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 10:42:17 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/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 10:42:17 INFO - Using env: {'DISPLAY': ':0', 10:42:17 INFO - 'HOME': '/home/cltbld', 10:42:17 INFO - 'LANG': 'en_US.UTF-8', 10:42:17 INFO - 'LANGUAGE': 'en_US:en', 10:42:17 INFO - 'LOGNAME': 'cltbld', 10:42:17 INFO - 'MAIL': '/var/mail/cltbld', 10:42:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:42:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:42:17 INFO - 'MOZ_NO_REMOTE': '1', 10:42:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:42:17 INFO - 'NO_EM_RESTART': '1', 10:42:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:42:17 INFO - 'PWD': '/builds/slave/test', 10:42:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:42:17 INFO - 'SHELL': '/bin/bash', 10:42:17 INFO - 'SHLVL': '1', 10:42:17 INFO - 'TERM': 'linux', 10:42:17 INFO - 'TMOUT': '86400', 10:42:17 INFO - 'USER': 'cltbld', 10:42:17 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449168086.142202-1887392268', 10:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:42:17 INFO - '_': '/tools/buildbot/bin/python'} 10:42:17 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/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 10:42:17 INFO - mozversion INFO | application_buildid: 20151203100125 10:42:17 INFO - mozversion INFO | application_changeset: f416176fa1693802b5d7f5fc9b8fd737e48e736e 10:42:17 INFO - mozversion INFO | application_display_name: Nightly 10:42:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:42:17 INFO - mozversion INFO | application_name: Firefox 10:42:17 INFO - mozversion INFO | application_remotingname: firefox 10:42:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:42:17 INFO - mozversion INFO | application_vendor: Mozilla 10:42:17 INFO - mozversion INFO | application_version: 45.0a1 10:42:17 INFO - mozversion INFO | platform_buildid: 20151203100125 10:42:17 INFO - mozversion INFO | platform_changeset: f416176fa1693802b5d7f5fc9b8fd737e48e736e 10:42:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:42:17 INFO - mozversion INFO | platform_version: 45.0a1 10:42:17 INFO - 2015-12-03 10:42:17,465 DEBUG : using testdate: 1449168137 10:42:17 INFO - 2015-12-03 10:42:17,465 DEBUG : actual date: 1449168137 10:42:17 INFO - 2015-12-03 10:42:17,473 INFO : starting webserver on 'localhost:57301' 10:42:17 INFO - 2015-12-03 10:42:17,474 INFO : Starting test suite talos-linux64-ix-025.e 10:42:17 INFO - 2015-12-03 10:42:17,474 INFO : Starting test dromaeo_css 10:42:17 INFO - 2015-12-03 10:42:17,474 DEBUG : operating with platform_type : linux_ 10:42:17 INFO - 2015-12-03 10:42:17,475 INFO : Initialising browser for dromaeo_css test... 10:42:17 INFO - 2015-12-03 10:42:17,487 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYuRYj7/profile http://localhost:57301/getInfo.html 10:42:22 INFO - 2015-12-03 10:42:22,322 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:42:22 INFO - 2015-12-03 10:42:22,322 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:42:22 INFO - 2015-12-03 10:42:22,322 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:42:22 INFO - 2015-12-03 10:42:22,322 DEBUG : BROWSER_OUTPUT: __metrics 10:42:22 INFO - 2015-12-03 10:42:22,418 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] 10:42:23 INFO - 2015-12-03 10:42:23,311 INFO : Browser initialized. 10:42:23 INFO - 2015-12-03 10:42:23,311 INFO : Running cycle 1/1 for dromaeo_css test... 10:42:23 INFO - 2015-12-03 10:42:23,312 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYuRYj7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:42:35 INFO - 2015-12-03 10:42:35,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 143073280 10:42:35 INFO - 2015-12-03 10:42:35,418 DEBUG : BROWSER_OUTPUT: 10:43:25 INFO - 2015-12-03 10:43:25,033 DEBUG : BROWSER_OUTPUT: 1449168205033 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] 10:45:37 INFO - 2015-12-03 10:45:37,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57301/tests/dromaeo/cssquery-ext.html) 10:45:38 INFO - 2015-12-03 10:45:38,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 148140032 10:45:38 INFO - 2015-12-03 10:45:38,420 DEBUG : BROWSER_OUTPUT: 10:48:40 INFO - 2015-12-03 10:48:40,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/dromaeo/cssquery-ext.html (next: http://localhost:57301/tests/dromaeo/cssquery-jquery.html) 10:48:41 INFO - 2015-12-03 10:48:41,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 147079168 10:48:41 INFO - 2015-12-03 10:48:41,104 DEBUG : BROWSER_OUTPUT: 10:51:42 INFO - 2015-12-03 10:51:42,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57301/tests/dromaeo/cssquery-mootools.html) 10:51:43 INFO - 2015-12-03 10:51:43,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 144916480 10:51:43 INFO - 2015-12-03 10:51:43,490 DEBUG : BROWSER_OUTPUT: 10:54:45 INFO - 2015-12-03 10:54:45,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57301/tests/dromaeo/cssquery-prototype.html) 10:54:45 INFO - 2015-12-03 10:54:45,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 144375808 10:54:45 INFO - 2015-12-03 10:54:45,894 DEBUG : BROWSER_OUTPUT: 10:57:48 INFO - 2015-12-03 10:57:48,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57301/tests/dromaeo/cssquery-yui.html) 10:57:49 INFO - 2015-12-03 10:57:49,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 144949248 10:57:49 INFO - 2015-12-03 10:57:49,061 DEBUG : BROWSER_OUTPUT: 11:00:51 INFO - 2015-12-03 11:00:51,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/dromaeo/cssquery-yui.html (next: http://localhost:57301/tests/dromaeo/cssquery-dojo.html) 11:00:52 INFO - 2015-12-03 11:00:52,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 147636224 11:00:52 INFO - 2015-12-03 11:00:52,005 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,006 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:00:52 INFO - 2015-12-03 11:00:52,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:00:52 INFO - 2015-12-03 11:00:52,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:00:52 INFO - 2015-12-03 11:00:52,006 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:00:52 INFO - 2015-12-03 11:00:52,008 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2661.3745769744114;2719.401731619043;2748.5052690515713;2757.545005074163;2764.22601671532;4574.153781550415;4797.496262892399;4832.154372984731;4864.051509955556;4871.196252618322;4667.6732628716;4707.858764237069;4783.425988881339;4788.760561971896;4806.543378379057;4392.12157568486;4411.536788637195;4551.180787458256;4555.544445555451;4591.79336929839;4227.429297044906;4421.447319085099;4425.4910685271125;4485.887852803689;4535.387722657449;4352.064306174188;4362.760048197348;4381.9561804381865;4434.467863856358;4455.799489022969;4423.292273236267;4457.420535330419;4458.643308535309;4461.843835465743;4493.078918821634;4229.281022226229;4465.084657645208;4466.486354069259;4485.551444855521;4514.909701805946;4624.09830083134;4624.930626040612;4625.907481850378;4698.647601429906;4842.104210720992;5099.898002039976;5140.897182056338;5154.92267615986;5156.690598564098;5190.6107041972;5177.197534382177;5189.792408303663;5193.065248255312;5193.195054766517;5194.428612852583;4641.675082744176;4656.767161641905;4707.31743897133;4733.124371991193;4765.142274390609;5224.268602395668;5282.154855223146;5288.841334759886;5301.284326615934;5312.9734351328;4839.491853355417;5034.874128146826;5048.495150484996;5071.163258062452;5072.264521644414;5043.041822053798;5045.9747701261995;5077.8730531737;5120.436751957282;5164.173732202829;5080.5681517070725;5082.542571168613;5085.542301192911;5106.361704786902;5110.642255042186;4798.2802579613335;4914.975425122923;5066.695998240044;5069.03688299222;5078.492150784892;4161.167766446722;4223.155368926227;4226.915461690811;4249.787510624456;4267.701260911768;3692.7599706019023;3693.298273328059;3697.7041836653;3714.981425092911;3731.8880433587037;4139.79301034947;4248.681348898845;4324.913501729948;4352.347147927773;4362.280223763044;5115.258287548285;5138.897222055538;5142.331496905378;5144.15121504955;5170.689758614495;4368.432103826546;4373.650107991417;4417.646588272931;4431.689781715249;4452.8218871245435;4289.056407590325;4390.538993405647;4391.209582275157;4394.494633117169;4498.685092043525;4712.24604063355;4753.429588449409;4782.665213435026;4825.131476334293;4841.080194762983;5135.589152867837;5143.897122057613;5173.948260517347;5178.223266510054;5215.947840521546;4632.143053535106;4870.537298956593;4876.658633895735;4892.217245240744;4924.679895806761;4929.950700492949;4953.603711703127;5088.618353623419;5091.9490805092955;5120.795168193231;5189.76646050921;5215.55667768244;5221.477852214748;5221.582273418194;5274.7890084396195;4732;4830.565249127595;5000.224965130411;5014.774335155;5033.521815427529;4822.107910036654;4873.366462359871;4890.388701412324;4892.486288939753;4935.259711043373;4809.0862736080035;4812.831550895702;4824.252240902666;4873.439554451284;4880.951190488192;4714.5992590630185;4830.203016502238;4871.585915197248;4967.379077615298;5032.773525191302;4826.782794774173;4841.685290456109;4865.902681946271;4880.780364883518;4943 11:00:52 INFO - 2015-12-03 11:00:52,009 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.8575153986123;557.3228527339282;568.2868000659172;587.667967598307;596.1504855580796;36762.816185919066;37382.8130859346;37566;37636.43545346815;37733.43399848998;40051.799741001254;40867.18265634686;40877.182456350856;40916;40952.18095638086;7959.7612071637795;8063.153368896269;8112.43212975092;8113.350931925462;8119.634616442245;7846.764597062097;7898.842023159534;7906;7924.920750792476;7928.405369597274;7942.523448593074;7984.081830589469;7988.9600551997155;7992.080910695287;8018.719344822933;7991;8076.475029123147;8096.595170241494;8100.270975612223;8102.5543595102545;7875.094364148139;8003.639836207326;8011.078725946474;8012.078610959756;8027.357811375135;37721.62278377209;37795.811020944995;37898.052548686224;37915.241695166216;38117;2722.9591556126675;2790.9441811163865;2875.8130721503035;2905.041336359018;3435.209901722618;27856.303592410353;28343.85828070867;28562;28855.278618034507;29437.11688649344;3061.4183305171946;3083.4141513112663;3087.8919237826794;3136.560881476595;3152.684731526852;208595;211218;211570;211573;212311;50377;51719.48280517222;53690.19464708032;54380.728096359264;54575.18137227945;64014.0397894032;65503.34496655068;65833.67083164553;65848;65991;11805.114616403804;11814.05487560993;11866.406679666155;11879.168458207843;11883;9232.723018309462;9242.491662958602;9248.768780780534;9278.582463789146;9296.95351523238;19153.80846191548;19337.226510939407;19375.224991000203;19418.22327106928;19418.417447476597;6961.721531138799;7129.572225666477;7164.355208031302;7192.604406757679;7213.49505534618;874.6588830356167;880.722572389708;895.1227796759082;914.4604683236922;962.5139304651107;26328.34179145537;26384.8680756595;26385;26573.468530629278;26775.86612066927;981.2052237687496;1004.7849272302766;1007.2596641468515;1009.28340877976;1080.9405482698369;13861.376238069312;14179.361928713026;14186.85813141876;14187.14877107377;14275.42898284057;261979;266431;266498;267022;267327;45978.31032534515;46082;46131;46139.538604614194;46177;1200.699825043739;1215.8905698487179;1220.8168774683868;1223.5956345780585;1352.9458821647024;25313.240602781945;25577.232683019538;25813.3546661335;25891.482170356863;25959.48081038331;40607.39088913728;41191.588084119976;41368.586314136475;41381.1723765517;41479.170416592104;247312;247814;248357;248939;249590;28308.43383132367;28762.137135885958;28816.711832881403;28817.56773648355;29068.418631626824;32931.34137317193;33630.663693363735;34313.656863431046;34772.82613587017;34846.47730283997;32057.198570035;32285.838570806995;33129.337413252084;33303.50044749282;33424.83287583546;30862.69137308688;31693.056038119637;31755.84122079467;32668.673313267514;36205.456918146774;32494.350112997134;32961.175970600925;32962.17594560059;33040.1739956503;33250.50124248186;29354.266143345732;29994.950176744584;30069.3986120272;30620.84689576627;30850.845745771127;22794.54410911806;23414.297571072893;24590;25421.87289063543;25477 11:00:52 INFO - 2015-12-03 11:00:52,009 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.6710423784691;336.08081896014414;338.68333108543527;339.6433744568204;339.9269157131217;14813.185274809895;15145.621359466018;15846.603834904134;15917.124558149297;16373.09947952862;9239.861402078974;9468.38455500392;11896.405179741021;13337.066405351628;13343.733125337487;4489.393931819203;4598.356230127785;4599.149157405891;4601.7238965662;4793.90412191756;4951.529604687549;4953.925691114636;4955.355803745508;4974.527419895104;4977.925331120036;4697.9060418791605;4832.806687732486;4854.2718592211095;4905.705657660534;4942.703437793726;4738.336632871401;4775.880602984918;4790.233562629963;4793.9520604794025;4828.806847726087;4670.883227919329;4779.498152693986;4833.081714474239;4833.130036593412;4837.7339246341435;11333.773324533464;11770.352630605314;13924.164550127025;14005;14082.155070695791;1725.5082301544126;1802.8467580255694;1827.972580411295;1891.328578354692;1931.1792488192461;8586.699465518677;8835.55822208887;8837.293016558724;8887.066857979948;8920.553972301424;1726.8877522961093;1759.8856074355253;1787.928482860684;1798.235749806327;1807.9433896446928;45834.54165458369;46236.53763462356;47097.29354059692;47299.52700472951;47438.525614743754;10024.248181386425;10028.147607453302;10069.244806639532;10080.596776128872;10109.64616238428;12494.625161245178;12505.187162834387;12515.249085054926;12530.373481325898;12594.118411711275;7092.858142837217;7118.323759242864;7118.71525138999;7173.3185347392955;7185.928140718631;6802.387785099365;6805.557638753465;6826.829329266808;6846.520743547904;6895.896561551581;4242.215190189825;4250.893727656771;4278.4010238566625;4302.870913872589;4318.784060796947;1726.620143568413;1734.9739753903702;1771.2118107442066;1803.9188236529387;1805.8555315574722;822.6914906909909;873.3188113271658;941.0285451978095;947.303731757158;959.6785076999283;15139.924300378649;15355.462558810388;15355.846441535665;15912.124833134289;16082.919585402233;816.5345752920778;821.6343727041528;847.3221422861686;868.4268382867277;890.7639475538858;8362.16378362171;9011.594478248495;9021.819563608691;9044.547772611342;9229.53852307382;429918;438050;453200;457028;457530;69118.30881691219;69265;69269;69609;70225.29774702188;1005.7988402319565;1013.6046941692746;1066.3335415365398;1074.4305518075432;1081.167501024207;14141.43434262618;14203.28983550839;14288.857111429168;14324.713505730035;15220.391184352944;33468.49797253092;35460.46809297914;37229.255414891006;37351.43972840355;38309.808450958684;42919.57080429156;43492;44480;49023.50976490189;49404.50595493999;13441.798373024609;13780.586582402544;14167.64580885486;14474.493392731625;14489.420423183376;17630.911845441206;17708.822911770716;17820.554486137433;18084.638307234043;18304.35934742331;8354.498730076215;8650.307975362082;8689.0876457971;8847.380683352103;14754.926225369234;8801.339899507691;8954;9168.724938251864;9232.076792320715;9782.461964592016;8286.254237118446;9306;9333.160015598629;9648;9834.754131146492;13915;14144.363503642155;14556.344964476835;14582.979191456496;14637.85362146365;8751.168638979287;8915.554222288989;9007.09929007094;9027.45835249887;9127.497987610479 11:00:52 INFO - 2015-12-03 11:00:52,010 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1485.739995500787;1663.4344322930206;1682.234583264614;1708.8379901666863;1723.8965662060277;6076.574639775217;6175;6663.4336081433075;7227.024351712517;7243.4205263578915;6757.66211689416;6925.688344024518;6998.8250293742685;7092.148942126939;7095.645217739118;2041.8979051047388;2049.9897500512516;2062;2077.044559502623;2079.8856062916534;2027.6350256953742;2041.2447394464068;2052.3945436096315;2074.4502706782714;2084.6247675418417;2046.703228031942;2053.3429302623167;2072.7927207279304;2081.9167233310727;2092.403664955488;2102.1381233694187;2133.95732085359;2133.9893300533477;2137;2140.3792900058966;2058.3824852544176;2097.7063211150453;2101.810837024675;2102.2747152232455;2109.9261525846673;6700.095487109275;6760.661966901635;6762.154730658668;6799.626020568867;6809.216940051859;4089.9591004089875;4133.875983720493;4148.377743338523;4163.042500224935;4172.165566886604;2315.6873822033976;2404.410919324759;2680.7319268073234;2747.7939154563487;2763.115802943059;856.7130011446111;885.7874110213567;885.9822803543893;899.7210864631985;926.7219834049758;9458.101480359355;9724.319297649168;9729.610815567368;9731.805363892754;9800.754981125458;3880;3886.0479182600443;3912.7847968361443;3966.0679740261016;3991.201759648082;7637.847243055107;7669;7674.270944260286;7678.232176782389;7686.3082322591235;4046.1300820323772;4056.2698714231133;4056.7768772717195;4060.553339132693;4068.7965601719798;3684.2815650948346;3696.094456858087;3697;3704.2776658551325;3717.386631205821;3063.8008529445515;3075.815451072943;3088.907332779975;3116.174213833336;3118.6413562440157;910.8360495110811;913.2739472119681;923.9168474837297;924.5654542365078;925.7176561148914;865.1262225152516;910.8497097978759;1155.0759392485977;1202.687301301668;1210.6126039667397;6505.512086593524;6567.573107747981;6570.441512471398;6591.604503729792;6601.240857301375;1031.0874875734878;1041.5937784264142;1043.9321444106108;1066.6693325069252;1072.871255449351;5353.384360798558;5393.191021346829;5413.648112872651;5416.945830541644;5428.701421421781;7587.165411804697;7724.150343462215;8411;8619.396642234984;8676.826463470696;8450.366222533334;8450.492970421672;8473.152684731478;8503.574821258911;8537.274331681876;6502.447291980235;6509.869802603921;6648.933510664928;6671.166104236971;6680.732770689216;6334.398232167937;6364.840878978062;6365.649889256136;6372.107904893226;6405.807825765234;7370.226126256666;7483.214262502359;7528.887066693895;7552.093748750185;7563.205863384265;7684.423668224794;7737.690492380467;7913.841723165619;7938.920610793818;7947.046354437504;6074.969625151846;6126.816195514141;6173.629582225081;6180.412860778399;6236.064590311308;6611.404973552403;6688.331166883273;6699.732010719516;6722.394984451423;6741.494387920828;6050.485708714633;6378.808635740936;6621.271660117287;6698.631575263407;6740.224874139537;6291.96854015727;6379.362063793584;6395.296517383177;6419.935800641933;6535.248446428722;6478.060681201294;6483.740650373932;6505.31694172124;6507.577007494498;6520.347965203631;5850.561207909339;5902.321233058082;5927.4665280125;5947.970260148844;5977.641341519523;6112.694365281629;6127.417895299939;6137.202163718688;6141.263048434216;6141.692915354125 11:00:52 INFO - 2015-12-03 11:00:52,011 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.39766081871346;299.2056091078188;302.1223346179349;304.5295019195344;305.1303784214986;5487.6158668893195;5522;5537.197106419567;5552.11166213406;5702;5469.945300546993;5541.695206763627;5571.359293681217;5578.776848926048;5579;4123.876283711494;4282.443282373287;4289.442372491571;4293.313069908823;4300.720453170534;4204.97897510512;4211.8525851595205;4223.176480586287;4226.619604235618;4237.470316210473;4176.227397931377;4177.33162693969;4184.456020717303;4188.4136220929095;4202.558731333212;4182;4183.874483765492;4200.600942910419;4203.726757760766;4210.831566737327;3637.163452405935;3639.3267245559655;3639.854405823764;3643.4899114124046;3644.0889777555612;5193.896122077537;5358;5366.70483123428;5380.596455265871;5417.377001644822;4826.927596086061;4827.203511420611;4833.05755377698;4839.443464001614;4841.588464980481;5857.20927674767;5861.648301101947;5871.882562348729;5873.823785286406;5879.647221166743;3960.1485680578526;3963.6234557717257;3963.781991990468;3972.423998520227;3978.6817054635558;5961.374055724174;6052.818415447544;6127.234095738033;6130.693465326761;6130.754769809202;4042.211768705133;4042.3532234842282;4059;4064.2277967186733;4072.2873497137884;4110.712250142461;4110.856120035784;4112.773797441169;4125.278076336629;4126.401671757639;4743.335932969387;4744.976275118603;4758.6437865208245;4763.309320148628;4779.330893674888;5624.493795558419;5782.45066718661;5825.271841019872;5832.270966129234;5852.502537284294;1442.3653592419303;1465.80211671423;1466.7506523890963;1467.156385078584;1468.3172324868988;972.2465089555651;973.5764942250144;974.0503009565617;988.9912289464705;994.0606127209862;4989.451160372356;5046.419661738873;5051.924221136685;5056.64603477753;5062.038212739568;5920.319163296276;6042.335343112254;6065.3934606539;6123.173371594867;6138.631682099089;5060.924086138711;5066.695998240118;5079.288899554065;5085;5121;3236.158598764291;3274.5579346788354;3293.374258890803;3302.1744563859033;3302.9174270643425;5572.414896435897;5692.203091567184;5726.713664316851;5739.16782066598;5745.511631511368;6212.968935155295;6267.2479302484;6267.9373206267355;6284.057391391328;6285.622862628257;5668.574856885668;5684.573656975744;5700.144978253295;5715.914261286084;5746.569007324468;6029.276486821609;6050.273967123797;6074.878502430015;6097.054956481752;6122.755089796358;5762;5972.522198224045;5993.61041532299;6005.819825405245;6006.3693312201585;5684.8294551163535;5711.257536520226;5724.885502289848;5725.370209276893;5739.110437882135;4087.427760113527;4122.42286079943;4166.979165104155;4167.124903770121;4180.6446452050695;5957.49361304294;6101.389861013863;6115.847103822262;6117.296510901126;6131.294901086432;5879.118132280192;5883;5883.970580147072;5885.970570147122;5886.52907767369;5860.853478663067;5871.266091738533;5878.911816322673;5882.058870580858;5885.352611212848;5606.411326810789;5740.856478588069;5747.626404283708;5750.424957504383;5757;5914.083317085859;5915.58590898633;5925.940740592711;5927.644341339534;5941.554383421174;5734.885302294014;5750.6262092963825;5765.135229715576;5781.335146458043;5789.189513468202 11:00:52 INFO - 2015-12-03 11:00:52,012 DEBUG : BROWSER_OUTPUT: |5;yui.html;758.0486489455732;764.6176911544228;773.79494433975;780.886771418144;804.6178065418925;11884;12187.817182742267;12269.263844169356;12309;12335.814962775565;13041.543545975892;13263.668408289797;13270.601881943532;13286.468541258362;13356.265405402699;772.6600295869828;780.9609519524015;787.9369650427981;789.5578476053429;790.5019837502365;771.1132197972321;782.3858271257064;791.0507391130637;792.8216151365925;795.1055063054064;804.6017221475348;815.7715839564931;816.8570500162477;821.4537332673765;821.4906757810166;801.374927556504;806.0247101007787;810.614957895001;812.9390295727844;816.6121092481054;609.1411110334451;609.2475792396431;609.421050002495;610.5237914426755;611.4894063457019;11824.527018919232;11847.229930054606;11910.761784764256;11931.164818462712;11937.522499100025;10833.29583577065;10939.45302734868;10998.615048473264;11008.614698485515;11379.772404551946;8788.252998495136;9159.084091590854;9159.129882661136;9162.541872906395;9203.769905752342;3170.8097514148994;3181.6659250778566;3199.936001279961;3219;3330.7668463207583;42259.57740422618;42284;42559.361609575884;43095.78452107719;43502;9254;9369.765755856022;9439.952800235955;9485.288603354638;9535.666251681296;16357;16404.343826246815;16410.671786564202;16414.42549510785;16431;6183.628982261079;6354.904676429857;6388.233411990498;6393.392627700361;6478.352164783578;3321.7674762766374;3325.966740332614;3333.7833040852265;3433.3305005524185;3442.638522955104;2535.1380530619676;2549.6685430894236;2592.727763584834;2592.766651001381;2594.2347007632793;467.60720994364897;467.70300858954806;475.27520531190214;480.27478507454;481.3670023918536;456.28430174149867;470.4166833126898;489.2587729589674;499.7076710124618;553.3885057012025;6862.348076932683;7059.82350441243;7087.184973728087;7091.326323999212;7206.891896621555;444.23147954039695;474.6653609205502;506.4252073896154;515.600409682499;525.6635753118007;3613.9277214456088;3615.475756015363;3766.3408903441787;3775.811209439517;3846.9038274042814;52708.47291527112;53440.198397024076;53896.19155712667;54065.72967135218;54107;45870.77064614656;46045.76977115093;46083.30875036877;46376.5362346379;47579.52420475751;37811;42782.57217427786;42839;42955.57044429578;43376;7758.495697779626;7904.367650587824;7945.275195712941;7946.8807967881685;8076.676932922617;33206.501902471966;33399;33694;33843.4923476153;34295.31409371849;39978;42315.365269520364;42421.575784242996;43229;43312;9679.370840895319;9682.70951871445;9903.851442228517;9988.650397236062;10040.497975101069;11476.368799716096;11482;11660.88339116598;11932.105092117952;12202.450889710162;9986.300958932805;10089;10170.949145254226;10356.275060745675;10579.841302380317;9976.950115249378;10116.797664046826;10187.490625468845;10722.73193170177;10724.946375268073;8938.50838203905;9133.269338453041;10454.581816727246;10476.423796691255;10854.077403420482;8751.606177722146;8864.556772161495;9117.407368521024;9278.072192780668;9316.580753866228;8161.755147345589;8203;8654.177853103945;8668.523231222343;8782.912170878464 11:00:52 INFO - 2015-12-03 11:00:52,013 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:00:52 INFO - 2015-12-03 11:00:52,013 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:00:52 INFO - 2015-12-03 11:00:52,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,334 11:00:52 INFO - 2015-12-03 11:00:52,013 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:00:52 INFO - 2015-12-03 11:00:52,013 DEBUG : BROWSER_OUTPUT: __startTimestamp1449169252005__endTimestamp 11:00:52 INFO - 2015-12-03 11:00:52,013 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,013 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:00:52 INFO - 2015-12-03 11:00:52,014 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:00:52 INFO - 2015-12-03 11:00:52,014 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,014 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4705.39 Median:4825.13 stddev:500.06 (10.4%) stddev-sans-first:475.20 11:00:52 INFO - 2015-12-03 11:00:52,014 DEBUG : BROWSER_OUTPUT: Values: 2661.4 2719.4 2748.5 2757.5 2764.2 4574.2 4797.5 4832.2 4864.1 4871.2 4667.7 4707.9 4783.4 4788.8 4806.5 4392.1 4411.5 4551.2 4555.5 4591.8 4227.4 4421.4 4425.5 4485.9 4535.4 4352.1 4362.8 4382.0 4434.5 4455.8 4423.3 4457.4 4458.6 4461.8 4493.1 4229.3 4465.1 4466.5 4485.6 4514.9 4624.1 4624.9 4625.9 4698.6 4842.1 5099.9 5140.9 5154.9 5156.7 5190.6 5177.2 5189.8 5193.1 5193.2 5194.4 4641.7 4656.8 4707.3 4733.1 4765.1 5224.3 5282.2 5288.8 5301.3 5313.0 4839.5 5034.9 5048.5 5071.2 5072.3 5043.0 5046.0 5077.9 5120.4 5164.2 5080.6 5082.5 5085.5 5106.4 5110.6 4798.3 4915.0 5066.7 5069.0 5078.5 4161.2 4223.2 4226.9 4249.8 4267.7 3692.8 3693.3 3697.7 3715.0 3731.9 4139.8 4248.7 4324.9 4352.3 4362.3 5115.3 5138.9 5142.3 5144.2 5170.7 4368.4 4373.7 4417.6 4431.7 4452.8 4289.1 4390.5 4391.2 4394.5 4498.7 4712.2 4753.4 4782.7 4825.1 4841.1 5135.6 5143.9 5173.9 5178.2 5215.9 4632.1 4870.5 4876.7 4892.2 4924.7 4930.0 4953.6 5088.6 5091.9 5120.8 5189.8 5215.6 5221.5 5221.6 5274.8 4732.0 4830.6 5000.2 5014.8 5033.5 4822.1 4873.4 4890.4 4892.5 4935.3 4809.1 4812.8 4824.3 4873.4 4881.0 4714.6 4830.2 4871.6 4967.4 5032.8 4826.8 4841.7 4865.9 4880.8 4943.0 11:00:52 INFO - 2015-12-03 11:00:52,014 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,014 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40421.32 Median:33277.00 stddev:63338.33 (190.3%) stddev-sans-first:63445.25 11:00:52 INFO - 2015-12-03 11:00:52,014 DEBUG : BROWSER_OUTPUT: Values: 546.9 557.3 568.3 587.7 596.2 36762.8 37382.8 37566.0 37636.4 37733.4 40051.8 40867.2 40877.2 40916.0 40952.2 7959.8 8063.2 8112.4 8113.4 8119.6 7846.8 7898.8 7906.0 7924.9 7928.4 7942.5 7984.1 7989.0 7992.1 8018.7 7991.0 8076.5 8096.6 8100.3 8102.6 7875.1 8003.6 8011.1 8012.1 8027.4 37721.6 37795.8 37898.1 37915.2 38117.0 2723.0 2790.9 2875.8 2905.0 3435.2 27856.3 28343.9 28562.0 28855.3 29437.1 3061.4 3083.4 3087.9 3136.6 3152.7 208595.0 211218.0 211570.0 211573.0 212311.0 50377.0 51719.5 53690.2 54380.7 54575.2 64014.0 65503.3 65833.7 65848.0 65991.0 11805.1 11814.1 11866.4 11879.2 11883.0 9232.7 9242.5 9248.8 9278.6 9297.0 19153.8 19337.2 19375.2 19418.2 19418.4 6961.7 7129.6 7164.4 7192.6 7213.5 874.7 880.7 895.1 914.5 962.5 26328.3 26384.9 26385.0 26573.5 26775.9 981.2 1004.8 1007.3 1009.3 1080.9 13861.4 14179.4 14186.9 14187.1 14275.4 261979.0 266431.0 266498.0 267022.0 267327.0 45978.3 46082.0 46131.0 46139.5 46177.0 1200.7 1215.9 1220.8 1223.6 1352.9 25313.2 25577.2 25813.4 25891.5 25959.5 40607.4 41191.6 41368.6 41381.2 41479.2 247312.0 247814.0 248357.0 248939.0 249590.0 28308.4 28762.1 28816.7 28817.6 29068.4 32931.3 33630.7 34313.7 34772.8 34846.5 32057.2 32285.8 33129.3 33303.5 33424.8 30862.7 31693.1 31755.8 32668.7 36205.5 32494.4 32961.2 32962.2 33040.2 33250.5 29354.3 29995.0 30069.4 30620.8 30850.8 22794.5 23414.3 24590.0 25421.9 25477.0 11:00:52 INFO - 2015-12-03 11:00:52,015 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,015 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24736.51 Median:455114.00 stddev:73086.56 (16.1%) stddev-sans-first:73268.62 11:00:52 INFO - 2015-12-03 11:00:52,016 DEBUG : BROWSER_OUTPUT: Values: 335.7 336.1 338.7 339.6 339.9 14813.2 15145.6 15846.6 15917.1 16373.1 9239.9 9468.4 11896.4 13337.1 13343.7 4489.4 4598.4 4599.1 4601.7 4793.9 4951.5 4953.9 4955.4 4974.5 4977.9 4697.9 4832.8 4854.3 4905.7 4942.7 4738.3 4775.9 4790.2 4794.0 4828.8 4670.9 4779.5 4833.1 4833.1 4837.7 11333.8 11770.4 13924.2 14005.0 14082.2 1725.5 1802.8 1828.0 1891.3 1931.2 8586.7 8835.6 8837.3 8887.1 8920.6 1726.9 1759.9 1787.9 1798.2 1807.9 45834.5 46236.5 47097.3 47299.5 47438.5 10024.2 10028.1 10069.2 10080.6 10109.6 12494.6 12505.2 12515.2 12530.4 12594.1 7092.9 7118.3 7118.7 7173.3 7185.9 6802.4 6805.6 6826.8 6846.5 6895.9 4242.2 4250.9 4278.4 4302.9 4318.8 1726.6 1735.0 1771.2 1803.9 1805.9 822.7 873.3 941.0 947.3 959.7 15139.9 15355.5 15355.8 15912.1 16082.9 816.5 821.6 847.3 868.4 890.8 8362.2 9011.6 9021.8 9044.5 9229.5 429918.0 438050.0 453200.0 457028.0 457530.0 69118.3 69265.0 69269.0 69609.0 70225.3 1005.8 1013.6 1066.3 1074.4 1081.2 14141.4 14203.3 14288.9 14324.7 15220.4 33468.5 35460.5 37229.3 37351.4 38309.8 42919.6 43492.0 44480.0 49023.5 49404.5 13441.8 13780.6 14167.6 14474.5 14489.4 17630.9 17708.8 17820.6 18084.6 18304.4 8354.5 8650.3 8689.1 8847.4 14754.9 8801.3 8954.0 9168.7 9232.1 9782.5 8286.3 9306.0 9333.2 9648.0 9834.8 13915.0 14144.4 14556.3 14583.0 14637.9 8751.2 8915.6 9007.1 9027.5 9127.5 11:00:52 INFO - 2015-12-03 11:00:52,016 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,016 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4904.09 Median:6264.02 stddev:2524.56 (40.3%) stddev-sans-first:2518.57 11:00:52 INFO - 2015-12-03 11:00:52,016 DEBUG : BROWSER_OUTPUT: Values: 1485.7 1663.4 1682.2 1708.8 1723.9 6076.6 6175.0 6663.4 7227.0 7243.4 6757.7 6925.7 6998.8 7092.1 7095.6 2041.9 2050.0 2062.0 2077.0 2079.9 2027.6 2041.2 2052.4 2074.5 2084.6 2046.7 2053.3 2072.8 2081.9 2092.4 2102.1 2134.0 2134.0 2137.0 2140.4 2058.4 2097.7 2101.8 2102.3 2109.9 6700.1 6760.7 6762.2 6799.6 6809.2 4090.0 4133.9 4148.4 4163.0 4172.2 2315.7 2404.4 2680.7 2747.8 2763.1 856.7 885.8 886.0 899.7 926.7 9458.1 9724.3 9729.6 9731.8 9800.8 3880.0 3886.0 3912.8 3966.1 3991.2 7637.8 7669.0 7674.3 7678.2 7686.3 4046.1 4056.3 4056.8 4060.6 4068.8 3684.3 3696.1 3697.0 3704.3 3717.4 3063.8 3075.8 3088.9 3116.2 3118.6 910.8 913.3 923.9 924.6 925.7 865.1 910.8 1155.1 1202.7 1210.6 6505.5 6567.6 6570.4 6591.6 6601.2 1031.1 1041.6 1043.9 1066.7 1072.9 5353.4 5393.2 5413.6 5416.9 5428.7 7587.2 7724.2 8411.0 8619.4 8676.8 8450.4 8450.5 8473.2 8503.6 8537.3 6502.4 6509.9 6648.9 6671.2 6680.7 6334.4 6364.8 6365.6 6372.1 6405.8 7370.2 7483.2 7528.9 7552.1 7563.2 7684.4 7737.7 7913.8 7938.9 7947.0 6075.0 6126.8 6173.6 6180.4 6236.1 6611.4 6688.3 6699.7 6722.4 6741.5 6050.5 6378.8 6621.3 6698.6 6740.2 6292.0 6379.4 6395.3 6419.9 6535.2 6478.1 6483.7 6505.3 6507.6 6520.3 5850.6 5902.3 5927.5 5948.0 5977.6 6112.7 6127.4 6137.2 6141.3 6141.7 11:00:52 INFO - 2015-12-03 11:00:52,017 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,017 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4817.39 Median:5561.74 stddev:1444.12 (26.0%) stddev-sans-first:1407.67 11:00:52 INFO - 2015-12-03 11:00:52,018 DEBUG : BROWSER_OUTPUT: Values: 292.4 299.2 302.1 304.5 305.1 5487.6 5522.0 5537.2 5552.1 5702.0 5469.9 5541.7 5571.4 5578.8 5579.0 4123.9 4282.4 4289.4 4293.3 4300.7 4205.0 4211.9 4223.2 4226.6 4237.5 4176.2 4177.3 4184.5 4188.4 4202.6 4182.0 4183.9 4200.6 4203.7 4210.8 3637.2 3639.3 3639.9 3643.5 3644.1 5193.9 5358.0 5366.7 5380.6 5417.4 4826.9 4827.2 4833.1 4839.4 4841.6 5857.2 5861.6 5871.9 5873.8 5879.6 3960.1 3963.6 3963.8 3972.4 3978.7 5961.4 6052.8 6127.2 6130.7 6130.8 4042.2 4042.4 4059.0 4064.2 4072.3 4110.7 4110.9 4112.8 4125.3 4126.4 4743.3 4745.0 4758.6 4763.3 4779.3 5624.5 5782.5 5825.3 5832.3 5852.5 1442.4 1465.8 1466.8 1467.2 1468.3 972.2 973.6 974.1 989.0 994.1 4989.5 5046.4 5051.9 5056.6 5062.0 5920.3 6042.3 6065.4 6123.2 6138.6 5060.9 5066.7 5079.3 5085.0 5121.0 3236.2 3274.6 3293.4 3302.2 3302.9 5572.4 5692.2 5726.7 5739.2 5745.5 6213.0 6267.2 6267.9 6284.1 6285.6 5668.6 5684.6 5700.1 5715.9 5746.6 6029.3 6050.3 6074.9 6097.1 6122.8 5762.0 5972.5 5993.6 6005.8 6006.4 5684.8 5711.3 5724.9 5725.4 5739.1 4087.4 4122.4 4167.0 4167.1 4180.6 5957.5 6101.4 6115.8 6117.3 6131.3 5879.1 5883.0 5884.0 5886.0 5886.5 5860.9 5871.3 5878.9 5882.1 5885.4 5606.4 5740.9 5747.6 5750.4 5757.0 5914.1 5915.6 5925.9 5927.6 5941.6 5734.9 5750.6 5765.1 5781.3 5789.2 11:00:52 INFO - 2015-12-03 11:00:52,018 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,018 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12609.67 Median:472.54 stddev:14711.89 (3113.4%) stddev-sans-first:14726.24 11:00:52 INFO - 2015-12-03 11:00:52,020 DEBUG : BROWSER_OUTPUT: Values: 758.0 764.6 773.8 780.9 804.6 11884.0 12187.8 12269.3 12309.0 12335.8 13041.5 13263.7 13270.6 13286.5 13356.3 772.7 781.0 787.9 789.6 790.5 771.1 782.4 791.1 792.8 795.1 804.6 815.8 816.9 821.5 821.5 801.4 806.0 810.6 812.9 816.6 609.1 609.2 609.4 610.5 611.5 11824.5 11847.2 11910.8 11931.2 11937.5 10833.3 10939.5 10998.6 11008.6 11379.8 8788.3 9159.1 9159.1 9162.5 9203.8 3170.8 3181.7 3199.9 3219.0 3330.8 42259.6 42284.0 42559.4 43095.8 43502.0 9254.0 9369.8 9440.0 9485.3 9535.7 16357.0 16404.3 16410.7 16414.4 16431.0 6183.6 6354.9 6388.2 6393.4 6478.4 3321.8 3326.0 3333.8 3433.3 3442.6 2535.1 2549.7 2592.7 2592.8 2594.2 467.6 467.7 475.3 480.3 481.4 456.3 470.4 489.3 499.7 553.4 6862.3 7059.8 7087.2 7091.3 7206.9 444.2 474.7 506.4 515.6 525.7 3613.9 3615.5 3766.3 3775.8 3846.9 52708.5 53440.2 53896.2 54065.7 54107.0 45870.8 46045.8 46083.3 46376.5 47579.5 37811.0 42782.6 42839.0 42955.6 43376.0 7758.5 7904.4 7945.3 7946.9 8076.7 33206.5 33399.0 33694.0 33843.5 34295.3 39978.0 42315.4 42421.6 43229.0 43312.0 9679.4 9682.7 9903.9 9988.7 10040.5 11476.4 11482.0 11660.9 11932.1 12202.5 9986.3 10089.0 10170.9 10356.3 10579.8 9977.0 10116.8 10187.5 10722.7 10724.9 8938.5 9133.3 10454.6 10476.4 10854.1 8751.6 8864.6 9117.4 9278.1 9316.6 8161.8 8203.0 8654.2 8668.5 8782.9 11:00:52 INFO - 2015-12-03 11:00:52,020 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:00:52 INFO - 2015-12-03 11:00:52,020 DEBUG : BROWSER_OUTPUT: 11:00:52 INFO - 2015-12-03 11:00:52,755 INFO : Browser exited with error code: 0 11:00:52 INFO - 2015-12-03 11:00:52,771 INFO : Completed test dromaeo_css (00:18:35) 11:00:52 INFO - 2015-12-03 11:00:52,772 INFO : Starting test kraken 11:00:52 INFO - 2015-12-03 11:00:52,772 DEBUG : operating with platform_type : linux_ 11:00:52 INFO - 2015-12-03 11:00:52,772 INFO : Initialising browser for kraken test... 11:00:52 INFO - 2015-12-03 11:00:52,778 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6pTa9/profile http://localhost:57301/getInfo.html 11:00:57 INFO - 2015-12-03 11:00:57,735 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:00:57 INFO - 2015-12-03 11:00:57,735 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:00:57 INFO - 2015-12-03 11:00:57,735 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:00:57 INFO - 2015-12-03 11:00:57,736 DEBUG : BROWSER_OUTPUT: __metrics 11:00:57 INFO - 2015-12-03 11:00:57,872 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:00:58 INFO - 2015-12-03 11:00:58,811 INFO : Browser initialized. 11:00:58 INFO - 2015-12-03 11:00:58,811 INFO : Running cycle 1/1 for kraken test... 11:00:58 INFO - 2015-12-03 11:00:58,812 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6pTa9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:01:10 INFO - 2015-12-03 11:01:10,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 143003648 11:01:10 INFO - 2015-12-03 11:01:10,913 DEBUG : BROWSER_OUTPUT: 11:01:13 INFO - 2015-12-03 11:01:13,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57301/tests/kraken/driver.html?testName=audio-beat-detection) 11:01:14 INFO - 2015-12-03 11:01:14,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 142864384 11:01:14 INFO - 2015-12-03 11:01:14,135 DEBUG : BROWSER_OUTPUT: 11:01:16 INFO - 2015-12-03 11:01:16,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57301/tests/kraken/driver.html?testName=audio-dft) 11:01:17 INFO - 2015-12-03 11:01:17,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 141754368 11:01:17 INFO - 2015-12-03 11:01:17,458 DEBUG : BROWSER_OUTPUT: 11:01:20 INFO - 2015-12-03 11:01:20,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57301/tests/kraken/driver.html?testName=audio-fft) 11:01:20 INFO - 2015-12-03 11:01:20,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 138518528 11:01:20 INFO - 2015-12-03 11:01:20,964 DEBUG : BROWSER_OUTPUT: 11:01:23 INFO - 2015-12-03 11:01:23,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57301/tests/kraken/driver.html?testName=audio-oscillator) 11:01:23 INFO - 2015-12-03 11:01:23,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 139042816 11:01:23 INFO - 2015-12-03 11:01:23,642 DEBUG : BROWSER_OUTPUT: 11:01:25 INFO - 2015-12-03 11:01:25,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:01:26 INFO - 2015-12-03 11:01:26,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 140591104 11:01:26 INFO - 2015-12-03 11:01:26,495 DEBUG : BROWSER_OUTPUT: 11:01:29 INFO - 2015-12-03 11:01:29,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57301/tests/kraken/driver.html?testName=imaging-darkroom) 11:01:30 INFO - 2015-12-03 11:01:30,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 141529088 11:01:30 INFO - 2015-12-03 11:01:30,173 DEBUG : BROWSER_OUTPUT: 11:01:33 INFO - 2015-12-03 11:01:33,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57301/tests/kraken/driver.html?testName=imaging-desaturate) 11:01:34 INFO - 2015-12-03 11:01:34,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 139337728 11:01:34 INFO - 2015-12-03 11:01:34,269 DEBUG : BROWSER_OUTPUT: 11:01:37 INFO - 2015-12-03 11:01:37,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57301/tests/kraken/driver.html?testName=json-parse-financial) 11:01:37 INFO - 2015-12-03 11:01:37,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 138072064 11:01:37 INFO - 2015-12-03 11:01:37,748 DEBUG : BROWSER_OUTPUT: 11:01:39 INFO - 2015-12-03 11:01:39,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:01:40 INFO - 2015-12-03 11:01:40,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 140275712 11:01:40 INFO - 2015-12-03 11:01:40,106 DEBUG : BROWSER_OUTPUT: 11:01:41 INFO - 2015-12-03 11:01:41,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:01:42 INFO - 2015-12-03 11:01:42,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 11:01:42 INFO - 2015-12-03 11:01:42,611 DEBUG : BROWSER_OUTPUT: 11:01:44 INFO - 2015-12-03 11:01:44,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:01:45 INFO - 2015-12-03 11:01:45,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 141176832 11:01:45 INFO - 2015-12-03 11:01:45,362 DEBUG : BROWSER_OUTPUT: 11:01:47 INFO - 2015-12-03 11:01:47,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:01:48 INFO - 2015-12-03 11:01:48,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 141082624 11:01:48 INFO - 2015-12-03 11:01:48,570 DEBUG : BROWSER_OUTPUT: 11:01:51 INFO - 2015-12-03 11:01:51,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:01:51 INFO - 2015-12-03 11:01:51,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 140591104 11:01:51 INFO - 2015-12-03 11:01:51,756 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57301/tests/kraken/driver.html?testName=ai-astar) 11:01:53 INFO - 2015-12-03 11:01:53,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 141369344 11:01:53 INFO - 2015-12-03 11:01:53,751 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,754 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:01:53 INFO - 2015-12-03 11:01:53,754 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:01:53 INFO - 2015-12-03 11:01:53,755 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:01:53 INFO - 2015-12-03 11:01:53,755 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:01:53 INFO - 2015-12-03 11:01:53,755 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;111;114;112;126;114;113;114;112 11:01:53 INFO - 2015-12-03 11:01:53,755 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;130;149;159;135;156;154;132;182;137 11:01:53 INFO - 2015-12-03 11:01:53,755 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;163;162;163;166;167;161;165;166 11:01:53 INFO - 2015-12-03 11:01:53,755 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;72;72;76;137;71;72;72 11:01:53 INFO - 2015-12-03 11:01:53,755 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;141;99;95;94;135;96;95;136 11:01:53 INFO - 2015-12-03 11:01:53,756 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;111;111;113;115 11:01:53 INFO - 2015-12-03 11:01:53,756 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;150;147;147;149;148;147;147 11:01:53 INFO - 2015-12-03 11:01:53,756 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;98;96;103;96;97;96;96;96 11:01:53 INFO - 2015-12-03 11:01:53,756 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;75;73;74;72;74;75;73;71 11:01:53 INFO - 2015-12-03 11:01:53,756 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;69;69;69;68;69;68;70 11:01:53 INFO - 2015-12-03 11:01:53,756 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;83;85;85;86;84;86;89;86;85 11:01:53 INFO - 2015-12-03 11:01:53,756 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;144;127;123;129;131;132;122;125;140 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;151;149;145;152;158;142;145;138;157 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;69;69;70;69;69;69;71;70;71 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,800 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: __startTimestamp1449169313753__endTimestamp 11:01:53 INFO - 2015-12-03 11:01:53,757 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,761 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:01:53 INFO - 2015-12-03 11:01:53,761 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:01:53 INFO - 2015-12-03 11:01:53,761 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,761 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.60 Median:113.50 stddev:4.84 (4.3%) stddev-sans-first:5.12 11:01:53 INFO - 2015-12-03 11:01:53,761 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 111.0 114.0 112.0 126.0 114.0 113.0 114.0 112.0 11:01:53 INFO - 2015-12-03 11:01:53,761 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,761 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.00 stddev:16.04 (10.4%) stddev-sans-first:16.76 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: Values: 157.0 130.0 149.0 159.0 135.0 156.0 154.0 132.0 182.0 137.0 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.32 (1.4%) stddev-sans-first:2.28 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 163.0 162.0 163.0 166.0 167.0 161.0 165.0 166.0 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:72.00 stddev:20.49 (28.5%) stddev-sans-first:21.59 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 72.0 72.0 76.0 137.0 71.0 72.0 72.0 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,762 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.10 Median:95.00 stddev:20.28 (21.3%) stddev-sans-first:20.86 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 141.0 99.0 95.0 94.0 135.0 96.0 95.0 136.0 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.00 Median:110.50 stddev:1.70 (1.5%) stddev-sans-first:1.76 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 113.0 115.0 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.06 (0.7%) stddev-sans-first:1.12 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 150.0 147.0 147.0 149.0 148.0 147.0 147.0 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,763 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.00 stddev:2.20 (2.3%) stddev-sans-first:2.29 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 98.0 96.0 103.0 96.0 97.0 96.0 96.0 96.0 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.50 stddev:1.37 (1.9%) stddev-sans-first:1.39 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 75.0 73.0 74.0 72.0 74.0 75.0 73.0 71.0 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 68.0 70.0 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.67 11:01:53 INFO - 2015-12-03 11:01:53,764 DEBUG : BROWSER_OUTPUT: Values: 86.0 83.0 85.0 85.0 86.0 84.0 86.0 89.0 86.0 85.0 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:130.00 stddev:7.65 (5.9%) stddev-sans-first:7.48 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: Values: 121.0 144.0 127.0 123.0 129.0 131.0 132.0 122.0 125.0 140.0 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:150.00 stddev:7.63 (5.1%) stddev-sans-first:6.69 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: Values: 135.0 151.0 149.0 145.0 152.0 158.0 142.0 145.0 138.0 157.0 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.33 (1.9%) stddev-sans-first:0.87 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: Values: 73.0 69.0 69.0 70.0 69.0 69.0 69.0 71.0 70.0 71.0 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:01:53 INFO - 2015-12-03 11:01:53,765 DEBUG : BROWSER_OUTPUT: 11:01:54 INFO - 2015-12-03 11:01:54,723 INFO : Browser exited with error code: 0 11:01:54 INFO - 2015-12-03 11:01:54,772 INFO : Completed test kraken (00:01:02) 11:01:54 INFO - 2015-12-03 11:01:54,772 INFO : Starting test v8_7 11:01:54 INFO - 2015-12-03 11:01:54,772 DEBUG : operating with platform_type : linux_ 11:01:54 INFO - 2015-12-03 11:01:54,772 INFO : Initialising browser for v8_7 test... 11:01:54 INFO - 2015-12-03 11:01:54,778 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5R8kIQ/profile http://localhost:57301/getInfo.html 11:01:59 INFO - 2015-12-03 11:01:59,661 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:01:59 INFO - 2015-12-03 11:01:59,661 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:01:59 INFO - 2015-12-03 11:01:59,661 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:01:59 INFO - 2015-12-03 11:01:59,661 DEBUG : BROWSER_OUTPUT: __metrics 11:01:59 INFO - 2015-12-03 11:01:59,786 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:02:00 INFO - 2015-12-03 11:02:00,735 INFO : Browser initialized. 11:02:00 INFO - 2015-12-03 11:02:00,736 INFO : Running cycle 1/1 for v8_7 test... 11:02:00 INFO - 2015-12-03 11:02:00,736 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5R8kIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:02:12 INFO - 2015-12-03 11:02:12,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 143187968 11:02:12 INFO - 2015-12-03 11:02:12,787 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57301/tests/v8_7/run.html (next: http://localhost:57301/tests/v8_7/run.html) 11:02:34 INFO - 2015-12-03 11:02:34,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 138604544 11:02:34 INFO - 2015-12-03 11:02:34,457 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,457 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:02:34 INFO - 2015-12-03 11:02:34,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:02:34 INFO - 2015-12-03 11:02:34,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:02:34 INFO - 2015-12-03 11:02:34,457 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:02:34 INFO - 2015-12-03 11:02:34,457 DEBUG : BROWSER_OUTPUT: |0;Richards;166.75004168751042 11:02:34 INFO - 2015-12-03 11:02:34,457 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.6381093057607 11:02:34 INFO - 2015-12-03 11:02:34,458 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.0850651149903 11:02:34 INFO - 2015-12-03 11:02:34,458 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 11:02:34 INFO - 2015-12-03 11:02:34,458 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1074.1138560687432 11:02:34 INFO - 2015-12-03 11:02:34,458 DEBUG : BROWSER_OUTPUT: |5;Earley;745.7121551081283 11:02:34 INFO - 2015-12-03 11:02:34,458 DEBUG : BROWSER_OUTPUT: |6;Boyer;12060.240963855422 11:02:34 INFO - 2015-12-03 11:02:34,459 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 11:02:34 INFO - 2015-12-03 11:02:34,459 DEBUG : BROWSER_OUTPUT: |8;Splay;584.4535359438925 11:02:34 INFO - 2015-12-03 11:02:34,459 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:02:34 INFO - 2015-12-03 11:02:34,459 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:02:34 INFO - 2015-12-03 11:02:34,460 DEBUG : BROWSER_OUTPUT: __startTimestamp1449169354455__endTimestamp 11:02:34 INFO - 2015-12-03 11:02:34,460 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,460 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:02:34 INFO - 2015-12-03 11:02:34,460 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:02:34 INFO - 2015-12-03 11:02:34,461 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,461 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,461 DEBUG : BROWSER_OUTPUT: Values: 166.8 11:02:34 INFO - 2015-12-03 11:02:34,461 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,462 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.64 Median:184.64 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,462 DEBUG : BROWSER_OUTPUT: Values: 184.6 11:02:34 INFO - 2015-12-03 11:02:34,462 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,462 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.09 Median:277.09 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: Values: 277.1 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: Values: 5218.8 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: Values: 1074.1 11:02:34 INFO - 2015-12-03 11:02:34,463 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:745.71 Median:745.71 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: Values: 745.7 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: Values: 12060.2 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: Values: 26736.8 11:02:34 INFO - 2015-12-03 11:02:34,464 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,465 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:584.45 Median:584.45 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,465 DEBUG : BROWSER_OUTPUT: Values: 584.5 11:02:34 INFO - 2015-12-03 11:02:34,465 DEBUG : BROWSER_OUTPUT: 11:02:34 INFO - 2015-12-03 11:02:34,465 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:02:34 INFO - 2015-12-03 11:02:34,465 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:02:34 INFO - 2015-12-03 11:02:34,465 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:02:34 INFO - 2015-12-03 11:02:34,465 DEBUG : BROWSER_OUTPUT: 11:02:35 INFO - 2015-12-03 11:02:35,371 INFO : Browser exited with error code: 0 11:02:35 INFO - 2015-12-03 11:02:35,390 INFO : Completed test v8_7 (00:00:40) 11:02:35 INFO - 2015-12-03 11:02:35,484 INFO : Completed test suite (00:20:18) 11:02:35 INFO - 2015-12-03 11:02:35,484 DEBUG : Working with test: dromaeo_css 11:02:35 INFO - 2015-12-03 11:02:35,484 DEBUG : Generating results file: dromaeo_css 11:02:35 INFO - 2015-12-03 11:02:35,485 DEBUG : Working with test: kraken 11:02:35 INFO - 2015-12-03 11:02:35,485 DEBUG : Generating results file: kraken 11:02:35 INFO - 2015-12-03 11:02:35,486 INFO : javascript benchmark 11:02:35 INFO - 2015-12-03 11:02:35,486 DEBUG : Working with test: v8_7 11:02:35 INFO - 2015-12-03 11:02:35,486 DEBUG : Generating results file: v8_7 11:02:35 INFO - 2015-12-03 11:02:35,486 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:02:35 INFO - 2015-12-03 11:02:35,548 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:02:35 INFO - 2015-12-03 11:02:35,548 DEBUG : process_Request line: dromaeo_css 6295.56 graph.html#tests=[[72,132,43]] 11:02:35 INFO - 2015-12-03 11:02:35,548 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:02:35 INFO - 2015-12-03 11:02:35,578 DEBUG : process_Request line: kraken 1542.90 graph.html#tests=[[232,132,43]] 11:02:35 INFO - 2015-12-03 11:02:35,578 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:02:35 INFO - 2015-12-03 11:02:35,612 DEBUG : process_Request line: v8_7 21295.04 graph.html#tests=[[230,132,43]] 11:02:35 INFO - 2015-12-03 11:02:35,613 INFO : javascript benchmark 11:02:35 INFO - 2015-12-03 11:02:35,616 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2661.3745769744114, 2719.401731619043, 2748.5052690515713, 2757.545005074163, 2764.22601671532, 4574.153781550415, 4797.496262892399, 4832.154372984731, 4864.051509955556, 4871.196252618322, 4667.6732628716, 4707.858764237069, 4783.425988881339, 4788.760561971896, 4806.543378379057, 4392.12157568486, 4411.536788637195, 4551.180787458256, 4555.544445555451, 4591.79336929839, 4227.429297044906, 4421.447319085099, 4425.4910685271125, 4485.887852803689, 4535.387722657449, 4352.064306174188, 4362.760048197348, 4381.9561804381865, 4434.467863856358, 4455.799489022969, 4423.292273236267, 4457.420535330419, 4458.643308535309, 4461.843835465743, 4493.078918821634, 4229.281022226229, 4465.084657645208, 4466.486354069259, 4485.551444855521, 4514.909701805946, 4624.09830083134, 4624.930626040612, 4625.907481850378, 4698.647601429906, 4842.104210720992, 5099.898002039976, 5140.897182056338, 5154.92267615986, 5156.690598564098, 5190.6107041972, 5177.197534382177, 5189.792408303663, 5193.065248255312, 5193.195054766517, 5194.428612852583, 4641.675082744176, 4656.767161641905, 4707.31743897133, 4733.124371991193, 4765.142274390609, 5224.268602395668, 5282.154855223146, 5288.841334759886, 5301.284326615934, 5312.9734351328, 4839.491853355417, 5034.874128146826, 5048.495150484996, 5071.163258062452, 5072.264521644414, 5043.041822053798, 5045.9747701261995, 5077.8730531737, 5120.436751957282, 5164.173732202829, 5080.5681517070725, 5082.542571168613, 5085.542301192911, 5106.361704786902, 5110.642255042186, 4798.2802579613335, 4914.975425122923, 5066.695998240044, 5069.03688299222, 5078.492150784892, 4161.167766446722, 4223.155368926227, 4226.915461690811, 4249.787510624456, 4267.701260911768, 3692.7599706019023, 3693.298273328059, 3697.7041836653, 3714.981425092911, 3731.8880433587037, 4139.79301034947, 4248.681348898845, 4324.913501729948, 4352.347147927773, 4362.280223763044, 5115.258287548285, 5138.897222055538, 5142.331496905378, 5144.15121504955, 5170.689758614495, 4368.432103826546, 4373.650107991417, 4417.646588272931, 4431.689781715249, 4452.8218871245435, 4289.056407590325, 4390.538993405647, 4391.209582275157, 4394.494633117169, 4498.685092043525, 4712.24604063355, 4753.429588449409, 4782.665213435026, 4825.131476334293, 4841.080194762983, 5135.589152867837, 5143.897122057613, 5173.948260517347, 5178.223266510054, 5215.947840521546, 4632.143053535106, 4870.537298956593, 4876.658633895735, 4892.217245240744, 4924.679895806761, 4929.950700492949, 4953.603711703127, 5088.618353623419, 5091.9490805092955, 5120.795168193231, 5189.76646050921, 5215.55667768244, 5221.477852214748, 5221.582273418194, 5274.7890084396195, 4732.0, 4830.565249127595, 5000.224965130411, 5014.774335155, 5033.521815427529, 4822.107910036654, 4873.366462359871, 4890.388701412324, 4892.486288939753, 4935.259711043373, 4809.0862736080035, 4812.831550895702, 4824.252240902666, 4873.439554451284, 4880.951190488192, 4714.5992590630185, 4830.203016502238, 4871.585915197248, 4967.379077615298, 5032.773525191302, 4826.782794774173, 4841.685290456109, 4865.902681946271, 4880.780364883518, 4943.0], "unit": "ms", "name": "dojo.html", "value": 4674.0599993120495}, {"lowerIsBetter": false, "replicates": [546.8575153986123, 557.3228527339282, 568.2868000659172, 587.667967598307, 596.1504855580796, 36762.816185919066, 37382.8130859346, 37566.0, 37636.43545346815, 37733.43399848998, 40051.799741001254, 40867.18265634686, 40877.182456350856, 40916.0, 40952.18095638086, 7959.7612071637795, 8063.153368896269, 8112.43212975092, 8113.350931925462, 8119.634616442245, 7846.764597062097, 7898.842023159534, 7906.0, 7924.920750792476, 7928.405369597274, 7942.523448593074, 7984.081830589469, 7988.9600551997155, 7992.080910695287, 8018.719344822933, 7991.0, 8076.475029123147, 8096.595170241494, 8100.270975612223, 8102.5543595102545, 7875.094364148139, 8003.639836207326, 8011.078725946474, 8012.078610959756, 8027.357811375135, 37721.62278377209, 37795.811020944995, 37898.052548686224, 37915.241695166216, 38117.0, 2722.9591556126675, 2790.9441811163865, 2875.8130721503035, 2905.041336359018, 3435.209901722618, 27856.303592410353, 28343.85828070867, 28562.0, 28855.278618034507, 29437.11688649344, 3061.4183305171946, 3083.4141513112663, 3087.8919237826794, 3136.560881476595, 3152.684731526852, 208595.0, 211218.0, 211570.0, 211573.0, 212311.0, 50377.0, 51719.48280517222, 53690.19464708032, 54380.728096359264, 54575.18137227945, 64014.0397894032, 65503.34496655068, 65833.67083164553, 65848.0, 65991.0, 11805.114616403804, 11814.05487560993, 11866.406679666155, 11879.168458207843, 11883.0, 9232.723018309462, 9242.491662958602, 9248.768780780534, 9278.582463789146, 9296.95351523238, 19153.80846191548, 19337.226510939407, 19375.224991000203, 19418.22327106928, 19418.417447476597, 6961.721531138799, 7129.572225666477, 7164.355208031302, 7192.604406757679, 7213.49505534618, 874.6588830356167, 880.722572389708, 895.1227796759082, 914.4604683236922, 962.5139304651107, 26328.34179145537, 26384.8680756595, 26385.0, 26573.468530629278, 26775.86612066927, 981.2052237687496, 1004.7849272302766, 1007.2596641468515, 1009.28340877976, 1080.9405482698369, 13861.376238069312, 14179.361928713026, 14186.85813141876, 14187.14877107377, 14275.42898284057, 261979.0, 266431.0, 266498.0, 267022.0, 267327.0, 45978.31032534515, 46082.0, 46131.0, 46139.538604614194, 46177.0, 1200.699825043739, 1215.8905698487179, 1220.8168774683868, 1223.5956345780585, 1352.9458821647024, 25313.240602781945, 25577.232683019538, 25813.3546661335, 25891.482170356863, 25959.48081038331, 40607.39088913728, 41191.588084119976, 41368.586314136475, 41381.1723765517, 41479.170416592104, 247312.0, 247814.0, 248357.0, 248939.0, 249590.0, 28308.43383132367, 28762.137135885958, 28816.711832881403, 28817.56773648355, 29068.418631626824, 32931.34137317193, 33630.663693363735, 34313.656863431046, 34772.82613587017, 34846.47730283997, 32057.198570035, 32285.838570806995, 33129.337413252084, 33303.50044749282, 33424.83287583546, 30862.69137308688, 31693.056038119637, 31755.84122079467, 32668.673313267514, 36205.456918146774, 32494.350112997134, 32961.175970600925, 32962.17594560059, 33040.1739956503, 33250.50124248186, 29354.266143345732, 29994.950176744584, 30069.3986120272, 30620.84689576627, 30850.845745771127, 22794.54410911806, 23414.297571072893, 24590.0, 25421.87289063543, 25477.0], "unit": "ms", "name": "ext.html", "value": 16728.55126517034}, {"lowerIsBetter": false, "replicates": [335.6710423784691, 336.08081896014414, 338.68333108543527, 339.6433744568204, 339.9269157131217, 14813.185274809895, 15145.621359466018, 15846.603834904134, 15917.124558149297, 16373.09947952862, 9239.861402078974, 9468.38455500392, 11896.405179741021, 13337.066405351628, 13343.733125337487, 4489.393931819203, 4598.356230127785, 4599.149157405891, 4601.7238965662, 4793.90412191756, 4951.529604687549, 4953.925691114636, 4955.355803745508, 4974.527419895104, 4977.925331120036, 4697.9060418791605, 4832.806687732486, 4854.2718592211095, 4905.705657660534, 4942.703437793726, 4738.336632871401, 4775.880602984918, 4790.233562629963, 4793.9520604794025, 4828.806847726087, 4670.883227919329, 4779.498152693986, 4833.081714474239, 4833.130036593412, 4837.7339246341435, 11333.773324533464, 11770.352630605314, 13924.164550127025, 14005.0, 14082.155070695791, 1725.5082301544126, 1802.8467580255694, 1827.972580411295, 1891.328578354692, 1931.1792488192461, 8586.699465518677, 8835.55822208887, 8837.293016558724, 8887.066857979948, 8920.553972301424, 1726.8877522961093, 1759.8856074355253, 1787.928482860684, 1798.235749806327, 1807.9433896446928, 45834.54165458369, 46236.53763462356, 47097.29354059692, 47299.52700472951, 47438.525614743754, 10024.248181386425, 10028.147607453302, 10069.244806639532, 10080.596776128872, 10109.64616238428, 12494.625161245178, 12505.187162834387, 12515.249085054926, 12530.373481325898, 12594.118411711275, 7092.858142837217, 7118.323759242864, 7118.71525138999, 7173.3185347392955, 7185.928140718631, 6802.387785099365, 6805.557638753465, 6826.829329266808, 6846.520743547904, 6895.896561551581, 4242.215190189825, 4250.893727656771, 4278.4010238566625, 4302.870913872589, 4318.784060796947, 1726.620143568413, 1734.9739753903702, 1771.2118107442066, 1803.9188236529387, 1805.8555315574722, 822.6914906909909, 873.3188113271658, 941.0285451978095, 947.303731757158, 959.6785076999283, 15139.924300378649, 15355.462558810388, 15355.846441535665, 15912.124833134289, 16082.919585402233, 816.5345752920778, 821.6343727041528, 847.3221422861686, 868.4268382867277, 890.7639475538858, 8362.16378362171, 9011.594478248495, 9021.819563608691, 9044.547772611342, 9229.53852307382, 429918.0, 438050.0, 453200.0, 457028.0, 457530.0, 69118.30881691219, 69265.0, 69269.0, 69609.0, 70225.29774702188, 1005.7988402319565, 1013.6046941692746, 1066.3335415365398, 1074.4305518075432, 1081.167501024207, 14141.43434262618, 14203.28983550839, 14288.857111429168, 14324.713505730035, 15220.391184352944, 33468.49797253092, 35460.46809297914, 37229.255414891006, 37351.43972840355, 38309.808450958684, 42919.57080429156, 43492.0, 44480.0, 49023.50976490189, 49404.50595493999, 13441.798373024609, 13780.586582402544, 14167.64580885486, 14474.493392731625, 14489.420423183376, 17630.911845441206, 17708.822911770716, 17820.554486137433, 18084.638307234043, 18304.35934742331, 8354.498730076215, 8650.307975362082, 8689.0876457971, 8847.380683352103, 14754.926225369234, 8801.339899507691, 8954.0, 9168.724938251864, 9232.076792320715, 9782.461964592016, 8286.254237118446, 9306.0, 9333.160015598629, 9648.0, 9834.754131146492, 13915.0, 14144.363503642155, 14556.344964476835, 14582.979191456496, 14637.85362146365, 8751.168638979287, 8915.554222288989, 9007.09929007094, 9027.45835249887, 9127.497987610479], "unit": "ms", "name": "jquery.html", "value": 7975.0811968619955}, {"lowerIsBetter": false, "replicates": [1485.739995500787, 1663.4344322930206, 1682.234583264614, 1708.8379901666863, 1723.8965662060277, 6076.574639775217, 6175.0, 6663.4336081433075, 7227.024351712517, 7243.4205263578915, 6757.66211689416, 6925.688344024518, 6998.8250293742685, 7092.148942126939, 7095.645217739118, 2041.8979051047388, 2049.9897500512516, 2062.0, 2077.044559502623, 2079.8856062916534, 2027.6350256953742, 2041.2447394464068, 2052.3945436096315, 2074.4502706782714, 2084.6247675418417, 2046.703228031942, 2053.3429302623167, 2072.7927207279304, 2081.9167233310727, 2092.403664955488, 2102.1381233694187, 2133.95732085359, 2133.9893300533477, 2137.0, 2140.3792900058966, 2058.3824852544176, 2097.7063211150453, 2101.810837024675, 2102.2747152232455, 2109.9261525846673, 6700.095487109275, 6760.661966901635, 6762.154730658668, 6799.626020568867, 6809.216940051859, 4089.9591004089875, 4133.875983720493, 4148.377743338523, 4163.042500224935, 4172.165566886604, 2315.6873822033976, 2404.410919324759, 2680.7319268073234, 2747.7939154563487, 2763.115802943059, 856.7130011446111, 885.7874110213567, 885.9822803543893, 899.7210864631985, 926.7219834049758, 9458.101480359355, 9724.319297649168, 9729.610815567368, 9731.805363892754, 9800.754981125458, 3880.0, 3886.0479182600443, 3912.7847968361443, 3966.0679740261016, 3991.201759648082, 7637.847243055107, 7669.0, 7674.270944260286, 7678.232176782389, 7686.3082322591235, 4046.1300820323772, 4056.2698714231133, 4056.7768772717195, 4060.553339132693, 4068.7965601719798, 3684.2815650948346, 3696.094456858087, 3697.0, 3704.2776658551325, 3717.386631205821, 3063.8008529445515, 3075.815451072943, 3088.907332779975, 3116.174213833336, 3118.6413562440157, 910.8360495110811, 913.2739472119681, 923.9168474837297, 924.5654542365078, 925.7176561148914, 865.1262225152516, 910.8497097978759, 1155.0759392485977, 1202.687301301668, 1210.6126039667397, 6505.512086593524, 6567.573107747981, 6570.441512471398, 6591.604503729792, 6601.240857301375, 1031.0874875734878, 1041.5937784264142, 1043.9321444106108, 1066.6693325069252, 1072.871255449351, 5353.384360798558, 5393.191021346829, 5413.648112872651, 5416.945830541644, 5428.701421421781, 7587.165411804697, 7724.150343462215, 8411.0, 8619.396642234984, 8676.826463470696, 8450.366222533334, 8450.492970421672, 8473.152684731478, 8503.574821258911, 8537.274331681876, 6502.447291980235, 6509.869802603921, 6648.933510664928, 6671.166104236971, 6680.732770689216, 6334.398232167937, 6364.840878978062, 6365.649889256136, 6372.107904893226, 6405.807825765234, 7370.226126256666, 7483.214262502359, 7528.887066693895, 7552.093748750185, 7563.205863384265, 7684.423668224794, 7737.690492380467, 7913.841723165619, 7938.920610793818, 7947.046354437504, 6074.969625151846, 6126.816195514141, 6173.629582225081, 6180.412860778399, 6236.064590311308, 6611.404973552403, 6688.331166883273, 6699.732010719516, 6722.394984451423, 6741.494387920828, 6050.485708714633, 6378.808635740936, 6621.271660117287, 6698.631575263407, 6740.224874139537, 6291.96854015727, 6379.362063793584, 6395.296517383177, 6419.935800641933, 6535.248446428722, 6478.060681201294, 6483.740650373932, 6505.31694172124, 6507.577007494498, 6520.347965203631, 5850.561207909339, 5902.321233058082, 5927.4665280125, 5947.970260148844, 5977.641341519523, 6112.694365281629, 6127.417895299939, 6137.202163718688, 6141.263048434216, 6141.692915354125], "unit": "ms", "name": "mootools.html", "value": 4039.683756363857}, {"lowerIsBetter": false, "replicates": [292.39766081871346, 299.2056091078188, 302.1223346179349, 304.5295019195344, 305.1303784214986, 5487.6158668893195, 5522.0, 5537.197106419567, 5552.11166213406, 5702.0, 5469.945300546993, 5541.695206763627, 5571.359293681217, 5578.776848926048, 5579.0, 4123.876283711494, 4282.443282373287, 4289.442372491571, 4293.313069908823, 4300.720453170534, 4204.97897510512, 4211.8525851595205, 4223.176480586287, 4226.619604235618, 4237.470316210473, 4176.227397931377, 4177.33162693969, 4184.456020717303, 4188.4136220929095, 4202.558731333212, 4182.0, 4183.874483765492, 4200.600942910419, 4203.726757760766, 4210.831566737327, 3637.163452405935, 3639.3267245559655, 3639.854405823764, 3643.4899114124046, 3644.0889777555612, 5193.896122077537, 5358.0, 5366.70483123428, 5380.596455265871, 5417.377001644822, 4826.927596086061, 4827.203511420611, 4833.05755377698, 4839.443464001614, 4841.588464980481, 5857.20927674767, 5861.648301101947, 5871.882562348729, 5873.823785286406, 5879.647221166743, 3960.1485680578526, 3963.6234557717257, 3963.781991990468, 3972.423998520227, 3978.6817054635558, 5961.374055724174, 6052.818415447544, 6127.234095738033, 6130.693465326761, 6130.754769809202, 4042.211768705133, 4042.3532234842282, 4059.0, 4064.2277967186733, 4072.2873497137884, 4110.712250142461, 4110.856120035784, 4112.773797441169, 4125.278076336629, 4126.401671757639, 4743.335932969387, 4744.976275118603, 4758.6437865208245, 4763.309320148628, 4779.330893674888, 5624.493795558419, 5782.45066718661, 5825.271841019872, 5832.270966129234, 5852.502537284294, 1442.3653592419303, 1465.80211671423, 1466.7506523890963, 1467.156385078584, 1468.3172324868988, 972.2465089555651, 973.5764942250144, 974.0503009565617, 988.9912289464705, 994.0606127209862, 4989.451160372356, 5046.419661738873, 5051.924221136685, 5056.64603477753, 5062.038212739568, 5920.319163296276, 6042.335343112254, 6065.3934606539, 6123.173371594867, 6138.631682099089, 5060.924086138711, 5066.695998240118, 5079.288899554065, 5085.0, 5121.0, 3236.158598764291, 3274.5579346788354, 3293.374258890803, 3302.1744563859033, 3302.9174270643425, 5572.414896435897, 5692.203091567184, 5726.713664316851, 5739.16782066598, 5745.511631511368, 6212.968935155295, 6267.2479302484, 6267.9373206267355, 6284.057391391328, 6285.622862628257, 5668.574856885668, 5684.573656975744, 5700.144978253295, 5715.914261286084, 5746.569007324468, 6029.276486821609, 6050.273967123797, 6074.878502430015, 6097.054956481752, 6122.755089796358, 5762.0, 5972.522198224045, 5993.61041532299, 6005.819825405245, 6006.3693312201585, 5684.8294551163535, 5711.257536520226, 5724.885502289848, 5725.370209276893, 5739.110437882135, 4087.427760113527, 4122.42286079943, 4166.979165104155, 4167.124903770121, 4180.6446452050695, 5957.49361304294, 6101.389861013863, 6115.847103822262, 6117.296510901126, 6131.294901086432, 5879.118132280192, 5883.0, 5883.970580147072, 5885.970570147122, 5886.52907767369, 5860.853478663067, 5871.266091738533, 5878.911816322673, 5882.058870580858, 5885.352611212848, 5606.411326810789, 5740.856478588069, 5747.626404283708, 5750.424957504383, 5757.0, 5914.083317085859, 5915.58590898633, 5925.940740592711, 5927.644341339534, 5941.554383421174, 5734.885302294014, 5750.6262092963825, 5765.135229715576, 5781.335146458043, 5789.189513468202], "unit": "ms", "name": "prototype.html", "value": 4346.497011324502}, {"lowerIsBetter": false, "replicates": [758.0486489455732, 764.6176911544228, 773.79494433975, 780.886771418144, 804.6178065418925, 11884.0, 12187.817182742267, 12269.263844169356, 12309.0, 12335.814962775565, 13041.543545975892, 13263.668408289797, 13270.601881943532, 13286.468541258362, 13356.265405402699, 772.6600295869828, 780.9609519524015, 787.9369650427981, 789.5578476053429, 790.5019837502365, 771.1132197972321, 782.3858271257064, 791.0507391130637, 792.8216151365925, 795.1055063054064, 804.6017221475348, 815.7715839564931, 816.8570500162477, 821.4537332673765, 821.4906757810166, 801.374927556504, 806.0247101007787, 810.614957895001, 812.9390295727844, 816.6121092481054, 609.1411110334451, 609.2475792396431, 609.421050002495, 610.5237914426755, 611.4894063457019, 11824.527018919232, 11847.229930054606, 11910.761784764256, 11931.164818462712, 11937.522499100025, 10833.29583577065, 10939.45302734868, 10998.615048473264, 11008.614698485515, 11379.772404551946, 8788.252998495136, 9159.084091590854, 9159.129882661136, 9162.541872906395, 9203.769905752342, 3170.8097514148994, 3181.6659250778566, 3199.936001279961, 3219.0, 3330.7668463207583, 42259.57740422618, 42284.0, 42559.361609575884, 43095.78452107719, 43502.0, 9254.0, 9369.765755856022, 9439.952800235955, 9485.288603354638, 9535.666251681296, 16357.0, 16404.343826246815, 16410.671786564202, 16414.42549510785, 16431.0, 6183.628982261079, 6354.904676429857, 6388.233411990498, 6393.392627700361, 6478.352164783578, 3321.7674762766374, 3325.966740332614, 3333.7833040852265, 3433.3305005524185, 3442.638522955104, 2535.1380530619676, 2549.6685430894236, 2592.727763584834, 2592.766651001381, 2594.2347007632793, 467.60720994364897, 467.70300858954806, 475.27520531190214, 480.27478507454, 481.3670023918536, 456.28430174149867, 470.4166833126898, 489.2587729589674, 499.7076710124618, 553.3885057012025, 6862.348076932683, 7059.82350441243, 7087.184973728087, 7091.326323999212, 7206.891896621555, 444.23147954039695, 474.6653609205502, 506.4252073896154, 515.600409682499, 525.6635753118007, 3613.9277214456088, 3615.475756015363, 3766.3408903441787, 3775.811209439517, 3846.9038274042814, 52708.47291527112, 53440.198397024076, 53896.19155712667, 54065.72967135218, 54107.0, 45870.77064614656, 46045.76977115093, 46083.30875036877, 46376.5362346379, 47579.52420475751, 37811.0, 42782.57217427786, 42839.0, 42955.57044429578, 43376.0, 7758.495697779626, 7904.367650587824, 7945.275195712941, 7946.8807967881685, 8076.676932922617, 33206.501902471966, 33399.0, 33694.0, 33843.4923476153, 34295.31409371849, 39978.0, 42315.365269520364, 42421.575784242996, 43229.0, 43312.0, 9679.370840895319, 9682.70951871445, 9903.851442228517, 9988.650397236062, 10040.497975101069, 11476.368799716096, 11482.0, 11660.88339116598, 11932.105092117952, 12202.450889710162, 9986.300958932805, 10089.0, 10170.949145254226, 10356.275060745675, 10579.841302380317, 9976.950115249378, 10116.797664046826, 10187.490625468845, 10722.73193170177, 10724.946375268073, 8938.50838203905, 9133.269338453041, 10454.581816727246, 10476.423796691255, 10854.077403420482, 8751.606177722146, 8864.556772161495, 9117.407368521024, 9278.072192780668, 9316.580753866228, 8161.755147345589, 8203.0, 8654.177853103945, 8668.523231222343, 8782.912170878464], "unit": "ms", "name": "yui.html", "value": 5685.743830681884}], "name": "dromaeo_css", "value": 6295.557075774691}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 114.0, 112.0, 126.0, 114.0, 113.0, 114.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 149.0, 159.0, 135.0, 156.0, 154.0, 132.0, 182.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 162.0, 163.0, 166.0, 167.0, 161.0, 165.0, 166.0], "unit": "ms", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 72.0, 72.0, 76.0, 137.0, 71.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 141.0, 99.0, 95.0, 94.0, 135.0, 96.0, 95.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 113.0, 115.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 111.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 150.0, 147.0, 147.0, 149.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 98.0, 96.0, 103.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 73.0, 74.0, 72.0, 74.0, 75.0, 73.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 85.0, 85.0, 86.0, 84.0, 86.0, 89.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [121.0, 144.0, 127.0, 123.0, 129.0, 131.0, 132.0, 122.0, 125.0, 140.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [135.0, 151.0, 149.0, 145.0, 152.0, 158.0, 142.0, 145.0, 138.0, 157.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 71.0, 70.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1542.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [184.6381093057607], "unit": "score", "name": "DeltaBlue", "value": 358.0950880000001}, {"lowerIsBetter": false, "replicates": [277.0850651149903], "unit": "score", "name": "Encrypt", "value": 960.647229}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [745.7121551081283], "unit": "score", "name": "Earley", "value": 893.7268829999998}, {"lowerIsBetter": false, "replicates": [12060.240963855422], "unit": "score", "name": "Boyer", "value": 55.2611678321678}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [584.4535359438925], "unit": "score", "name": "Splay", "value": 139.43110099999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21295.036325530113}]} 11:02:35 INFO - RETURN: dromaeo_css: 6295.56 11:02:35 INFO - RETURN: kraken: 1542.90 11:02:35 INFO - RETURN: v8_7: 21295.04 11:02:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21295.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1542.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6295.56"}}} 11:02:35 INFO - Return code: 0 11:02:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:02:35 INFO - # TBPL SUCCESS # 11:02:35 INFO - Running post-action listener: _resource_record_post_action 11:02:35 INFO - Running post-run listener: _resource_record_post_run 11:02:36 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 505405440; Read time: 184; Write time: 472036 11:02:36 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231538688; Read time: 0; Write time: 310328 11:02:36 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 266989568; Read time: 184; Write time: 159292 11:02:36 INFO - Running post-run listener: _upload_blobber_files 11:02:36 INFO - Blob upload gear active. 11:02:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:02:36 INFO - Copying logs to upload dir... 11:02:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.020028 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-03 11:02:36.662204) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 11:02:36.663582) ========= 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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010018 build_url: 'https://queue.taskcluster.net/v1/task/RtVuLHnrRquz1YT8DjOsHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 11:02:36.728060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 mins, 9 secs) (at 2015-12-03 11:02:36.728438) ========= 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=3cd289541638898829117e0a000001bd-1449168086.142202-1887392268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 69.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 mins, 9 secs) (at 2015-12-03 11:03:45.833853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 11:03:45.834241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 11:03:46.129074) ========= ========= Total master_lag: 69.36 =========