builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1449688795.82 results: success (0) buildid: 20151209104438 builduid: e252137886f546ac95ef0e37e35dde6b revision: 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:55.819239) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:55.819660) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:55.819953) ========= 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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006444 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:55.863034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:55.863331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:55.963715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:55.963986) ========= 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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:56.023277) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:56.023559) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:56.023885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:56.024154) ========= 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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 11:19:56-- 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% 23.5M=0s 2015-12-09 11:19:56 (23.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:56.235950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:56.236254) ========= 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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014458 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:56.288880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 11:19:56.289243) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 --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 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 --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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 11:19:56,761 truncating revision to first 12 chars 2015-12-09 11:19:56,761 Setting DEBUG logging. 2015-12-09 11:19:56,761 attempt 1/10 2015-12-09 11:19:56,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/575efef2e8cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 11:19:57,932 unpacking tar archive at: fx-team-575efef2e8cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.429978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 11:19:57.735801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:57.736528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:57.747298) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:57.747563) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:57.747951) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-09 11:19:57.748231) ========= /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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:19:58 INFO - MultiFileLogger online at 20151209 11:19:58 in /builds/slave/test 11:19:58 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 11:19:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:19:58 INFO - {'append_to_log': False, 11:19:58 INFO - 'base_work_dir': '/builds/slave/test', 11:19:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:19:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:19:58 INFO - 'branch': 'Fx-Team-Non-PGO', 11:19:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:19:58 INFO - 'config_files': ('talos/linux_config.py',), 11:19:58 INFO - 'default_actions': ('clobber', 11:19:58 INFO - 'read-buildbot-config', 11:19:58 INFO - 'download-and-extract', 11:19:58 INFO - 'populate-webroot', 11:19:58 INFO - 'create-virtualenv', 11:19:58 INFO - 'install', 11:19:58 INFO - 'run-tests'), 11:19:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:19:58 INFO - 'download_minidump_stackwalk': True, 11:19:58 INFO - 'download_symbols': 'ondemand', 11:19:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:19:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:19:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:19:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:19:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:19:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:19:58 INFO - 'installer_path': 'installer.exe', 11:19:58 INFO - 'log_level': 'info', 11:19:58 INFO - 'log_name': 'talos', 11:19:58 INFO - 'log_to_console': True, 11:19:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:19:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:19:58 INFO - 'opt_config_files': (), 11:19:58 INFO - 'pip_index': False, 11:19:58 INFO - 'sps_profile': False, 11:19:58 INFO - 'sps_profile_interval': 0, 11:19:58 INFO - 'suite': 'dromaeojs-e10s', 11:19:58 INFO - 'system_bits': '64', 11:19:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:19:58 INFO - 'title': 'talos-linux64-ix-002', 11:19:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:19:58 INFO - 'use_talos_json': True, 11:19:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:19:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:19:58 INFO - 'work_dir': 'build'} 11:19:58 INFO - ##### 11:19:58 INFO - ##### Running clobber step. 11:19:58 INFO - ##### 11:19:58 INFO - Running pre-action listener: _resource_record_pre_action 11:19:58 INFO - Running main action method: clobber 11:19:58 INFO - rmtree: /builds/slave/test/build 11:19:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:19:59 INFO - Running post-action listener: _resource_record_post_action 11:19:59 INFO - ##### 11:19:59 INFO - ##### Running read-buildbot-config step. 11:19:59 INFO - ##### 11:19:59 INFO - Running pre-action listener: _resource_record_pre_action 11:19:59 INFO - Running main action method: read_buildbot_config 11:19:59 INFO - Using buildbot properties: 11:19:59 INFO - { 11:19:59 INFO - "properties": { 11:19:59 INFO - "buildnumber": 557, 11:19:59 INFO - "product": "firefox", 11:19:59 INFO - "script_repo_revision": "production", 11:19:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:19:59 INFO - "repository": "", 11:19:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:19:59 INFO - "buildid": "20151209104438", 11:19:59 INFO - "slavename": "talos-linux64-ix-002", 11:19:59 INFO - "pgo_build": "False", 11:19:59 INFO - "basedir": "/builds/slave/test", 11:19:59 INFO - "project": "", 11:19:59 INFO - "platform": "ubuntu64_hw", 11:19:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:19:59 INFO - "slavebuilddir": "test", 11:19:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:19:59 INFO - "branch": "fx-team", 11:19:59 INFO - "repo_path": "integration/fx-team", 11:19:59 INFO - "stage_platform": "linux64", 11:19:59 INFO - "builduid": "e252137886f546ac95ef0e37e35dde6b", 11:19:59 INFO - "revision": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8" 11:19:59 INFO - }, 11:19:59 INFO - "sourcestamp": { 11:19:59 INFO - "repository": "", 11:19:59 INFO - "hasPatch": false, 11:19:59 INFO - "project": "", 11:19:59 INFO - "branch": "fx-team-linux64-talos", 11:19:59 INFO - "changes": [ 11:19:59 INFO - { 11:19:59 INFO - "category": null, 11:19:59 INFO - "files": [ 11:19:59 INFO - { 11:19:59 INFO - "url": null, 11:19:59 INFO - "name": "https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:19:59 INFO - } 11:19:59 INFO - ], 11:19:59 INFO - "repository": "", 11:19:59 INFO - "rev": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8", 11:19:59 INFO - "who": "mleibovic@mozilla.com", 11:19:59 INFO - "when": 1449688750, 11:19:59 INFO - "number": 7172124, 11:19:59 INFO - "comments": "Bug 1221513 - Disable test_TelemetryEnvironment.js on Android. r=me", 11:19:59 INFO - "project": "", 11:19:59 INFO - "at": "Wed 09 Dec 2015 11:19:10", 11:19:59 INFO - "branch": "fx-team-linux64-talos", 11:19:59 INFO - "revlink": "", 11:19:59 INFO - "properties": [ 11:19:59 INFO - [ 11:19:59 INFO - "buildid", 11:19:59 INFO - "20151209104438", 11:19:59 INFO - "Change" 11:19:59 INFO - ], 11:19:59 INFO - [ 11:19:59 INFO - "builduid", 11:19:59 INFO - "e252137886f546ac95ef0e37e35dde6b", 11:19:59 INFO - "Change" 11:19:59 INFO - ], 11:19:59 INFO - [ 11:19:59 INFO - "pgo_build", 11:19:59 INFO - "False", 11:19:59 INFO - "Change" 11:19:59 INFO - ] 11:19:59 INFO - ], 11:19:59 INFO - "revision": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8" 11:19:59 INFO - } 11:19:59 INFO - ], 11:19:59 INFO - "revision": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8" 11:19:59 INFO - } 11:19:59 INFO - } 11:19:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:19:59 INFO - Running post-action listener: _resource_record_post_action 11:19:59 INFO - ##### 11:19:59 INFO - ##### Running download-and-extract step. 11:19:59 INFO - ##### 11:19:59 INFO - Running pre-action listener: _resource_record_pre_action 11:19:59 INFO - Running main action method: download_and_extract 11:19:59 INFO - mkdir: /builds/slave/test/build/tests 11:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:59 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:19:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json 11:19:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json 11:19:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:20:00 INFO - Downloaded 1302 bytes. 11:20:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:20:00 INFO - Using the following test package requirements: 11:20:00 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:00 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:00 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:00 INFO - u'jsshell-linux-x86_64.zip'], 11:20:00 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:00 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:00 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:20:00 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:20:00 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:00 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:00 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:00 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:20:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:02 INFO - Downloaded 21860154 bytes. 11:20:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:20:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:20:03 INFO - Return code: 0 11:20:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:03 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:20:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:10 INFO - Downloaded 21860154 bytes. 11:20:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:20:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:20:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:20:11 INFO - Return code: 0 11:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:11 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:20:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:20:14 INFO - Downloaded 11132038 bytes. 11:20:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:20:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:20:14 INFO - Return code: 0 11:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:14 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:20:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:20:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:20:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:20:18 INFO - Downloaded 57733956 bytes. 11:20:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:20:18 INFO - mkdir: /builds/slave/test/properties 11:20:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:18 INFO - Contents: 11:20:18 INFO - build_url:https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:20:18 INFO - Running post-action listener: _resource_record_post_action 11:20:18 INFO - Running post-action listener: set_extra_try_arguments 11:20:18 INFO - ##### 11:20:18 INFO - ##### Running populate-webroot step. 11:20:18 INFO - ##### 11:20:18 INFO - Running pre-action listener: _resource_record_pre_action 11:20:18 INFO - Running main action method: populate_webroot 11:20:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:18 INFO - '--tppagecycles', 11:20:18 INFO - '7'], 11:20:18 INFO - 'tests': ['tsvgm']}}, 11:20:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:20:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:20:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:20:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'tests': ['damp', 'tps']}, 11:20:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['damp', 'tps']}, 11:20:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:20:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:18 INFO - 'other': {'tests': ['a11yr', 11:20:18 INFO - 'ts_paint', 11:20:18 INFO - 'tpaint', 11:20:18 INFO - 'sessionrestore', 11:20:18 INFO - 'sessionrestore_no_auto_restore']}, 11:20:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['a11yr', 11:20:18 INFO - 'ts_paint', 11:20:18 INFO - 'tpaint', 11:20:18 INFO - 'sessionrestore', 11:20:18 INFO - 'sessionrestore_no_auto_restore']}, 11:20:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['a11yr', 11:20:18 INFO - 'ts_paint', 11:20:18 INFO - 'tpaint', 11:20:18 INFO - 'sessionrestore', 11:20:18 INFO - 'sessionrestore_no_auto_restore']}, 11:20:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['a11yr', 11:20:18 INFO - 'ts_paint', 11:20:18 INFO - 'tpaint', 11:20:18 INFO - 'sessionrestore', 11:20:18 INFO - 'sessionrestore_no_auto_restore']}, 11:20:18 INFO - 'other_l64': {'tests': ['a11yr', 11:20:18 INFO - 'ts_paint', 11:20:18 INFO - 'tpaint', 11:20:18 INFO - 'sessionrestore', 11:20:18 INFO - 'sessionrestore_no_auto_restore']}, 11:20:18 INFO - 'other_nol64': {'tests': ['a11yr', 11:20:18 INFO - 'ts_paint', 11:20:18 INFO - 'tpaint', 11:20:18 INFO - 'sessionrestore', 11:20:18 INFO - 'sessionrestore_no_auto_restore']}, 11:20:18 INFO - 'svgr': {'tests': ['tsvgx', 11:20:18 INFO - 'tsvgr_opacity', 11:20:18 INFO - 'tart', 11:20:18 INFO - 'tscrollx', 11:20:18 INFO - 'cart']}, 11:20:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['tsvgx', 11:20:18 INFO - 'tsvgr_opacity', 11:20:18 INFO - 'tart', 11:20:18 INFO - 'tscrollx', 11:20:18 INFO - 'cart']}, 11:20:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'tests': ['tp5o']}, 11:20:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'talos_options': ['--e10s'], 11:20:18 INFO - 'tests': ['tp5o']}, 11:20:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'talos_options': ['--xperf_path', 11:20:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:18 INFO - 'tests': ['tp5n']}, 11:20:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:18 INFO - 'talos_options': ['--e10s', 11:20:18 INFO - '--xperf_path', 11:20:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:18 INFO - 'tests': ['tp5n']}}, 11:20:18 INFO - 'talos.zip': {'path': '', 11:20:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:18 INFO - Running post-action listener: _resource_record_post_action 11:20:18 INFO - ##### 11:20:18 INFO - ##### Running create-virtualenv step. 11:20:18 INFO - ##### 11:20:18 INFO - Running pre-action listener: _resource_record_pre_action 11:20:18 INFO - Running main action method: create_virtualenv 11:20:18 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:18 INFO - Using real prefix '/usr' 11:20:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:18 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:20 INFO - Installing pip.................done. 11:20:20 INFO - Return code: 0 11:20:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:20 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:20 INFO - Using env: {'DISPLAY': ':0', 11:20:20 INFO - 'HOME': '/home/cltbld', 11:20:20 INFO - 'LANG': 'en_US.UTF-8', 11:20:20 INFO - 'LANGUAGE': 'en_US:en', 11:20:20 INFO - 'LOGNAME': 'cltbld', 11:20:20 INFO - 'MAIL': '/var/mail/cltbld', 11:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:20 INFO - 'MOZ_NO_REMOTE': '1', 11:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:20 INFO - 'NO_EM_RESTART': '1', 11:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:20 INFO - 'PWD': '/builds/slave/test', 11:20:20 INFO - 'SHELL': '/bin/bash', 11:20:20 INFO - 'SHLVL': '1', 11:20:20 INFO - 'TERM': 'linux', 11:20:20 INFO - 'TMOUT': '86400', 11:20:20 INFO - 'USER': 'cltbld', 11:20:20 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:20 INFO - '_': '/tools/buildbot/bin/python'} 11:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:20:20 INFO - Cleaning up... 11:20:20 INFO - Return code: 0 11:20:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:20 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:20:20 INFO - Using env: {'DISPLAY': ':0', 11:20:20 INFO - 'HOME': '/home/cltbld', 11:20:20 INFO - 'LANG': 'en_US.UTF-8', 11:20:20 INFO - 'LANGUAGE': 'en_US:en', 11:20:20 INFO - 'LOGNAME': 'cltbld', 11:20:20 INFO - 'MAIL': '/var/mail/cltbld', 11:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:20 INFO - 'MOZ_NO_REMOTE': '1', 11:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:20 INFO - 'NO_EM_RESTART': '1', 11:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:20 INFO - 'PWD': '/builds/slave/test', 11:20:20 INFO - 'SHELL': '/bin/bash', 11:20:20 INFO - 'SHLVL': '1', 11:20:20 INFO - 'TERM': 'linux', 11:20:20 INFO - 'TMOUT': '86400', 11:20:20 INFO - 'USER': 'cltbld', 11:20:20 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:20 INFO - '_': '/tools/buildbot/bin/python'} 11:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:21 INFO - Downloading/unpacking psutil>=0.7.1 11:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:22 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:20:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:22 INFO - Installing collected packages: psutil 11:20:22 INFO - Running setup.py install for psutil 11:20:22 INFO - building 'psutil._psutil_linux' extension 11:20:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:20:23 INFO - building 'psutil._psutil_posix' extension 11:20:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:20:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:23 INFO - Successfully installed psutil 11:20:23 INFO - Cleaning up... 11:20:23 INFO - Return code: 0 11:20:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:23 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:20:23 INFO - Using env: {'DISPLAY': ':0', 11:20:23 INFO - 'HOME': '/home/cltbld', 11:20:23 INFO - 'LANG': 'en_US.UTF-8', 11:20:23 INFO - 'LANGUAGE': 'en_US:en', 11:20:23 INFO - 'LOGNAME': 'cltbld', 11:20:23 INFO - 'MAIL': '/var/mail/cltbld', 11:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:23 INFO - 'MOZ_NO_REMOTE': '1', 11:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:23 INFO - 'NO_EM_RESTART': '1', 11:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:23 INFO - 'PWD': '/builds/slave/test', 11:20:23 INFO - 'SHELL': '/bin/bash', 11:20:23 INFO - 'SHLVL': '1', 11:20:23 INFO - 'TERM': 'linux', 11:20:23 INFO - 'TMOUT': '86400', 11:20:23 INFO - 'USER': 'cltbld', 11:20:23 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:23 INFO - '_': '/tools/buildbot/bin/python'} 11:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:20:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:20:25 INFO - Installing collected packages: mozsystemmonitor 11:20:25 INFO - Running setup.py install for mozsystemmonitor 11:20:25 INFO - Successfully installed mozsystemmonitor 11:20:25 INFO - Cleaning up... 11:20:25 INFO - Return code: 0 11:20:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:25 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:20:25 INFO - Using env: {'DISPLAY': ':0', 11:20:25 INFO - 'HOME': '/home/cltbld', 11:20:25 INFO - 'LANG': 'en_US.UTF-8', 11:20:25 INFO - 'LANGUAGE': 'en_US:en', 11:20:25 INFO - 'LOGNAME': 'cltbld', 11:20:25 INFO - 'MAIL': '/var/mail/cltbld', 11:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:25 INFO - 'MOZ_NO_REMOTE': '1', 11:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:25 INFO - 'NO_EM_RESTART': '1', 11:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:25 INFO - 'PWD': '/builds/slave/test', 11:20:25 INFO - 'SHELL': '/bin/bash', 11:20:25 INFO - 'SHLVL': '1', 11:20:25 INFO - 'TERM': 'linux', 11:20:25 INFO - 'TMOUT': '86400', 11:20:25 INFO - 'USER': 'cltbld', 11:20:25 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:25 INFO - '_': '/tools/buildbot/bin/python'} 11:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:25 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:27 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:28 INFO - Downloading docopt-0.6.1.tar.gz 11:20:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:28 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:28 INFO - Running setup.py install for blobuploader 11:20:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:28 INFO - Running setup.py install for requests 11:20:28 INFO - Running setup.py install for docopt 11:20:28 INFO - Successfully installed blobuploader requests docopt 11:20:28 INFO - Cleaning up... 11:20:28 INFO - Return code: 0 11:20:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:28 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:28 INFO - Using env: {'DISPLAY': ':0', 11:20:28 INFO - 'HOME': '/home/cltbld', 11:20:28 INFO - 'LANG': 'en_US.UTF-8', 11:20:28 INFO - 'LANGUAGE': 'en_US:en', 11:20:28 INFO - 'LOGNAME': 'cltbld', 11:20:28 INFO - 'MAIL': '/var/mail/cltbld', 11:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:28 INFO - 'MOZ_NO_REMOTE': '1', 11:20:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:28 INFO - 'NO_EM_RESTART': '1', 11:20:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:28 INFO - 'PWD': '/builds/slave/test', 11:20:28 INFO - 'SHELL': '/bin/bash', 11:20:28 INFO - 'SHLVL': '1', 11:20:28 INFO - 'TERM': 'linux', 11:20:28 INFO - 'TMOUT': '86400', 11:20:28 INFO - 'USER': 'cltbld', 11:20:28 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:28 INFO - '_': '/tools/buildbot/bin/python'} 11:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:28 INFO - Running setup.py (path:/tmp/pip-5FqPEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:28 INFO - Running setup.py (path:/tmp/pip-PnbFYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:29 INFO - Running setup.py (path:/tmp/pip-jdCL_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:29 INFO - Running setup.py (path:/tmp/pip-73tJur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:29 INFO - Running setup.py (path:/tmp/pip-ZaaPNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:29 INFO - Running setup.py (path:/tmp/pip-4wWGuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:29 INFO - Running setup.py (path:/tmp/pip-ktaOSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:29 INFO - Running setup.py (path:/tmp/pip-jApV6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:29 INFO - Running setup.py (path:/tmp/pip-iOMhvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:29 INFO - Running setup.py (path:/tmp/pip-a8GsmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:29 INFO - Running setup.py (path:/tmp/pip-oSqvle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:29 INFO - Running setup.py (path:/tmp/pip-RN3ugG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:29 INFO - Running setup.py (path:/tmp/pip-cgfUVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:29 INFO - Running setup.py (path:/tmp/pip-97lysx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:29 INFO - Running setup.py (path:/tmp/pip-KkukkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:29 INFO - Running setup.py (path:/tmp/pip-ek85xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:30 INFO - Running setup.py (path:/tmp/pip-DsDKjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:30 INFO - Running setup.py install for manifestparser 11:20:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Running setup.py install for mozcrash 11:20:30 INFO - Running setup.py install for mozdebug 11:20:30 INFO - Running setup.py install for mozdevice 11:20:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Running setup.py install for mozfile 11:20:30 INFO - Running setup.py install for mozhttpd 11:20:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Running setup.py install for mozinfo 11:20:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Running setup.py install for mozInstall 11:20:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:30 INFO - Running setup.py install for mozleak 11:20:31 INFO - Running setup.py install for mozlog 11:20:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:31 INFO - Running setup.py install for moznetwork 11:20:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:31 INFO - Running setup.py install for mozprocess 11:20:31 INFO - Running setup.py install for mozprofile 11:20:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:31 INFO - Running setup.py install for mozrunner 11:20:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:31 INFO - Running setup.py install for mozscreenshot 11:20:31 INFO - Running setup.py install for moztest 11:20:31 INFO - Running setup.py install for mozversion 11:20:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:31 INFO - Cleaning up... 11:20:31 INFO - Return code: 0 11:20:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:31 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:31 INFO - Using env: {'DISPLAY': ':0', 11:20:31 INFO - 'HOME': '/home/cltbld', 11:20:31 INFO - 'LANG': 'en_US.UTF-8', 11:20:31 INFO - 'LANGUAGE': 'en_US:en', 11:20:31 INFO - 'LOGNAME': 'cltbld', 11:20:31 INFO - 'MAIL': '/var/mail/cltbld', 11:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:31 INFO - 'MOZ_NO_REMOTE': '1', 11:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:31 INFO - 'NO_EM_RESTART': '1', 11:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:31 INFO - 'PWD': '/builds/slave/test', 11:20:31 INFO - 'SHELL': '/bin/bash', 11:20:31 INFO - 'SHLVL': '1', 11:20:31 INFO - 'TERM': 'linux', 11:20:31 INFO - 'TMOUT': '86400', 11:20:31 INFO - 'USER': 'cltbld', 11:20:31 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:31 INFO - '_': '/tools/buildbot/bin/python'} 11:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:32 INFO - Running setup.py (path:/tmp/pip-M3CkrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:32 INFO - Running setup.py (path:/tmp/pip-jmd65f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:32 INFO - Running setup.py (path:/tmp/pip-llxt2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:32 INFO - Running setup.py (path:/tmp/pip-5C_8km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:32 INFO - Running setup.py (path:/tmp/pip-_6v0mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:32 INFO - Running setup.py (path:/tmp/pip-FEZtVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:32 INFO - Running setup.py (path:/tmp/pip-ZOTpS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:32 INFO - Running setup.py (path:/tmp/pip-_tYbLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:32 INFO - Running setup.py (path:/tmp/pip-cwBR4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:32 INFO - Running setup.py (path:/tmp/pip-MzQMxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:32 INFO - Running setup.py (path:/tmp/pip-0gebTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:32 INFO - Running setup.py (path:/tmp/pip-9Zvekr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:32 INFO - Running setup.py (path:/tmp/pip-HTJOWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:33 INFO - Running setup.py (path:/tmp/pip-pVQw4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:33 INFO - Running setup.py (path:/tmp/pip-zNcIKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:33 INFO - Running setup.py (path:/tmp/pip-3T5IMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:33 INFO - Running setup.py (path:/tmp/pip-37fhI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:20:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:34 INFO - Downloading blessings-1.5.1.tar.gz 11:20:34 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:20:35 INFO - Installing collected packages: blessings 11:20:35 INFO - Running setup.py install for blessings 11:20:35 INFO - Successfully installed blessings 11:20:35 INFO - Cleaning up... 11:20:35 INFO - Return code: 0 11:20:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:35 INFO - Reading from file tmpfile_stdout 11:20:35 INFO - Current package versions: 11:20:35 INFO - argparse == 1.2.1 11:20:35 INFO - blessings == 1.5.1 11:20:35 INFO - blobuploader == 1.2.4 11:20:35 INFO - docopt == 0.6.1 11:20:35 INFO - manifestparser == 1.1 11:20:35 INFO - mozInstall == 1.12 11:20:35 INFO - mozcrash == 0.16 11:20:35 INFO - mozdebug == 0.1 11:20:35 INFO - mozdevice == 0.47 11:20:35 INFO - mozfile == 1.2 11:20:35 INFO - mozhttpd == 0.7 11:20:35 INFO - mozinfo == 0.9 11:20:35 INFO - mozleak == 0.1 11:20:35 INFO - mozlog == 3.1 11:20:35 INFO - moznetwork == 0.27 11:20:35 INFO - mozprocess == 0.22 11:20:35 INFO - mozprofile == 0.27 11:20:35 INFO - mozrunner == 6.11 11:20:35 INFO - mozscreenshot == 0.1 11:20:35 INFO - mozsystemmonitor == 0.0 11:20:35 INFO - moztest == 0.7 11:20:35 INFO - mozversion == 1.4 11:20:35 INFO - psutil == 3.1.1 11:20:35 INFO - requests == 1.2.3 11:20:35 INFO - wsgiref == 0.1.2 11:20:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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')]} 11:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:35 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:35 INFO - Using env: {'DISPLAY': ':0', 11:20:35 INFO - 'HOME': '/home/cltbld', 11:20:35 INFO - 'LANG': 'en_US.UTF-8', 11:20:35 INFO - 'LANGUAGE': 'en_US:en', 11:20:35 INFO - 'LOGNAME': 'cltbld', 11:20:35 INFO - 'MAIL': '/var/mail/cltbld', 11:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:35 INFO - 'MOZ_NO_REMOTE': '1', 11:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:35 INFO - 'NO_EM_RESTART': '1', 11:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:35 INFO - 'PWD': '/builds/slave/test', 11:20:35 INFO - 'SHELL': '/bin/bash', 11:20:35 INFO - 'SHLVL': '1', 11:20:35 INFO - 'TERM': 'linux', 11:20:35 INFO - 'TMOUT': '86400', 11:20:35 INFO - 'USER': 'cltbld', 11:20:35 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:35 INFO - '_': '/tools/buildbot/bin/python'} 11:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:20:35 INFO - Cleaning up... 11:20:35 INFO - Return code: 0 11:20:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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')]} 11:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:35 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:20:35 INFO - Using env: {'DISPLAY': ':0', 11:20:35 INFO - 'HOME': '/home/cltbld', 11:20:35 INFO - 'LANG': 'en_US.UTF-8', 11:20:35 INFO - 'LANGUAGE': 'en_US:en', 11:20:35 INFO - 'LOGNAME': 'cltbld', 11:20:35 INFO - 'MAIL': '/var/mail/cltbld', 11:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:35 INFO - 'MOZ_NO_REMOTE': '1', 11:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:35 INFO - 'NO_EM_RESTART': '1', 11:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:35 INFO - 'PWD': '/builds/slave/test', 11:20:35 INFO - 'SHELL': '/bin/bash', 11:20:35 INFO - 'SHLVL': '1', 11:20:35 INFO - 'TERM': 'linux', 11:20:35 INFO - 'TMOUT': '86400', 11:20:35 INFO - 'USER': 'cltbld', 11:20:35 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:35 INFO - '_': '/tools/buildbot/bin/python'} 11:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:35 INFO - Downloading/unpacking jsonschema 11:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:20:37 INFO - Downloading/unpacking functools32 (from jsonschema) 11:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:37 INFO - warning: no files found matching '*.txt' 11:20:37 INFO - no previously-included directories found matching 'build' 11:20:37 INFO - no previously-included directories found matching 'dist' 11:20:37 INFO - no previously-included directories found matching '.git*' 11:20:37 INFO - Installing collected packages: jsonschema, functools32 11:20:37 INFO - Running setup.py install for functools32 11:20:37 INFO - warning: no files found matching '*.txt' 11:20:37 INFO - no previously-included directories found matching 'build' 11:20:37 INFO - no previously-included directories found matching 'dist' 11:20:37 INFO - no previously-included directories found matching '.git*' 11:20:37 INFO - Successfully installed jsonschema functools32 11:20:37 INFO - Cleaning up... 11:20:38 INFO - Return code: 0 11:20:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:38 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 0x7ffddbadaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2920240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, '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': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:20:38 INFO - Using env: {'DISPLAY': ':0', 11:20:38 INFO - 'HOME': '/home/cltbld', 11:20:38 INFO - 'LANG': 'en_US.UTF-8', 11:20:38 INFO - 'LANGUAGE': 'en_US:en', 11:20:38 INFO - 'LOGNAME': 'cltbld', 11:20:38 INFO - 'MAIL': '/var/mail/cltbld', 11:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:38 INFO - 'MOZ_NO_REMOTE': '1', 11:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:38 INFO - 'NO_EM_RESTART': '1', 11:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:38 INFO - 'PWD': '/builds/slave/test', 11:20:38 INFO - 'SHELL': '/bin/bash', 11:20:38 INFO - 'SHLVL': '1', 11:20:38 INFO - 'TERM': 'linux', 11:20:38 INFO - 'TMOUT': '86400', 11:20:38 INFO - 'USER': 'cltbld', 11:20:38 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:38 INFO - '_': '/tools/buildbot/bin/python'} 11:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:38 INFO - Downloading/unpacking flake8 11:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:20:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 11:20:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:20:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:20:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 11:20:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:20:40 INFO - no previously-included directories found matching 'docs/_build' 11:20:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:20:40 INFO - Running setup.py install for pep8 11:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:20:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:20:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:20:40 INFO - no previously-included directories found matching 'docs/_build' 11:20:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:20:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:20:40 INFO - Cleaning up... 11:20:40 INFO - Return code: 0 11:20:40 INFO - Running post-action listener: _resource_record_post_action 11:20:40 INFO - Running post-action listener: _start_resource_monitoring 11:20:40 INFO - Starting resource monitoring. 11:20:40 INFO - ##### 11:20:40 INFO - ##### Running install step. 11:20:40 INFO - ##### 11:20:40 INFO - Running pre-action listener: _resource_record_pre_action 11:20:40 INFO - Running main action method: install 11:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:41 INFO - Reading from file tmpfile_stdout 11:20:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:20:41 INFO - Reading from file tmpfile_stdout 11:20:41 INFO - Output received: 11:20:41 INFO - Usage: mozinstall [options] installer 11:20:41 INFO - Options: 11:20:41 INFO - -h, --help show this help message and exit 11:20:41 INFO - -d DEST, --destination=DEST 11:20:41 INFO - Directory to install application into. [default: 11:20:41 INFO - "/builds/slave/test"] 11:20:41 INFO - --app=APP Application being installed. [default: firefox] 11:20:41 INFO - mkdir: /builds/slave/test/build/application 11:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:20:55 INFO - Reading from file tmpfile_stdout 11:20:55 INFO - Output received: 11:20:55 INFO - /builds/slave/test/build/application/firefox/firefox 11:20:55 INFO - Running post-action listener: _resource_record_post_action 11:20:55 INFO - ##### 11:20:55 INFO - ##### Running run-tests step. 11:20:55 INFO - ##### 11:20:55 INFO - Running pre-action listener: _resource_record_pre_action 11:20:55 INFO - Running main action method: run_tests 11:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:20:55 INFO - Python 2.7.3 11:20:55 INFO - Return code: 0 11:20:55 INFO - grabbing minidump binary from tooltool 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:55 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 0x29af0b0>, '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 0x29affb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:20:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:20:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:20:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:20:55 INFO - Return code: 0 11:20:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:20:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:20:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:20:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:20:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:20:56 INFO - Return code: 0 11:20:56 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/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test/build 11:20:56 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/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 11:20:56 INFO - Using env: {'DISPLAY': ':0', 11:20:56 INFO - 'HOME': '/home/cltbld', 11:20:56 INFO - 'LANG': 'en_US.UTF-8', 11:20:56 INFO - 'LANGUAGE': 'en_US:en', 11:20:56 INFO - 'LOGNAME': 'cltbld', 11:20:56 INFO - 'MAIL': '/var/mail/cltbld', 11:20:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:20:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:56 INFO - 'MOZ_NO_REMOTE': '1', 11:20:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:56 INFO - 'NO_EM_RESTART': '1', 11:20:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:56 INFO - 'PWD': '/builds/slave/test', 11:20:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:20:56 INFO - 'SHELL': '/bin/bash', 11:20:56 INFO - 'SHLVL': '1', 11:20:56 INFO - 'TERM': 'linux', 11:20:56 INFO - 'TMOUT': '86400', 11:20:56 INFO - 'USER': 'cltbld', 11:20:56 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449688434.706664-653697100', 11:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:56 INFO - '_': '/tools/buildbot/bin/python'} 11:20:56 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/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 11:20:56 INFO - mozversion INFO | application_buildid: 20151209104438 11:20:56 INFO - mozversion INFO | application_changeset: 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 11:20:56 INFO - mozversion INFO | application_display_name: Nightly 11:20:56 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:20:56 INFO - mozversion INFO | application_name: Firefox 11:20:56 INFO - mozversion INFO | application_remotingname: firefox 11:20:56 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:20:56 INFO - mozversion INFO | application_vendor: Mozilla 11:20:56 INFO - mozversion INFO | application_version: 45.0a1 11:20:56 INFO - mozversion INFO | platform_buildid: 20151209104438 11:20:56 INFO - mozversion INFO | platform_changeset: 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 11:20:56 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:20:56 INFO - mozversion INFO | platform_version: 45.0a1 11:20:56 INFO - 2015-12-09 11:20:56,835 DEBUG : using testdate: 1449688856 11:20:56 INFO - 2015-12-09 11:20:56,835 DEBUG : actual date: 1449688856 11:20:56 INFO - 2015-12-09 11:20:56,844 INFO : starting webserver on 'localhost:41965' 11:20:56 INFO - 2015-12-09 11:20:56,845 INFO : Starting test suite talos-linux64-ix-002.e 11:20:56 INFO - 2015-12-09 11:20:56,845 INFO : Starting test dromaeo_css 11:20:56 INFO - 2015-12-09 11:20:56,846 DEBUG : operating with platform_type : linux_ 11:20:56 INFO - 2015-12-09 11:20:56,846 INFO : Initialising browser for dromaeo_css test... 11:20:56 INFO - 2015-12-09 11:20:56,863 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjtG5aS/profile http://localhost:41965/getInfo.html 11:21:01 INFO - 2015-12-09 11:21:01,394 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:21:01 INFO - 2015-12-09 11:21:01,395 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:21:01 INFO - 2015-12-09 11:21:01,395 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:21:01 INFO - 2015-12-09 11:21:01,395 DEBUG : BROWSER_OUTPUT: __metrics 11:21:01 INFO - 2015-12-09 11:21:01,536 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:21:02 INFO - 2015-12-09 11:21:02,439 INFO : Browser initialized. 11:21:02 INFO - 2015-12-09 11:21:02,440 INFO : Running cycle 1/1 for dromaeo_css test... 11:21:02 INFO - 2015-12-09 11:21:02,440 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjtG5aS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:21:14 INFO - 2015-12-09 11:21:14,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 143142912 11:21:14 INFO - 2015-12-09 11:21:14,418 DEBUG : BROWSER_OUTPUT: 11:22:04 INFO - 2015-12-09 11:22:04,073 DEBUG : BROWSER_OUTPUT: 1449688924069 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:24:15 INFO - 2015-12-09 11:24:15,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41965/tests/dromaeo/cssquery-ext.html) 11:24:17 INFO - 2015-12-09 11:24:17,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 147566592 11:24:17 INFO - 2015-12-09 11:24:17,035 DEBUG : BROWSER_OUTPUT: 11:27:19 INFO - 2015-12-09 11:27:19,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/dromaeo/cssquery-ext.html (next: http://localhost:41965/tests/dromaeo/cssquery-jquery.html) 11:27:19 INFO - 2015-12-09 11:27:19,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 144035840 11:27:19 INFO - 2015-12-09 11:27:19,712 DEBUG : BROWSER_OUTPUT: 11:30:21 INFO - 2015-12-09 11:30:21,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41965/tests/dromaeo/cssquery-mootools.html) 11:30:22 INFO - 2015-12-09 11:30:22,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 146321408 11:30:22 INFO - 2015-12-09 11:30:22,087 DEBUG : BROWSER_OUTPUT: 11:33:23 INFO - 2015-12-09 11:33:23,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41965/tests/dromaeo/cssquery-prototype.html) 11:33:24 INFO - 2015-12-09 11:33:24,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 144723968 11:33:24 INFO - 2015-12-09 11:33:24,461 DEBUG : BROWSER_OUTPUT: 11:36:27 INFO - 2015-12-09 11:36:27,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41965/tests/dromaeo/cssquery-yui.html) 11:36:27 INFO - 2015-12-09 11:36:27,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 145289216 11:36:27 INFO - 2015-12-09 11:36:27,675 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/dromaeo/cssquery-yui.html (next: http://localhost:41965/tests/dromaeo/cssquery-dojo.html) 11:39:30 INFO - 2015-12-09 11:39:30,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 148004864 11:39:30 INFO - 2015-12-09 11:39:30,302 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,302 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:39:30 INFO - 2015-12-09 11:39:30,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:39:30 INFO - 2015-12-09 11:39:30,303 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:39:30 INFO - 2015-12-09 11:39:30,303 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:39:30 INFO - 2015-12-09 11:39:30,303 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2659.056035107537;2711.4170453352526;2736.2612094734422;2746.5468197747373;2757.944841103177;4485.708428952116;4685.953140468594;4742.407199100113;4749.620030397568;4780.282957556364;4572.5884670379655;4647.86056418308;4677.766111694419;4696.929546056812;4705.694129881564;4285.678574106947;4363.847265345697;4409.118176364724;4420.160169567788;4459.732416055047;4290.399344091829;4328.7402755834755;4431.0251744616135;4452.710573812708;4518.254488009475;4132.607402296807;4222.451081359434;4232.513260974996;4401.009772801126;4449.021215332622;4272.444582204324;4338.197433474786;4355.80398882051;4375.278079116942;4384.890377740582;4356.8257269709175;4365.323374876899;4382.758948257876;4393.143337049277;4429.800658970322;4415.094905544356;4568.862934111982;4575.6568257380495;4646.326282689025;4708.952910470885;4902.901941961177;4971.701697898137;4973.353464049686;4981.501849815026;5014.373203349582;5065.1642478990925;5120.871978200537;5123.129068058439;5132.563732082777;5180.974095129538;4583.885402864955;4732.550407711262;4733.148033354029;4747.145513807548;4759.976605029935;5116.539511443988;5183.533481986564;5267.815626453055;5268.104422248227;5308.416074231832;4938.111658129207;4957.801687932442;4962.950370496321;4967.751612419437;5009.7495125243595;4855.5387238212315;4937.703737775745;5009.624278179152;5020.146575082244;5037.647364684511;4901.387326584177;4954.752262386866;4960.528749768766;4973.751312434364;5006.148954677714;5013.974930125399;5032.647714660012;5040.193569028937;5050.04049230645;5083.440821509631;4041.0503531670033;4155.833766649361;4157.771322577227;4219.156168766198;4255.702100852911;3670.3209906167444;3685.355062863988;3702.9074273142846;3727.9440808387894;3736.103335199587;4342.782860856944;4349.717268377545;4380.759058251763;4409.206342858316;4410.22821006329;4855.878603034952;4923.77842997066;4968.8757781055765;5057.342545469065;5125.718085505258;4356.825726970886;4361.978190109029;4373.322135069069;4385.210662080856;4416.3596278539435;4498;4522.638188944877;4531.388262584509;4541.318802179633;4571.451425828922;4683.8360657376825;4786.569208771228;4829.95170048295;4902.362692849907;4945.455999840086;5117.130087884994;5135.229715542699;5138.614603904647;5145.382554093533;5190.247414125006;4670.929936050894;4853.247746599282;4863.148948933993;4863.4650188479945;4905.7792399342825;4855.8057677692495;4997.0505603935135;5015.122353588181;5019.924701129559;5020.623453240948;5133.820316288912;5158.432572417106;5167.741612919414;5168.0697474454955;5168.224766285088;4929.13740095489;4979.029089327546;4986.675866068694;4986.750662466789;5001.449840517467;4619.86140415788;4708.81164753406;4716.080364328923;4717.080169366941;4949.57928576075;4786.329913811999;4794.065157294294;4812.903741925212;4863.562279394871;4875.0493653737185;4938.901221975612;4973.701577905337;4983.103041452428;4989.575886049582;5017.172166592617;4668.066386722601;4769.809207631656;4812.0135372247905;4874.968928660204;4926 11:39:30 INFO - 2015-12-09 11:39:30,303 DEBUG : BROWSER_OUTPUT: |1;ext.html;521.4681025354138;530.6709839899263;534.4975722820551;534.9465053494652;537.7150110441465;35498.1125471863;36093.27813443729;36128.819355903215;36165.45751813725;36251.456228156596;39614;40167;40234;40241;40324.39513407294;7840.921590784091;7933.920660793376;8004.839903201932;8014.03831540216;8027.277545020947;7898.249666281694;7970.840583188333;8011.078725946532;8038;8048.154943730911;7918.049834019926;7997.200279972015;8054.798630034266;8055.31529819966;8101.878471822927;7963.283304502594;8018.118007019223;8046.235607617296;8067.193280671944;8070.919290807075;7781.41639377049;7846.293833554951;7878.763637090897;7881.487703299267;7887.329576985963;36805.63194368049;37083.072923176864;37157.25685486302;37217.25565488675;37274.25451490955;2467.9136230231857;2765.653480467026;2910.83990380529;2995.5656429817554;3591.371509985768;27241.591376129374;27280.727192728016;27341.726582734118;27499.587506187425;28319.858400707864;3399.6430374810534;3445.207602251471;3466.133466633342;3508.2632647144133;3525.083478295636;174281;174892.12553937276;174926;175066;175174.12412937853;38817.22365552673;39161.41257881134;51942;52243.47756522386;52277.7386113067;39650.40524392136;39707.80146099251;39718.20563588712;39912;39964;13397.93301033508;13607.591772246848;13617;13682;13707.246101464516;9763.170130538983;9886.30795844284;9904.257180711475;9906.60373585063;9920.007999200023;13461.798073028913;13492.527761528496;13550.796738048937;13562.86437135616;13576.321183940961;5426.449568702704;5506.1190209566275;5588.720563971867;5612.803551875665;5653.773849045992;869.4088020146361;912.9497877616794;926.9490178040138;1026.5637104230673;1029.891861354562;26311.47377052448;26650.46699066008;27271.181864544094;27282.863585681946;27388.178354649393;944.1125342178331;994.6866736977829;995.2386424385351;998.0817647764075;1042.4996001919121;13760.793588096187;14148.64628384278;14180.870977646186;14341.713165736626;14407.78388324176;259156;264033;264207;264963;265771;45873.54126458759;46467.30299045517;46519.767401162775;46736.532634673895;46741.5325846744;1211.6789050901518;1212.4362171590076;1224.3633310678576;1226.9815952760716;1236.7526494701276;25926.740732593185;26471.867640662444;26518.867405662848;26726.331841704112;26855.86572067127;41381.58618413777;41518.792406038985;41701.79149104235;41947;41970;258610;260932;261550;262626;262815;30205;42741.57258427376;42812;43370.78314608407;43868.78065609652;38991.6100838988;38994.02514937149;39035.804820976846;39511;40005.1998960025;33427.665723342456;33513.832430838665;34102.65897340995;34469.31061378808;37805.62194378021;33533.16167095842;33670.32659346848;33831.3233735319;34064.31871362608;34414.31171376609;33486.66513334835;34112.14719632029;34253.14367140841;34394.484082739276;34424.31151377009;30502.38995220039;30955.845220773754;31361.529577055906;31383.529247060855;31406.52890206603;24119.51760964806;24169.879150604134;24488.75511244865;24580.262592122264;24658.63012054785 11:39:30 INFO - 2015-12-09 11:39:30,303 DEBUG : BROWSER_OUTPUT: |2;jquery.html;271.90619236363455;272.43877612119036;275.6113879430002;278.1557971556327;278.4848031142386;12994.675133121676;13378.866211337883;16109.436169734061;16619.66760664786;16703.16484175791;9478.431294122358;9724.805503889918;9732.124108830203;14401.92799036006;15826.920865395658;4376.299792033284;4473.9776301118445;4487.439070116236;4495.505494395614;4497.392851964992;4416.315471101968;4804.879878003043;4913.459519452876;4930.161872481687;4930.876728081791;4814.8314808981695;4832.081904438145;4848.321235027099;4849.854504364875;4853.757312134397;4928.507149285078;4951.108800415924;4961;4964.578010869044;4979.751012449381;4552.795124219418;4679.508651591568;4693.108309421199;4811.374521312242;4812.759362031919;10814.567417303298;10939.45302734868;11009.83485247722;14560.927195364062;17402.738958915626;1752.4217008387202;1776.1740790532465;1823.3527097880326;1851.6296740651924;1867.0384751852807;8251.83496330076;8386.035605905337;8513.233808957224;11929.522819087226;12421.033811434676;1735.6788994036144;1769.7876254849373;1796.2725096336005;1803.2696757813108;1804.2151664026192;56405;57867.71066144684;58064.70967645177;58093.41906580923;58259.41740582624;9309.348345615741;9384.671536496326;9665.371750836313;9705.611775529042;9763.463009534402;11849.585264515701;11872.22830516031;11880.940595297141;11895.643130706092;11944.163908526494;7078.681459334342;7114.395276401564;7166;7191.64041797908;7203.89194162088;6909.723611055602;6950.79147625572;7017.333353331425;7052.506324557232;7069.434445244368;3929.155231625214;3986.7807270599815;4032.3749818778138;4052.8986775330854;4071.592840715964;1713.083500327319;1713.5801728576578;1726.0851748573277;1727.3781438682065;1734.3149455964824;881.678187461572;886.7916039730658;888.9599968001455;911.5305617606938;912.5163663258484;15941.760873586905;15957.20213989296;15988.76016859748;16279.430219942245;16486.917565412336;827.71443851871;847.9915200847912;854.457419538585;860.767592749954;924.426855349674;6661;9251.768705782275;9322.20761235289;9366.250699944125;9479.957204707476;482081;499165;499634;501788;503504;69516;70557;73105;73295.63352183205;73366.26633733702;983.5721461164273;993.1310103659298;996.0637001218976;1003.3327836988467;1037.071820720451;14405.711885762017;14427.567172984827;14599.774240548255;14604.561863144123;14674.192919389108;33527.329453410304;33741.83129084339;33951.4907276396;34428.82785586056;34858.825705871306;42890.38249787113;43350;44943.32585011162;46223.30665040094;47913.76043119762;8762.649494020168;8813.91186088131;8824.808650832056;8968.86546701787;8983.910160898307;15365.769513457084;15573.688526229185;15790.76313855316;15815.051096934221;16738.246778894736;13001.739965200453;13097.934510327388;13285.269310188032;13612.251326177155;13959.511417100353;13079.7430800428;13458;13599.252041137437;14169.291535423394;14279.785803213168;14410.639734006734;14417.711645766816;14514.419423222953;14878.330475128429;14913.105213687213;8710.128987101492;8852.822943541221;8911.688090916787;8952;8968.10318968098;10807;13824.792628110788;13956.162630242217;14024.509142179975;14532.927335363678 11:39:30 INFO - 2015-12-09 11:39:30,304 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1444.2850788859516;1587.1746691720305;1667.7748503951964;1680.0759582229778;1686.9325226990918;5754.798582049629;5837.24115864937;6722.630255335955;6897.172339319282;6930.6188159651265;6472.158619379486;6610.471162307016;6624.768133115342;6642.867142657144;6681.565698229611;2023.5447024419461;2043.1827269092332;2072.9067191976324;2076.3874656976227;2076.7923207679264;2031.1875249900083;2064.1846470644086;2069.2964392106683;2077.1483691686412;2089.4880754215164;1986.7417235759403;2033.074950897338;2034.847386446015;2049.28275103714;2050.1082029317295;2031.6952457131401;2046.467918341242;2049.0062319774897;2060.1656329186703;2063.319104695447;1991.75103112111;2017.8587498875086;2057.331367305632;2058.3310424112224;2065.1842522203797;6736.8989465158065;6762.594244345306;6772.2211945625895;6813.693383797741;6842.110525631636;4060.1067765091634;4118.6499147572495;4120.381942708587;4120.835166593332;4133.0700592366775;2689.717579654128;2711.769499592517;2715.2397328747984;2801.7618502427317;2809.073005908066;826.0912995704737;832.8375966686438;840.1388576708861;863.5595846118462;873.8470767615642;9018.909810901872;9097.545122743903;9111.407758495743;9116.4074335168;9127.087291270886;3734.589195188527;3742.719296052807;3788.299164654548;3808.3716186829415;3826.9617303826603;7976.122626511079;7985.960070199611;8022.719204827803;8048.5170889746805;8065.838683226302;4193.454850869368;4231.576842315744;4253.340732186516;4253.97873010633;4265;3154.810711357326;3227.8224697641854;3638.7816730996224;3809.8857034289017;3842.077901303667;3292.654271301527;3316.535685004101;3338.8998330050135;3346.5147553604593;3364.9327013460083;1051.0803047333584;1068.7808999155154;1069.2568664777905;1073.457903758597;1082.7401423658266;960.577345967786;1007.8992100789862;1163.2555164694602;1168.7720894425506;1187.9783386287786;6637.86724265512;6684.16447944007;6699.162604674416;6727.394534491919;6788.287229840895;1068.3269540189785;1109.8446217529552;1117.1286396610656;1131.281636161027;1152.0668258710305;5224.138017227191;5285;5381.300430943952;5405.108157154104;5407.864803379868;8127.83744325122;8280.378971577156;8349.33205343571;8356.415050946376;8370.121137280497;8093.473924194908;8100.675972961016;8201.95899020513;8212.507249565046;8288.627011784363;6479.6760161991715;6584.275729669733;6613.371729685576;6617.702203400859;6645.501587380966;6295.307516173126;6316.968415157895;6402.071699603438;6422.743090276336;6433.903491447726;7294;7395.334419902235;7400.111986561647;7410.481266311306;7473.962630186814;7558.9244107558225;7677.30904218623;7681.308682218627;7738.993930788962;7750.224977502205;5023.572996295356;5139.8458046258675;5635.718214089361;5660.066089095253;5737;6078.057901025348;6172.259328880563;6302.779402720883;6304.18045654062;6304.65324407162;5936.109583562327;5956.434138756811;5971.970140149271;5990.550708696952;6185.752569897154;5822.0684690449325;5936.13925980739;5959.970200148971;5968.850778730566;6271.153394291895;6235.563510554218;6268.717907694074;6282.968585157228;6324.3991820776955;6330.335314791881;5896.705164741831;5935.495482883831;5947.405259474018;5960.165576819162;5962.344142144274;5878.3239927407185;5921.17103605487;5947.137665038632;5965.642061476326;5992.221011268507 11:39:30 INFO - 2015-12-09 11:39:30,306 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.6388981811101;255.4533298740694;258.4159798854588;259.8695673818888;262.03570859238005;5553.694546799924;5607.158926161078;5651.011073062213;5664.858378540539;5686.886262274752;5536.141898005805;5571.052921003429;5597.328320601523;5609.859753506154;5613.186088017235;4027.0939038716274;4111.588841115879;4112.239235741397;4116.382542618616;4117.8970525736795;4096.283150448675;4097.672186225095;4104.42538044674;4106.897327566805;4109.630133288004;4086.1010577672864;4086.734362266458;4087.8364865405347;4093.0585965228015;4115.115250221202;4091.2022155679656;4093.5906409358977;4097.569755175693;4099.323611604082;4106.260873042851;3363.697267245935;3435.9312813743586;3437.742169337285;3483.5819701635965;3526.2947410518;5357.357117145929;5365.06111430502;5366.4633536646415;5380.892382152374;5392.272043274186;4725.692829966076;4736.4316282046375;4744.264638980963;4746.738929358884;4750.61995040396;5787.450192231773;5816.1566572846705;5830.82507524775;5840.415958404125;5853.912191317134;3708.258348330318;3819.2170605025904;3822.57951625321;3824.2542704172697;3828.444875493066;6151.815445536641;6222.191115155001;6228.439440450381;6231.2522497300615;6239.344868788802;3850.614938506183;3851.056491159684;3852.8844134676006;3857.7492462989817;3864.2078373933277;3908.120672848643;3909;3912.217556488714;3914.119323152268;3922.686185105185;4516.480604730433;4569.428821397325;4647.34937108805;4656.092062047868;4690.835820746258;5849.795257165979;5861.882762344814;5864.149698293723;5866.501347385435;5881.647101173943;1369.0963963783854;1374.202962281874;1381.6822130909948;1381.8825399840925;1382.9585112446644;892.1435421994828;900.1538553759445;903.8566213739624;915.4324318922311;921.138735282513;5024.949750502521;5053.0399224147295;5060.2156665716875;5069.417017043087;5071.0872043032605;6111.8472038198515;6147.293061297919;6156.5998210116195;6162.537809664203;6168.19813424261;5047.192449208109;5047.671901326402;5050.090983622909;5054.2671312660195;5061.72160531167;3238.3361410910707;3274.1978215337394;3289.227031647561;3321.30252646942;3322.750793690483;5741.8277451675685;5749;5759.1937128802;5760.135979603009;5764.13537969308;6265.530085243625;6310.4636105930595;6315.242170939517;6317.842053948596;6325.114483972247;5557.805476808292;5723.856903577361;5727.7995270166175;5742.885142297214;5743.368229494752;6137.171481849893;6154.169187159676;6154.230721159855;6155.692215389123;6164.537659675632;5990.970045149921;6002.879942401215;6002.969985150046;6008.819735407945;6017;5731.713414329183;5742.655440673573;5748.856278593069;5752.252207213036;5763.596548241583;3777.660010599059;3885.630865067814;3905.7070719696703;3914.197589494204;3943.507061617298;6069.423404776539;6136.570440069152;6149.569530132848;6154.107654390178;6165.445109940127;5887.911681324698;5909.231799866162;5954;5956;5961.463468287701;5921.467067963904;5930.703464826827;5934.169216309634;5938.346781854079;5960.403959604005;5716.742746576331;5759.798407055733;5785.450382213683;5808.419158084327;5815.883682326415;5934.821955341346;5958.285005799332;5982.581219314607;5988.131720900532;6000.159977603052;5788.681622510802;5814.156947242711;5835.8832823342445;5837.708114594338;5843 11:39:30 INFO - 2015-12-09 11:39:30,306 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.3087757854255;668.5687731413235;669.5246375073696;670.5767157565746;734.1997223026902;10861;11082.501287442064;11085.889141108586;11097.056750176225;11124.944375278132;11470.7132321692;11584.42077896104;11623.535058597647;11676.065914726823;11681.59114430995;788.73577351587;798.2097723253995;813.4184058398245;816.7631386897792;821.7247222180577;796.4265728675344;796.9641366138537;802.1537278171527;802.8875957365973;803.1606970715587;831.3640065350012;836.1972506393869;837.1252041616495;843.4939036578065;845.1168528887328;821.9835603287901;832.9541875196862;832.9583520823935;834.2908527751423;836.1638361638362;617.2500411999397;621.6332363905273;621.9564630475868;622.9283632382288;623.0063049436142;12334.75330493394;12494.687632809253;12498.500059997588;12537.74924501505;12581.119321647488;10379.273450858444;10664.733381665443;11095.334279943148;11166.776664466664;11628.418579071098;9303.116203960613;9312.44125352481;9447.952760236223;9549.28380371468;9658.082482164184;3187.4421976154313;3201.4557525220766;3219.388316219911;3261.9184520386943;3267.722243609296;39993.400098998536;40487;40642.79678601588;40676.79661601673;40788.18423631511;9460.43237405744;9657.985911479194;9815.411075335503;10141.985801419947;10310.123639490726;16856.57858553546;16921.661566768842;17132;17185.7422138668;17244.051577163125;6604.471642268703;6695.263521012685;6717.529772915849;6759.188897332253;6787.423069039089;3647.8723244686307;3673.173535954389;3679.632036796299;3728.6830619397656;3759.830807613664;2732.194002769188;2736.53478908586;2748.189284161177;2753.7246275372304;2760.213339198319;461.06634066016585;469.9965573500601;485.35932569009276;485.48538549138027;486.3312944701036;482.8044641919958;525.0129756058585;576.685706290073;609.9908501372483;617.3086143519287;7523.285287897641;7582.696692132253;7761.495502792301;7796.571188584682;7855.567943763148;486.77365025263424;494.5203152941641;585.0376131264047;591.3317950715664;607.3228350389372;3609.8556057757396;3632.6912212461707;3649.908752281161;3723.4414837774007;3755.455458958436;49235.75382123138;49442.25836612382;49913.75043124761;49913.750431248336;49993;39297;39543.80228098841;39552.20895582072;39959.80020099939;39991.80004099961;38164.23671526554;40650.79674601608;40757;40914.749688767406;41405.171896561296;7845.960770196112;7904.762857114296;8179.713710020121;8345.374096942633;8423.957880210804;31824.84087579547;31849.8407507961;32500.187495312806;33277.16807079843;33539.83230083931;36439.27121457503;36665.26669466649;37782.81108594439;40295.3955690659;40777.592224078566;9722;9874.111329980336;10069.496525173858;10130.240231982483;10233.897661023295;11194.720131996764;11279.09767218604;11302.378369189773;11325.603603873826;11383.260088094248;10265.84601230997;10603.469826508797;10666.306690065121;10878.945605271923;10893.400862952614;10716.839247411452;10726.410047447465;10926.890731092588;10946.562137514411;10968.835467467834;9888.406695598287;10002.199824014207;10076.647317343857;10337.84493232587;10349.84475232857;9056.95844977836;9156.771080723036;9168.679096231599;9197.632094716404;9230.492322922304;8655.783605409915;8737.825243495221;8778.429402088845;8940.68707595231;9206.815863682823 11:39:30 INFO - 2015-12-09 11:39:30,306 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:39:30 INFO - 2015-12-09 11:39:30,306 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:39:30 INFO - 2015-12-09 11:39:30,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,314 11:39:30 INFO - 2015-12-09 11:39:30,306 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:39:30 INFO - 2015-12-09 11:39:30,306 DEBUG : BROWSER_OUTPUT: __startTimestamp1449689970295__endTimestamp 11:39:30 INFO - 2015-12-09 11:39:30,307 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,307 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:39:30 INFO - 2015-12-09 11:39:30,307 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:39:30 INFO - 2015-12-09 11:39:30,307 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,307 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4662.76 Median:4780.28 stddev:486.21 (10.2%) stddev-sans-first:461.59 11:39:30 INFO - 2015-12-09 11:39:30,307 DEBUG : BROWSER_OUTPUT: Values: 2659.1 2711.4 2736.3 2746.5 2757.9 4485.7 4686.0 4742.4 4749.6 4780.3 4572.6 4647.9 4677.8 4696.9 4705.7 4285.7 4363.8 4409.1 4420.2 4459.7 4290.4 4328.7 4431.0 4452.7 4518.3 4132.6 4222.5 4232.5 4401.0 4449.0 4272.4 4338.2 4355.8 4375.3 4384.9 4356.8 4365.3 4382.8 4393.1 4429.8 4415.1 4568.9 4575.7 4646.3 4709.0 4902.9 4971.7 4973.4 4981.5 5014.4 5065.2 5120.9 5123.1 5132.6 5181.0 4583.9 4732.6 4733.1 4747.1 4760.0 5116.5 5183.5 5267.8 5268.1 5308.4 4938.1 4957.8 4963.0 4967.8 5009.7 4855.5 4937.7 5009.6 5020.1 5037.6 4901.4 4954.8 4960.5 4973.8 5006.1 5014.0 5032.6 5040.2 5050.0 5083.4 4041.1 4155.8 4157.8 4219.2 4255.7 3670.3 3685.4 3702.9 3727.9 3736.1 4342.8 4349.7 4380.8 4409.2 4410.2 4855.9 4923.8 4968.9 5057.3 5125.7 4356.8 4362.0 4373.3 4385.2 4416.4 4498.0 4522.6 4531.4 4541.3 4571.5 4683.8 4786.6 4830.0 4902.4 4945.5 5117.1 5135.2 5138.6 5145.4 5190.2 4670.9 4853.2 4863.1 4863.5 4905.8 4855.8 4997.1 5015.1 5019.9 5020.6 5133.8 5158.4 5167.7 5168.1 5168.2 4929.1 4979.0 4986.7 4986.8 5001.4 4619.9 4708.8 4716.1 4717.1 4949.6 4786.3 4794.1 4812.9 4863.6 4875.0 4938.9 4973.7 4983.1 4989.6 5017.2 4668.1 4769.8 4812.0 4875.0 4926.0 11:39:30 INFO - 2015-12-09 11:39:30,307 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,308 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39271.50 Median:36147.14 stddev:61722.13 (170.8%) stddev-sans-first:61826.70 11:39:30 INFO - 2015-12-09 11:39:30,309 DEBUG : BROWSER_OUTPUT: Values: 521.5 530.7 534.5 534.9 537.7 35498.1 36093.3 36128.8 36165.5 36251.5 39614.0 40167.0 40234.0 40241.0 40324.4 7840.9 7933.9 8004.8 8014.0 8027.3 7898.2 7970.8 8011.1 8038.0 8048.2 7918.0 7997.2 8054.8 8055.3 8101.9 7963.3 8018.1 8046.2 8067.2 8070.9 7781.4 7846.3 7878.8 7881.5 7887.3 36805.6 37083.1 37157.3 37217.3 37274.3 2467.9 2765.7 2910.8 2995.6 3591.4 27241.6 27280.7 27341.7 27499.6 28319.9 3399.6 3445.2 3466.1 3508.3 3525.1 174281.0 174892.1 174926.0 175066.0 175174.1 38817.2 39161.4 51942.0 52243.5 52277.7 39650.4 39707.8 39718.2 39912.0 39964.0 13397.9 13607.6 13617.0 13682.0 13707.2 9763.2 9886.3 9904.3 9906.6 9920.0 13461.8 13492.5 13550.8 13562.9 13576.3 5426.4 5506.1 5588.7 5612.8 5653.8 869.4 912.9 926.9 1026.6 1029.9 26311.5 26650.5 27271.2 27282.9 27388.2 944.1 994.7 995.2 998.1 1042.5 13760.8 14148.6 14180.9 14341.7 14407.8 259156.0 264033.0 264207.0 264963.0 265771.0 45873.5 46467.3 46519.8 46736.5 46741.5 1211.7 1212.4 1224.4 1227.0 1236.8 25926.7 26471.9 26518.9 26726.3 26855.9 41381.6 41518.8 41701.8 41947.0 41970.0 258610.0 260932.0 261550.0 262626.0 262815.0 30205.0 42741.6 42812.0 43370.8 43868.8 38991.6 38994.0 39035.8 39511.0 40005.2 33427.7 33513.8 34102.7 34469.3 37805.6 33533.2 33670.3 33831.3 34064.3 34414.3 33486.7 34112.1 34253.1 34394.5 34424.3 30502.4 30955.8 31361.5 31383.5 31406.5 24119.5 24169.9 24488.8 24580.3 24658.6 11:39:30 INFO - 2015-12-09 11:39:30,309 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,309 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26554.28 Median:4480.71 stddev:81275.59 (1813.9%) stddev-sans-first:81479.63 11:39:30 INFO - 2015-12-09 11:39:30,309 DEBUG : BROWSER_OUTPUT: Values: 271.9 272.4 275.6 278.2 278.5 12994.7 13378.9 16109.4 16619.7 16703.2 9478.4 9724.8 9732.1 14401.9 15826.9 4376.3 4474.0 4487.4 4495.5 4497.4 4416.3 4804.9 4913.5 4930.2 4930.9 4814.8 4832.1 4848.3 4849.9 4853.8 4928.5 4951.1 4961.0 4964.6 4979.8 4552.8 4679.5 4693.1 4811.4 4812.8 10814.6 10939.5 11009.8 14560.9 17402.7 1752.4 1776.2 1823.4 1851.6 1867.0 8251.8 8386.0 8513.2 11929.5 12421.0 1735.7 1769.8 1796.3 1803.3 1804.2 56405.0 57867.7 58064.7 58093.4 58259.4 9309.3 9384.7 9665.4 9705.6 9763.5 11849.6 11872.2 11880.9 11895.6 11944.2 7078.7 7114.4 7166.0 7191.6 7203.9 6909.7 6950.8 7017.3 7052.5 7069.4 3929.2 3986.8 4032.4 4052.9 4071.6 1713.1 1713.6 1726.1 1727.4 1734.3 881.7 886.8 889.0 911.5 912.5 15941.8 15957.2 15988.8 16279.4 16486.9 827.7 848.0 854.5 860.8 924.4 6661.0 9251.8 9322.2 9366.3 9480.0 482081.0 499165.0 499634.0 501788.0 503504.0 69516.0 70557.0 73105.0 73295.6 73366.3 983.6 993.1 996.1 1003.3 1037.1 14405.7 14427.6 14599.8 14604.6 14674.2 33527.3 33741.8 33951.5 34428.8 34858.8 42890.4 43350.0 44943.3 46223.3 47913.8 8762.6 8813.9 8824.8 8968.9 8983.9 15365.8 15573.7 15790.8 15815.1 16738.2 13001.7 13097.9 13285.3 13612.3 13959.5 13079.7 13458.0 13599.3 14169.3 14279.8 14410.6 14417.7 14514.4 14878.3 14913.1 8710.1 8852.8 8911.7 8952.0 8968.1 10807.0 13824.8 13956.2 14024.5 14532.9 11:39:30 INFO - 2015-12-09 11:39:30,309 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,309 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4807.43 Median:5935.80 stddev:2435.21 (41.0%) stddev-sans-first:2428.92 11:39:30 INFO - 2015-12-09 11:39:30,311 DEBUG : BROWSER_OUTPUT: Values: 1444.3 1587.2 1667.8 1680.1 1686.9 5754.8 5837.2 6722.6 6897.2 6930.6 6472.2 6610.5 6624.8 6642.9 6681.6 2023.5 2043.2 2072.9 2076.4 2076.8 2031.2 2064.2 2069.3 2077.1 2089.5 1986.7 2033.1 2034.8 2049.3 2050.1 2031.7 2046.5 2049.0 2060.2 2063.3 1991.8 2017.9 2057.3 2058.3 2065.2 6736.9 6762.6 6772.2 6813.7 6842.1 4060.1 4118.6 4120.4 4120.8 4133.1 2689.7 2711.8 2715.2 2801.8 2809.1 826.1 832.8 840.1 863.6 873.8 9018.9 9097.5 9111.4 9116.4 9127.1 3734.6 3742.7 3788.3 3808.4 3827.0 7976.1 7986.0 8022.7 8048.5 8065.8 4193.5 4231.6 4253.3 4254.0 4265.0 3154.8 3227.8 3638.8 3809.9 3842.1 3292.7 3316.5 3338.9 3346.5 3364.9 1051.1 1068.8 1069.3 1073.5 1082.7 960.6 1007.9 1163.3 1168.8 1188.0 6637.9 6684.2 6699.2 6727.4 6788.3 1068.3 1109.8 1117.1 1131.3 1152.1 5224.1 5285.0 5381.3 5405.1 5407.9 8127.8 8280.4 8349.3 8356.4 8370.1 8093.5 8100.7 8202.0 8212.5 8288.6 6479.7 6584.3 6613.4 6617.7 6645.5 6295.3 6317.0 6402.1 6422.7 6433.9 7294.0 7395.3 7400.1 7410.5 7474.0 7558.9 7677.3 7681.3 7739.0 7750.2 5023.6 5139.8 5635.7 5660.1 5737.0 6078.1 6172.3 6302.8 6304.2 6304.7 5936.1 5956.4 5972.0 5990.6 6185.8 5822.1 5936.1 5960.0 5968.9 6271.2 6235.6 6268.7 6283.0 6324.4 6330.3 5896.7 5935.5 5947.4 5960.2 5962.3 5878.3 5921.2 5947.1 5965.6 5992.2 11:39:30 INFO - 2015-12-09 11:39:30,311 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,311 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4791.17 Median:5608.51 stddev:1502.77 (26.8%) stddev-sans-first:1467.85 11:39:30 INFO - 2015-12-09 11:39:30,312 DEBUG : BROWSER_OUTPUT: Values: 251.6 255.5 258.4 259.9 262.0 5553.7 5607.2 5651.0 5664.9 5686.9 5536.1 5571.1 5597.3 5609.9 5613.2 4027.1 4111.6 4112.2 4116.4 4117.9 4096.3 4097.7 4104.4 4106.9 4109.6 4086.1 4086.7 4087.8 4093.1 4115.1 4091.2 4093.6 4097.6 4099.3 4106.3 3363.7 3435.9 3437.7 3483.6 3526.3 5357.4 5365.1 5366.5 5380.9 5392.3 4725.7 4736.4 4744.3 4746.7 4750.6 5787.5 5816.2 5830.8 5840.4 5853.9 3708.3 3819.2 3822.6 3824.3 3828.4 6151.8 6222.2 6228.4 6231.3 6239.3 3850.6 3851.1 3852.9 3857.7 3864.2 3908.1 3909.0 3912.2 3914.1 3922.7 4516.5 4569.4 4647.3 4656.1 4690.8 5849.8 5861.9 5864.1 5866.5 5881.6 1369.1 1374.2 1381.7 1381.9 1383.0 892.1 900.2 903.9 915.4 921.1 5024.9 5053.0 5060.2 5069.4 5071.1 6111.8 6147.3 6156.6 6162.5 6168.2 5047.2 5047.7 5050.1 5054.3 5061.7 3238.3 3274.2 3289.2 3321.3 3322.8 5741.8 5749.0 5759.2 5760.1 5764.1 6265.5 6310.5 6315.2 6317.8 6325.1 5557.8 5723.9 5727.8 5742.9 5743.4 6137.2 6154.2 6154.2 6155.7 6164.5 5991.0 6002.9 6003.0 6008.8 6017.0 5731.7 5742.7 5748.9 5752.3 5763.6 3777.7 3885.6 3905.7 3914.2 3943.5 6069.4 6136.6 6149.6 6154.1 6165.4 5887.9 5909.2 5954.0 5956.0 5961.5 5921.5 5930.7 5934.2 5938.3 5960.4 5716.7 5759.8 5785.5 5808.4 5815.9 5934.8 5958.3 5982.6 5988.1 6000.2 5788.7 5814.2 5835.9 5837.7 5843.0 11:39:30 INFO - 2015-12-09 11:39:30,312 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,312 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12134.51 Median:40782.89 stddev:13488.95 (33.1%) stddev-sans-first:13499.26 11:39:30 INFO - 2015-12-09 11:39:30,313 DEBUG : BROWSER_OUTPUT: Values: 658.3 668.6 669.5 670.6 734.2 10861.0 11082.5 11085.9 11097.1 11124.9 11470.7 11584.4 11623.5 11676.1 11681.6 788.7 798.2 813.4 816.8 821.7 796.4 797.0 802.2 802.9 803.2 831.4 836.2 837.1 843.5 845.1 822.0 833.0 833.0 834.3 836.2 617.3 621.6 622.0 622.9 623.0 12334.8 12494.7 12498.5 12537.7 12581.1 10379.3 10664.7 11095.3 11166.8 11628.4 9303.1 9312.4 9448.0 9549.3 9658.1 3187.4 3201.5 3219.4 3261.9 3267.7 39993.4 40487.0 40642.8 40676.8 40788.2 9460.4 9658.0 9815.4 10142.0 10310.1 16856.6 16921.7 17132.0 17185.7 17244.1 6604.5 6695.3 6717.5 6759.2 6787.4 3647.9 3673.2 3679.6 3728.7 3759.8 2732.2 2736.5 2748.2 2753.7 2760.2 461.1 470.0 485.4 485.5 486.3 482.8 525.0 576.7 610.0 617.3 7523.3 7582.7 7761.5 7796.6 7855.6 486.8 494.5 585.0 591.3 607.3 3609.9 3632.7 3649.9 3723.4 3755.5 49235.8 49442.3 49913.8 49913.8 49993.0 39297.0 39543.8 39552.2 39959.8 39991.8 38164.2 40650.8 40757.0 40914.7 41405.2 7846.0 7904.8 8179.7 8345.4 8424.0 31824.8 31849.8 32500.2 33277.2 33539.8 36439.3 36665.3 37782.8 40295.4 40777.6 9722.0 9874.1 10069.5 10130.2 10233.9 11194.7 11279.1 11302.4 11325.6 11383.3 10265.8 10603.5 10666.3 10878.9 10893.4 10716.8 10726.4 10926.9 10946.6 10968.8 9888.4 10002.2 10076.6 10337.8 10349.8 9057.0 9156.8 9168.7 9197.6 9230.5 8655.8 8737.8 8778.4 8940.7 9206.8 11:39:30 INFO - 2015-12-09 11:39:30,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:39:30 INFO - 2015-12-09 11:39:30,314 DEBUG : BROWSER_OUTPUT: 11:39:30 INFO - 2015-12-09 11:39:30,984 INFO : Browser exited with error code: 0 11:39:31 INFO - 2015-12-09 11:39:31,005 INFO : Completed test dromaeo_css (00:18:34) 11:39:31 INFO - 2015-12-09 11:39:31,005 INFO : Starting test kraken 11:39:31 INFO - 2015-12-09 11:39:31,005 DEBUG : operating with platform_type : linux_ 11:39:31 INFO - 2015-12-09 11:39:31,005 INFO : Initialising browser for kraken test... 11:39:31 INFO - 2015-12-09 11:39:31,011 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJT2Q5/profile http://localhost:41965/getInfo.html 11:39:35 INFO - 2015-12-09 11:39:35,672 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:39:35 INFO - 2015-12-09 11:39:35,673 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:39:35 INFO - 2015-12-09 11:39:35,673 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:39:35 INFO - 2015-12-09 11:39:35,673 DEBUG : BROWSER_OUTPUT: __metrics 11:39:35 INFO - 2015-12-09 11:39:35,770 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:39:36 INFO - 2015-12-09 11:39:36,684 INFO : Browser initialized. 11:39:36 INFO - 2015-12-09 11:39:36,684 INFO : Running cycle 1/1 for kraken test... 11:39:36 INFO - 2015-12-09 11:39:36,685 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJT2Q5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:39:48 INFO - 2015-12-09 11:39:48,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 11:39:48 INFO - 2015-12-09 11:39:48,668 DEBUG : BROWSER_OUTPUT: 11:39:51 INFO - 2015-12-09 11:39:51,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41965/tests/kraken/driver.html?testName=audio-beat-detection) 11:39:51 INFO - 2015-12-09 11:39:51,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 144384000 11:39:51 INFO - 2015-12-09 11:39:51,875 DEBUG : BROWSER_OUTPUT: 11:39:54 INFO - 2015-12-09 11:39:54,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41965/tests/kraken/driver.html?testName=audio-dft) 11:39:55 INFO - 2015-12-09 11:39:55,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 144121856 11:39:55 INFO - 2015-12-09 11:39:55,186 DEBUG : BROWSER_OUTPUT: 11:39:58 INFO - 2015-12-09 11:39:58,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41965/tests/kraken/driver.html?testName=audio-fft) 11:39:58 INFO - 2015-12-09 11:39:58,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 138440704 11:39:58 INFO - 2015-12-09 11:39:58,689 DEBUG : BROWSER_OUTPUT: 11:40:00 INFO - 2015-12-09 11:40:00,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41965/tests/kraken/driver.html?testName=audio-oscillator) 11:40:01 INFO - 2015-12-09 11:40:01,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 138784768 11:40:01 INFO - 2015-12-09 11:40:01,398 DEBUG : BROWSER_OUTPUT: 11:40:03 INFO - 2015-12-09 11:40:03,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41965/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:04 INFO - 2015-12-09 11:40:04,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 140320768 11:40:04 INFO - 2015-12-09 11:40:04,274 DEBUG : BROWSER_OUTPUT: 11:40:07 INFO - 2015-12-09 11:40:07,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41965/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:07 INFO - 2015-12-09 11:40:07,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 141279232 11:40:07 INFO - 2015-12-09 11:40:07,914 DEBUG : BROWSER_OUTPUT: 11:40:11 INFO - 2015-12-09 11:40:11,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41965/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:11 INFO - 2015-12-09 11:40:11,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 11:40:11 INFO - 2015-12-09 11:40:11,966 DEBUG : BROWSER_OUTPUT: 11:40:14 INFO - 2015-12-09 11:40:14,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41965/tests/kraken/driver.html?testName=json-parse-financial) 11:40:15 INFO - 2015-12-09 11:40:15,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 139735040 11:40:15 INFO - 2015-12-09 11:40:15,470 DEBUG : BROWSER_OUTPUT: 11:40:17 INFO - 2015-12-09 11:40:17,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41965/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:17 INFO - 2015-12-09 11:40:17,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 140820480 11:40:17 INFO - 2015-12-09 11:40:17,880 DEBUG : BROWSER_OUTPUT: 11:40:19 INFO - 2015-12-09 11:40:19,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:20 INFO - 2015-12-09 11:40:20,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 140115968 11:40:20 INFO - 2015-12-09 11:40:20,369 DEBUG : BROWSER_OUTPUT: 11:40:22 INFO - 2015-12-09 11:40:22,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:23 INFO - 2015-12-09 11:40:23,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 139661312 11:40:23 INFO - 2015-12-09 11:40:23,155 DEBUG : BROWSER_OUTPUT: 11:40:25 INFO - 2015-12-09 11:40:25,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:26 INFO - 2015-12-09 11:40:26,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 140537856 11:40:26 INFO - 2015-12-09 11:40:26,358 DEBUG : BROWSER_OUTPUT: 11:40:28 INFO - 2015-12-09 11:40:28,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:29 INFO - 2015-12-09 11:40:29,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 140337152 11:40:29 INFO - 2015-12-09 11:40:29,588 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41965/tests/kraken/driver.html?testName=ai-astar) 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 140009472 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;110;115;114;115;125;114;114;113;117 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;132;150;172;133;156;151;131;170;133 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |2;audio-dft;166;163;161;162;162;165;167;167;165;162 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;73;76;73;132;72;73;73 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;142;94;96;94;141;94;96;139 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;110;110;111;110 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;147;148;147;146;148;148;147 11:40:31 INFO - 2015-12-09 11:40:31,596 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;99;96;95;97;96;95;95;96 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;74;75;82;78;74;75;78;80 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;71;70;69;69 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;95;90;87;84;84;85;85;86;88 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;134;132;118;124;129;126;130;126;128 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;162;150;149;149;151;148;150;148;140 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;73;70;73;71;69;70;71;70 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,785 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: __startTimestamp1449690031591__endTimestamp 11:40:31 INFO - 2015-12-09 11:40:31,597 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:3.89 (3.4%) stddev-sans-first:4.12 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: Values: 116.0 110.0 115.0 114.0 115.0 125.0 114.0 114.0 113.0 117.0 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.00 stddev:15.56 (10.2%) stddev-sans-first:16.32 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: Values: 155.0 132.0 150.0 172.0 133.0 156.0 151.0 131.0 170.0 133.0 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:165.00 stddev:2.26 (1.4%) stddev-sans-first:2.28 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: Values: 166.0 163.0 161.0 162.0 162.0 165.0 167.0 167.0 165.0 162.0 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:18.69 (25.6%) stddev-sans-first:19.66 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 73.0 76.0 73.0 132.0 72.0 73.0 73.0 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,601 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:22.29 (23.7%) stddev-sans-first:23.03 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 142.0 94.0 96.0 94.0 141.0 94.0 96.0 139.0 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 147.0 148.0 147.0 146.0 148.0 148.0 147.0 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:1.27 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 99.0 96.0 95.0 97.0 96.0 95.0 95.0 96.0 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.50 Median:76.50 stddev:2.84 (3.7%) stddev-sans-first:2.96 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 74.0 75.0 82.0 78.0 74.0 75.0 78.0 80.0 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,602 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 71.0 70.0 69.0 69.0 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.49 (4.0%) stddev-sans-first:3.55 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: Values: 84.0 95.0 90.0 87.0 84.0 84.0 85.0 85.0 86.0 88.0 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.50 stddev:4.67 (3.6%) stddev-sans-first:4.72 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: Values: 123.0 134.0 132.0 118.0 124.0 129.0 126.0 130.0 126.0 128.0 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:149.50 stddev:5.61 (3.8%) stddev-sans-first:5.63 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: Values: 144.0 162.0 150.0 149.0 149.0 151.0 148.0 150.0 148.0 140.0 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.32 (1.9%) stddev-sans-first:1.36 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 73.0 70.0 73.0 71.0 69.0 70.0 71.0 70.0 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:40:31 INFO - 2015-12-09 11:40:31,603 DEBUG : BROWSER_OUTPUT: 11:40:32 INFO - 2015-12-09 11:40:32,512 INFO : Browser exited with error code: 0 11:40:32 INFO - 2015-12-09 11:40:32,562 INFO : Completed test kraken (00:01:01) 11:40:32 INFO - 2015-12-09 11:40:32,562 INFO : Starting test v8_7 11:40:32 INFO - 2015-12-09 11:40:32,562 DEBUG : operating with platform_type : linux_ 11:40:32 INFO - 2015-12-09 11:40:32,562 INFO : Initialising browser for v8_7 test... 11:40:32 INFO - 2015-12-09 11:40:32,569 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5VCiz/profile http://localhost:41965/getInfo.html 11:40:37 INFO - 2015-12-09 11:40:37,231 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:40:37 INFO - 2015-12-09 11:40:37,232 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:40:37 INFO - 2015-12-09 11:40:37,232 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:40:37 INFO - 2015-12-09 11:40:37,232 DEBUG : BROWSER_OUTPUT: __metrics 11:40:37 INFO - 2015-12-09 11:40:37,336 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:40:38 INFO - 2015-12-09 11:40:38,296 INFO : Browser initialized. 11:40:38 INFO - 2015-12-09 11:40:38,296 INFO : Running cycle 1/1 for v8_7 test... 11:40:38 INFO - 2015-12-09 11:40:38,297 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5VCiz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:40:50 INFO - 2015-12-09 11:40:50,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 142909440 11:40:50 INFO - 2015-12-09 11:40:50,271 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41965/tests/v8_7/run.html (next: http://localhost:41965/tests/v8_7/run.html) 11:41:11 INFO - 2015-12-09 11:41:11,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 11:41:11 INFO - 2015-12-09 11:41:11,938 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,939 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:11 INFO - 2015-12-09 11:41:11,939 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:11 INFO - 2015-12-09 11:41:11,939 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:11 INFO - 2015-12-09 11:41:11,939 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:11 INFO - 2015-12-09 11:41:11,939 DEBUG : BROWSER_OUTPUT: |0;Richards;166.91704223001167 11:41:11 INFO - 2015-12-09 11:41:11,940 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.1620626151013 11:41:11 INFO - 2015-12-09 11:41:11,940 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 11:41:11 INFO - 2015-12-09 11:41:11,940 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 11:41:11 INFO - 2015-12-09 11:41:11,940 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1072.961373390558 11:41:11 INFO - 2015-12-09 11:41:11,941 DEBUG : BROWSER_OUTPUT: |5;Earley;700.770847932726 11:41:11 INFO - 2015-12-09 11:41:11,941 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 11:41:11 INFO - 2015-12-09 11:41:11,941 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 11:41:11 INFO - 2015-12-09 11:41:11,943 DEBUG : BROWSER_OUTPUT: |8;Splay;597.3715651135007 11:41:11 INFO - 2015-12-09 11:41:11,943 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:41:11 INFO - 2015-12-09 11:41:11,943 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:11 INFO - 2015-12-09 11:41:11,943 DEBUG : BROWSER_OUTPUT: __startTimestamp1449690071938__endTimestamp 11:41:11 INFO - 2015-12-09 11:41:11,943 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: Values: 166.9 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.16 Median:184.16 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: Values: 184.2 11:41:11 INFO - 2015-12-09 11:41:11,944 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: Values: 278.2 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: Values: 5191.7 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,945 DEBUG : BROWSER_OUTPUT: Values: 1073.0 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:700.77 Median:700.77 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: Values: 700.8 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: Values: 12000.0 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,946 DEBUG : BROWSER_OUTPUT: Values: 26128.2 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.37 Median:597.37 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: Values: 597.4 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:11 INFO - 2015-12-09 11:41:11,947 DEBUG : BROWSER_OUTPUT: 11:41:12 INFO - 2015-12-09 11:41:12,859 INFO : Browser exited with error code: 0 11:41:12 INFO - 2015-12-09 11:41:12,874 INFO : Completed test v8_7 (00:00:40) 11:41:12 INFO - 2015-12-09 11:41:12,937 INFO : Completed test suite (00:20:16) 11:41:12 INFO - 2015-12-09 11:41:12,937 DEBUG : Working with test: dromaeo_css 11:41:12 INFO - 2015-12-09 11:41:12,937 DEBUG : Generating results file: dromaeo_css 11:41:12 INFO - 2015-12-09 11:41:12,938 DEBUG : Working with test: kraken 11:41:12 INFO - 2015-12-09 11:41:12,938 DEBUG : Generating results file: kraken 11:41:12 INFO - 2015-12-09 11:41:12,939 INFO : javascript benchmark 11:41:12 INFO - 2015-12-09 11:41:12,939 DEBUG : Working with test: v8_7 11:41:12 INFO - 2015-12-09 11:41:12,939 DEBUG : Generating results file: v8_7 11:41:12 INFO - 2015-12-09 11:41:12,939 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:41:12 INFO - 2015-12-09 11:41:12,998 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:41:12 INFO - 2015-12-09 11:41:12,998 DEBUG : process_Request line: dromaeo_css 6261.38 graph.html#tests=[[72,132,43]] 11:41:12 INFO - 2015-12-09 11:41:12,998 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:41:13 INFO - 2015-12-09 11:41:13,027 DEBUG : process_Request line: kraken 1547.40 graph.html#tests=[[232,132,43]] 11:41:13 INFO - 2015-12-09 11:41:13,027 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:41:13 INFO - 2015-12-09 11:41:13,057 DEBUG : process_Request line: v8_7 21450.20 graph.html#tests=[[230,132,43]] 11:41:13 INFO - 2015-12-09 11:41:13,058 INFO : javascript benchmark 11:41:13 INFO - 2015-12-09 11:41:13,062 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2659.056035107537, 2711.4170453352526, 2736.2612094734422, 2746.5468197747373, 2757.944841103177, 4485.708428952116, 4685.953140468594, 4742.407199100113, 4749.620030397568, 4780.282957556364, 4572.5884670379655, 4647.86056418308, 4677.766111694419, 4696.929546056812, 4705.694129881564, 4285.678574106947, 4363.847265345697, 4409.118176364724, 4420.160169567788, 4459.732416055047, 4290.399344091829, 4328.7402755834755, 4431.0251744616135, 4452.710573812708, 4518.254488009475, 4132.607402296807, 4222.451081359434, 4232.513260974996, 4401.009772801126, 4449.021215332622, 4272.444582204324, 4338.197433474786, 4355.80398882051, 4375.278079116942, 4384.890377740582, 4356.8257269709175, 4365.323374876899, 4382.758948257876, 4393.143337049277, 4429.800658970322, 4415.094905544356, 4568.862934111982, 4575.6568257380495, 4646.326282689025, 4708.952910470885, 4902.901941961177, 4971.701697898137, 4973.353464049686, 4981.501849815026, 5014.373203349582, 5065.1642478990925, 5120.871978200537, 5123.129068058439, 5132.563732082777, 5180.974095129538, 4583.885402864955, 4732.550407711262, 4733.148033354029, 4747.145513807548, 4759.976605029935, 5116.539511443988, 5183.533481986564, 5267.815626453055, 5268.104422248227, 5308.416074231832, 4938.111658129207, 4957.801687932442, 4962.950370496321, 4967.751612419437, 5009.7495125243595, 4855.5387238212315, 4937.703737775745, 5009.624278179152, 5020.146575082244, 5037.647364684511, 4901.387326584177, 4954.752262386866, 4960.528749768766, 4973.751312434364, 5006.148954677714, 5013.974930125399, 5032.647714660012, 5040.193569028937, 5050.04049230645, 5083.440821509631, 4041.0503531670033, 4155.833766649361, 4157.771322577227, 4219.156168766198, 4255.702100852911, 3670.3209906167444, 3685.355062863988, 3702.9074273142846, 3727.9440808387894, 3736.103335199587, 4342.782860856944, 4349.717268377545, 4380.759058251763, 4409.206342858316, 4410.22821006329, 4855.878603034952, 4923.77842997066, 4968.8757781055765, 5057.342545469065, 5125.718085505258, 4356.825726970886, 4361.978190109029, 4373.322135069069, 4385.210662080856, 4416.3596278539435, 4498.0, 4522.638188944877, 4531.388262584509, 4541.318802179633, 4571.451425828922, 4683.8360657376825, 4786.569208771228, 4829.95170048295, 4902.362692849907, 4945.455999840086, 5117.130087884994, 5135.229715542699, 5138.614603904647, 5145.382554093533, 5190.247414125006, 4670.929936050894, 4853.247746599282, 4863.148948933993, 4863.4650188479945, 4905.7792399342825, 4855.8057677692495, 4997.0505603935135, 5015.122353588181, 5019.924701129559, 5020.623453240948, 5133.820316288912, 5158.432572417106, 5167.741612919414, 5168.0697474454955, 5168.224766285088, 4929.13740095489, 4979.029089327546, 4986.675866068694, 4986.750662466789, 5001.449840517467, 4619.86140415788, 4708.81164753406, 4716.080364328923, 4717.080169366941, 4949.57928576075, 4786.329913811999, 4794.065157294294, 4812.903741925212, 4863.562279394871, 4875.0493653737185, 4938.901221975612, 4973.701577905337, 4983.103041452428, 4989.575886049582, 5017.172166592617, 4668.066386722601, 4769.809207631656, 4812.0135372247905, 4874.968928660204, 4926.0], "unit": "ms", "name": "dojo.html", "value": 4632.806818626177}, {"lowerIsBetter": false, "replicates": [521.4681025354138, 530.6709839899263, 534.4975722820551, 534.9465053494652, 537.7150110441465, 35498.1125471863, 36093.27813443729, 36128.819355903215, 36165.45751813725, 36251.456228156596, 39614.0, 40167.0, 40234.0, 40241.0, 40324.39513407294, 7840.921590784091, 7933.920660793376, 8004.839903201932, 8014.03831540216, 8027.277545020947, 7898.249666281694, 7970.840583188333, 8011.078725946532, 8038.0, 8048.154943730911, 7918.049834019926, 7997.200279972015, 8054.798630034266, 8055.31529819966, 8101.878471822927, 7963.283304502594, 8018.118007019223, 8046.235607617296, 8067.193280671944, 8070.919290807075, 7781.41639377049, 7846.293833554951, 7878.763637090897, 7881.487703299267, 7887.329576985963, 36805.63194368049, 37083.072923176864, 37157.25685486302, 37217.25565488675, 37274.25451490955, 2467.9136230231857, 2765.653480467026, 2910.83990380529, 2995.5656429817554, 3591.371509985768, 27241.591376129374, 27280.727192728016, 27341.726582734118, 27499.587506187425, 28319.858400707864, 3399.6430374810534, 3445.207602251471, 3466.133466633342, 3508.2632647144133, 3525.083478295636, 174281.0, 174892.12553937276, 174926.0, 175066.0, 175174.12412937853, 38817.22365552673, 39161.41257881134, 51942.0, 52243.47756522386, 52277.7386113067, 39650.40524392136, 39707.80146099251, 39718.20563588712, 39912.0, 39964.0, 13397.93301033508, 13607.591772246848, 13617.0, 13682.0, 13707.246101464516, 9763.170130538983, 9886.30795844284, 9904.257180711475, 9906.60373585063, 9920.007999200023, 13461.798073028913, 13492.527761528496, 13550.796738048937, 13562.86437135616, 13576.321183940961, 5426.449568702704, 5506.1190209566275, 5588.720563971867, 5612.803551875665, 5653.773849045992, 869.4088020146361, 912.9497877616794, 926.9490178040138, 1026.5637104230673, 1029.891861354562, 26311.47377052448, 26650.46699066008, 27271.181864544094, 27282.863585681946, 27388.178354649393, 944.1125342178331, 994.6866736977829, 995.2386424385351, 998.0817647764075, 1042.4996001919121, 13760.793588096187, 14148.64628384278, 14180.870977646186, 14341.713165736626, 14407.78388324176, 259156.0, 264033.0, 264207.0, 264963.0, 265771.0, 45873.54126458759, 46467.30299045517, 46519.767401162775, 46736.532634673895, 46741.5325846744, 1211.6789050901518, 1212.4362171590076, 1224.3633310678576, 1226.9815952760716, 1236.7526494701276, 25926.740732593185, 26471.867640662444, 26518.867405662848, 26726.331841704112, 26855.86572067127, 41381.58618413777, 41518.792406038985, 41701.79149104235, 41947.0, 41970.0, 258610.0, 260932.0, 261550.0, 262626.0, 262815.0, 30205.0, 42741.57258427376, 42812.0, 43370.78314608407, 43868.78065609652, 38991.6100838988, 38994.02514937149, 39035.804820976846, 39511.0, 40005.1998960025, 33427.665723342456, 33513.832430838665, 34102.65897340995, 34469.31061378808, 37805.62194378021, 33533.16167095842, 33670.32659346848, 33831.3233735319, 34064.31871362608, 34414.31171376609, 33486.66513334835, 34112.14719632029, 34253.14367140841, 34394.484082739276, 34424.31151377009, 30502.38995220039, 30955.845220773754, 31361.529577055906, 31383.529247060855, 31406.52890206603, 24119.51760964806, 24169.879150604134, 24488.75511244865, 24580.262592122264, 24658.63012054785], "unit": "ms", "name": "ext.html", "value": 16484.80503073971}, {"lowerIsBetter": false, "replicates": [271.90619236363455, 272.43877612119036, 275.6113879430002, 278.1557971556327, 278.4848031142386, 12994.675133121676, 13378.866211337883, 16109.436169734061, 16619.66760664786, 16703.16484175791, 9478.431294122358, 9724.805503889918, 9732.124108830203, 14401.92799036006, 15826.920865395658, 4376.299792033284, 4473.9776301118445, 4487.439070116236, 4495.505494395614, 4497.392851964992, 4416.315471101968, 4804.879878003043, 4913.459519452876, 4930.161872481687, 4930.876728081791, 4814.8314808981695, 4832.081904438145, 4848.321235027099, 4849.854504364875, 4853.757312134397, 4928.507149285078, 4951.108800415924, 4961.0, 4964.578010869044, 4979.751012449381, 4552.795124219418, 4679.508651591568, 4693.108309421199, 4811.374521312242, 4812.759362031919, 10814.567417303298, 10939.45302734868, 11009.83485247722, 14560.927195364062, 17402.738958915626, 1752.4217008387202, 1776.1740790532465, 1823.3527097880326, 1851.6296740651924, 1867.0384751852807, 8251.83496330076, 8386.035605905337, 8513.233808957224, 11929.522819087226, 12421.033811434676, 1735.6788994036144, 1769.7876254849373, 1796.2725096336005, 1803.2696757813108, 1804.2151664026192, 56405.0, 57867.71066144684, 58064.70967645177, 58093.41906580923, 58259.41740582624, 9309.348345615741, 9384.671536496326, 9665.371750836313, 9705.611775529042, 9763.463009534402, 11849.585264515701, 11872.22830516031, 11880.940595297141, 11895.643130706092, 11944.163908526494, 7078.681459334342, 7114.395276401564, 7166.0, 7191.64041797908, 7203.89194162088, 6909.723611055602, 6950.79147625572, 7017.333353331425, 7052.506324557232, 7069.434445244368, 3929.155231625214, 3986.7807270599815, 4032.3749818778138, 4052.8986775330854, 4071.592840715964, 1713.083500327319, 1713.5801728576578, 1726.0851748573277, 1727.3781438682065, 1734.3149455964824, 881.678187461572, 886.7916039730658, 888.9599968001455, 911.5305617606938, 912.5163663258484, 15941.760873586905, 15957.20213989296, 15988.76016859748, 16279.430219942245, 16486.917565412336, 827.71443851871, 847.9915200847912, 854.457419538585, 860.767592749954, 924.426855349674, 6661.0, 9251.768705782275, 9322.20761235289, 9366.250699944125, 9479.957204707476, 482081.0, 499165.0, 499634.0, 501788.0, 503504.0, 69516.0, 70557.0, 73105.0, 73295.63352183205, 73366.26633733702, 983.5721461164273, 993.1310103659298, 996.0637001218976, 1003.3327836988467, 1037.071820720451, 14405.711885762017, 14427.567172984827, 14599.774240548255, 14604.561863144123, 14674.192919389108, 33527.329453410304, 33741.83129084339, 33951.4907276396, 34428.82785586056, 34858.825705871306, 42890.38249787113, 43350.0, 44943.32585011162, 46223.30665040094, 47913.76043119762, 8762.649494020168, 8813.91186088131, 8824.808650832056, 8968.86546701787, 8983.910160898307, 15365.769513457084, 15573.688526229185, 15790.76313855316, 15815.051096934221, 16738.246778894736, 13001.739965200453, 13097.934510327388, 13285.269310188032, 13612.251326177155, 13959.511417100353, 13079.7430800428, 13458.0, 13599.252041137437, 14169.291535423394, 14279.785803213168, 14410.639734006734, 14417.711645766816, 14514.419423222953, 14878.330475128429, 14913.105213687213, 8710.128987101492, 8852.822943541221, 8911.688090916787, 8952.0, 8968.10318968098, 10807.0, 13824.792628110788, 13956.162630242217, 14024.509142179975, 14532.927335363678], "unit": "ms", "name": "jquery.html", "value": 8073.496383738065}, {"lowerIsBetter": false, "replicates": [1444.2850788859516, 1587.1746691720305, 1667.7748503951964, 1680.0759582229778, 1686.9325226990918, 5754.798582049629, 5837.24115864937, 6722.630255335955, 6897.172339319282, 6930.6188159651265, 6472.158619379486, 6610.471162307016, 6624.768133115342, 6642.867142657144, 6681.565698229611, 2023.5447024419461, 2043.1827269092332, 2072.9067191976324, 2076.3874656976227, 2076.7923207679264, 2031.1875249900083, 2064.1846470644086, 2069.2964392106683, 2077.1483691686412, 2089.4880754215164, 1986.7417235759403, 2033.074950897338, 2034.847386446015, 2049.28275103714, 2050.1082029317295, 2031.6952457131401, 2046.467918341242, 2049.0062319774897, 2060.1656329186703, 2063.319104695447, 1991.75103112111, 2017.8587498875086, 2057.331367305632, 2058.3310424112224, 2065.1842522203797, 6736.8989465158065, 6762.594244345306, 6772.2211945625895, 6813.693383797741, 6842.110525631636, 4060.1067765091634, 4118.6499147572495, 4120.381942708587, 4120.835166593332, 4133.0700592366775, 2689.717579654128, 2711.769499592517, 2715.2397328747984, 2801.7618502427317, 2809.073005908066, 826.0912995704737, 832.8375966686438, 840.1388576708861, 863.5595846118462, 873.8470767615642, 9018.909810901872, 9097.545122743903, 9111.407758495743, 9116.4074335168, 9127.087291270886, 3734.589195188527, 3742.719296052807, 3788.299164654548, 3808.3716186829415, 3826.9617303826603, 7976.122626511079, 7985.960070199611, 8022.719204827803, 8048.5170889746805, 8065.838683226302, 4193.454850869368, 4231.576842315744, 4253.340732186516, 4253.97873010633, 4265.0, 3154.810711357326, 3227.8224697641854, 3638.7816730996224, 3809.8857034289017, 3842.077901303667, 3292.654271301527, 3316.535685004101, 3338.8998330050135, 3346.5147553604593, 3364.9327013460083, 1051.0803047333584, 1068.7808999155154, 1069.2568664777905, 1073.457903758597, 1082.7401423658266, 960.577345967786, 1007.8992100789862, 1163.2555164694602, 1168.7720894425506, 1187.9783386287786, 6637.86724265512, 6684.16447944007, 6699.162604674416, 6727.394534491919, 6788.287229840895, 1068.3269540189785, 1109.8446217529552, 1117.1286396610656, 1131.281636161027, 1152.0668258710305, 5224.138017227191, 5285.0, 5381.300430943952, 5405.108157154104, 5407.864803379868, 8127.83744325122, 8280.378971577156, 8349.33205343571, 8356.415050946376, 8370.121137280497, 8093.473924194908, 8100.675972961016, 8201.95899020513, 8212.507249565046, 8288.627011784363, 6479.6760161991715, 6584.275729669733, 6613.371729685576, 6617.702203400859, 6645.501587380966, 6295.307516173126, 6316.968415157895, 6402.071699603438, 6422.743090276336, 6433.903491447726, 7294.0, 7395.334419902235, 7400.111986561647, 7410.481266311306, 7473.962630186814, 7558.9244107558225, 7677.30904218623, 7681.308682218627, 7738.993930788962, 7750.224977502205, 5023.572996295356, 5139.8458046258675, 5635.718214089361, 5660.066089095253, 5737.0, 6078.057901025348, 6172.259328880563, 6302.779402720883, 6304.18045654062, 6304.65324407162, 5936.109583562327, 5956.434138756811, 5971.970140149271, 5990.550708696952, 6185.752569897154, 5822.0684690449325, 5936.13925980739, 5959.970200148971, 5968.850778730566, 6271.153394291895, 6235.563510554218, 6268.717907694074, 6282.968585157228, 6324.3991820776955, 6330.335314791881, 5896.705164741831, 5935.495482883831, 5947.405259474018, 5960.165576819162, 5962.344142144274, 5878.3239927407185, 5921.17103605487, 5947.137665038632, 5965.642061476326, 5992.221011268507], "unit": "ms", "name": "mootools.html", "value": 3995.963670947464}, {"lowerIsBetter": false, "replicates": [251.6388981811101, 255.4533298740694, 258.4159798854588, 259.8695673818888, 262.03570859238005, 5553.694546799924, 5607.158926161078, 5651.011073062213, 5664.858378540539, 5686.886262274752, 5536.141898005805, 5571.052921003429, 5597.328320601523, 5609.859753506154, 5613.186088017235, 4027.0939038716274, 4111.588841115879, 4112.239235741397, 4116.382542618616, 4117.8970525736795, 4096.283150448675, 4097.672186225095, 4104.42538044674, 4106.897327566805, 4109.630133288004, 4086.1010577672864, 4086.734362266458, 4087.8364865405347, 4093.0585965228015, 4115.115250221202, 4091.2022155679656, 4093.5906409358977, 4097.569755175693, 4099.323611604082, 4106.260873042851, 3363.697267245935, 3435.9312813743586, 3437.742169337285, 3483.5819701635965, 3526.2947410518, 5357.357117145929, 5365.06111430502, 5366.4633536646415, 5380.892382152374, 5392.272043274186, 4725.692829966076, 4736.4316282046375, 4744.264638980963, 4746.738929358884, 4750.61995040396, 5787.450192231773, 5816.1566572846705, 5830.82507524775, 5840.415958404125, 5853.912191317134, 3708.258348330318, 3819.2170605025904, 3822.57951625321, 3824.2542704172697, 3828.444875493066, 6151.815445536641, 6222.191115155001, 6228.439440450381, 6231.2522497300615, 6239.344868788802, 3850.614938506183, 3851.056491159684, 3852.8844134676006, 3857.7492462989817, 3864.2078373933277, 3908.120672848643, 3909.0, 3912.217556488714, 3914.119323152268, 3922.686185105185, 4516.480604730433, 4569.428821397325, 4647.34937108805, 4656.092062047868, 4690.835820746258, 5849.795257165979, 5861.882762344814, 5864.149698293723, 5866.501347385435, 5881.647101173943, 1369.0963963783854, 1374.202962281874, 1381.6822130909948, 1381.8825399840925, 1382.9585112446644, 892.1435421994828, 900.1538553759445, 903.8566213739624, 915.4324318922311, 921.138735282513, 5024.949750502521, 5053.0399224147295, 5060.2156665716875, 5069.417017043087, 5071.0872043032605, 6111.8472038198515, 6147.293061297919, 6156.5998210116195, 6162.537809664203, 6168.19813424261, 5047.192449208109, 5047.671901326402, 5050.090983622909, 5054.2671312660195, 5061.72160531167, 3238.3361410910707, 3274.1978215337394, 3289.227031647561, 3321.30252646942, 3322.750793690483, 5741.8277451675685, 5749.0, 5759.1937128802, 5760.135979603009, 5764.13537969308, 6265.530085243625, 6310.4636105930595, 6315.242170939517, 6317.842053948596, 6325.114483972247, 5557.805476808292, 5723.856903577361, 5727.7995270166175, 5742.885142297214, 5743.368229494752, 6137.171481849893, 6154.169187159676, 6154.230721159855, 6155.692215389123, 6164.537659675632, 5990.970045149921, 6002.879942401215, 6002.969985150046, 6008.819735407945, 6017.0, 5731.713414329183, 5742.655440673573, 5748.856278593069, 5752.252207213036, 5763.596548241583, 3777.660010599059, 3885.630865067814, 3905.7070719696703, 3914.197589494204, 3943.507061617298, 6069.423404776539, 6136.570440069152, 6149.569530132848, 6154.107654390178, 6165.445109940127, 5887.911681324698, 5909.231799866162, 5954.0, 5956.0, 5961.463468287701, 5921.467067963904, 5930.703464826827, 5934.169216309634, 5938.346781854079, 5960.403959604005, 5716.742746576331, 5759.798407055733, 5785.450382213683, 5808.419158084327, 5815.883682326415, 5934.821955341346, 5958.285005799332, 5982.581219314607, 5988.131720900532, 6000.159977603052, 5788.681622510802, 5814.156947242711, 5835.8832823342445, 5837.708114594338, 5843.0], "unit": "ms", "name": "prototype.html", "value": 4280.486876469067}, {"lowerIsBetter": false, "replicates": [658.3087757854255, 668.5687731413235, 669.5246375073696, 670.5767157565746, 734.1997223026902, 10861.0, 11082.501287442064, 11085.889141108586, 11097.056750176225, 11124.944375278132, 11470.7132321692, 11584.42077896104, 11623.535058597647, 11676.065914726823, 11681.59114430995, 788.73577351587, 798.2097723253995, 813.4184058398245, 816.7631386897792, 821.7247222180577, 796.4265728675344, 796.9641366138537, 802.1537278171527, 802.8875957365973, 803.1606970715587, 831.3640065350012, 836.1972506393869, 837.1252041616495, 843.4939036578065, 845.1168528887328, 821.9835603287901, 832.9541875196862, 832.9583520823935, 834.2908527751423, 836.1638361638362, 617.2500411999397, 621.6332363905273, 621.9564630475868, 622.9283632382288, 623.0063049436142, 12334.75330493394, 12494.687632809253, 12498.500059997588, 12537.74924501505, 12581.119321647488, 10379.273450858444, 10664.733381665443, 11095.334279943148, 11166.776664466664, 11628.418579071098, 9303.116203960613, 9312.44125352481, 9447.952760236223, 9549.28380371468, 9658.082482164184, 3187.4421976154313, 3201.4557525220766, 3219.388316219911, 3261.9184520386943, 3267.722243609296, 39993.400098998536, 40487.0, 40642.79678601588, 40676.79661601673, 40788.18423631511, 9460.43237405744, 9657.985911479194, 9815.411075335503, 10141.985801419947, 10310.123639490726, 16856.57858553546, 16921.661566768842, 17132.0, 17185.7422138668, 17244.051577163125, 6604.471642268703, 6695.263521012685, 6717.529772915849, 6759.188897332253, 6787.423069039089, 3647.8723244686307, 3673.173535954389, 3679.632036796299, 3728.6830619397656, 3759.830807613664, 2732.194002769188, 2736.53478908586, 2748.189284161177, 2753.7246275372304, 2760.213339198319, 461.06634066016585, 469.9965573500601, 485.35932569009276, 485.48538549138027, 486.3312944701036, 482.8044641919958, 525.0129756058585, 576.685706290073, 609.9908501372483, 617.3086143519287, 7523.285287897641, 7582.696692132253, 7761.495502792301, 7796.571188584682, 7855.567943763148, 486.77365025263424, 494.5203152941641, 585.0376131264047, 591.3317950715664, 607.3228350389372, 3609.8556057757396, 3632.6912212461707, 3649.908752281161, 3723.4414837774007, 3755.455458958436, 49235.75382123138, 49442.25836612382, 49913.75043124761, 49913.750431248336, 49993.0, 39297.0, 39543.80228098841, 39552.20895582072, 39959.80020099939, 39991.80004099961, 38164.23671526554, 40650.79674601608, 40757.0, 40914.749688767406, 41405.171896561296, 7845.960770196112, 7904.762857114296, 8179.713710020121, 8345.374096942633, 8423.957880210804, 31824.84087579547, 31849.8407507961, 32500.187495312806, 33277.16807079843, 33539.83230083931, 36439.27121457503, 36665.26669466649, 37782.81108594439, 40295.3955690659, 40777.592224078566, 9722.0, 9874.111329980336, 10069.496525173858, 10130.240231982483, 10233.897661023295, 11194.720131996764, 11279.09767218604, 11302.378369189773, 11325.603603873826, 11383.260088094248, 10265.84601230997, 10603.469826508797, 10666.306690065121, 10878.945605271923, 10893.400862952614, 10716.839247411452, 10726.410047447465, 10926.890731092588, 10946.562137514411, 10968.835467467834, 9888.406695598287, 10002.199824014207, 10076.647317343857, 10337.84493232587, 10349.84475232857, 9056.95844977836, 9156.771080723036, 9168.679096231599, 9197.632094716404, 9230.492322922304, 8655.783605409915, 8737.825243495221, 8778.429402088845, 8940.68707595231, 9206.815863682823], "unit": "ms", "name": "yui.html", "value": 5713.1186545308665}], "name": "dromaeo_css", "value": 6261.382640007217}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 115.0, 114.0, 115.0, 125.0, 114.0, 114.0, 113.0, 117.0], "unit": "ms", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 150.0, 172.0, 133.0, 156.0, 151.0, 131.0, 170.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [166.0, 163.0, 161.0, 162.0, 162.0, 165.0, 167.0, 167.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 73.0, 76.0, 73.0, 132.0, 72.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 94.0, 96.0, 94.0, 141.0, 94.0, 96.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 99.0, 96.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 75.0, 82.0, 78.0, 74.0, 75.0, 78.0, 80.0], "unit": "ms", "name": "json-parse-financial", "value": 76.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 71.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 95.0, 90.0, 87.0, 84.0, 84.0, 85.0, 85.0, 86.0, 88.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [123.0, 134.0, 132.0, 118.0, 124.0, 129.0, 126.0, 130.0, 126.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [144.0, 162.0, 150.0, 149.0, 149.0, 151.0, 148.0, 150.0, 148.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 73.0, 70.0, 73.0, 71.0, 69.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1547.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [184.1620626151013], "unit": "score", "name": "DeltaBlue", "value": 359.02074000000005}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [700.770847932726], "unit": "score", "name": "Earley", "value": 951.0427009999997}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [597.3715651135007], "unit": "score", "name": "Splay", "value": 136.41593400000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21450.203730380177}]} 11:41:13 INFO - RETURN: dromaeo_css: 6261.38 11:41:13 INFO - RETURN: kraken: 1547.40 11:41:13 INFO - RETURN: v8_7: 21450.20 11:41:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21450.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1547.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6261.38"}}} 11:41:13 INFO - Return code: 0 11:41:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:41:13 INFO - # TBPL SUCCESS # 11:41:13 INFO - Running post-action listener: _resource_record_post_action 11:41:13 INFO - Running post-run listener: _resource_record_post_run 11:41:14 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506429440; Read time: 12; Write time: 346072 11:41:14 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 168431616; Read time: 0; Write time: 163592 11:41:14 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275357696; Read time: 12; Write time: 137484 11:41:14 INFO - Running post-run listener: _upload_blobber_files 11:41:14 INFO - Blob upload gear active. 11:41:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:41:14 INFO - Copying logs to upload dir... 11:41:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.107847 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-09 11:41:13.876042) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:41:13.879945) ========= 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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010128 build_url: 'https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:41:13.932213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:41:13.932618) ========= 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=dd132779db58144225c4cf24000001c8-1449688434.706664-653697100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:41:13.982569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 11:41:13.982915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 11:41:13.983249) ========= ========= Total master_lag: 0.27 =========