builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1450277138.62 results: success (0) buildid: 20151216060609 builduid: 97dead39603e490489cb09fcbc4fa5cf revision: 45a3b79cc3a474a576e96f3039f976538f55ac3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.621479) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.622228) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.622738) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004977 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.672177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.672545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.719303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.719680) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016306 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.774847) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.775206) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.775615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:38.775903) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 06:45:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2015-12-16 06:45:38 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.223376 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:39.027745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:39.028144) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.125624 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:39.164422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:39.164785) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45a3b79cc3a474a576e96f3039f976538f55ac3e --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 45a3b79cc3a474a576e96f3039f976538f55ac3e --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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 06:45:39,191 truncating revision to first 12 chars 2015-12-16 06:45:39,191 Setting DEBUG logging. 2015-12-16 06:45:39,191 attempt 1/10 2015-12-16 06:45:39,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45a3b79cc3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 06:45:39,866 unpacking tar archive at: fx-team-45a3b79cc3a4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.964284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:40.140689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:40.141067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:40.151531) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:40.151930) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 06:45:40.152436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-12-16 06:45:40.152734) ========= /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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:45:40 INFO - MultiFileLogger online at 20151216 06:45:40 in /builds/slave/test 06:45:40 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 06:45:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:45:40 INFO - {'append_to_log': False, 06:45:40 INFO - 'base_work_dir': '/builds/slave/test', 06:45:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:45:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:45:40 INFO - 'branch': 'Fx-Team-Non-PGO', 06:45:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:45:40 INFO - 'config_files': ('talos/linux_config.py',), 06:45:40 INFO - 'default_actions': ('clobber', 06:45:40 INFO - 'read-buildbot-config', 06:45:40 INFO - 'download-and-extract', 06:45:40 INFO - 'populate-webroot', 06:45:40 INFO - 'create-virtualenv', 06:45:40 INFO - 'install', 06:45:40 INFO - 'run-tests'), 06:45:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:45:40 INFO - 'download_minidump_stackwalk': True, 06:45:40 INFO - 'download_symbols': 'ondemand', 06:45:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:45:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:45:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:45:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:45:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:45:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:45:40 INFO - 'installer_path': 'installer.exe', 06:45:40 INFO - 'log_level': 'info', 06:45:40 INFO - 'log_name': 'talos', 06:45:40 INFO - 'log_to_console': True, 06:45:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:45:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:45:40 INFO - 'opt_config_files': (), 06:45:40 INFO - 'pip_index': False, 06:45:40 INFO - 'sps_profile': False, 06:45:40 INFO - 'sps_profile_interval': 0, 06:45:40 INFO - 'suite': 'dromaeojs-e10s', 06:45:40 INFO - 'system_bits': '64', 06:45:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:45:40 INFO - 'title': 'talos-linux64-ix-011', 06:45:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:45:40 INFO - 'use_talos_json': True, 06:45:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:45:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:45:40 INFO - 'work_dir': 'build'} 06:45:40 INFO - ##### 06:45:40 INFO - ##### Running clobber step. 06:45:40 INFO - ##### 06:45:40 INFO - Running pre-action listener: _resource_record_pre_action 06:45:40 INFO - Running main action method: clobber 06:45:40 INFO - rmtree: /builds/slave/test/build 06:45:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:45:43 INFO - Running post-action listener: _resource_record_post_action 06:45:43 INFO - ##### 06:45:43 INFO - ##### Running read-buildbot-config step. 06:45:43 INFO - ##### 06:45:43 INFO - Running pre-action listener: _resource_record_pre_action 06:45:43 INFO - Running main action method: read_buildbot_config 06:45:43 INFO - Using buildbot properties: 06:45:43 INFO - { 06:45:43 INFO - "properties": { 06:45:43 INFO - "buildnumber": 822, 06:45:43 INFO - "product": "firefox", 06:45:43 INFO - "script_repo_revision": "production", 06:45:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:45:43 INFO - "repository": "", 06:45:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:45:43 INFO - "buildid": "20151216060609", 06:45:43 INFO - "slavename": "talos-linux64-ix-011", 06:45:43 INFO - "pgo_build": "False", 06:45:43 INFO - "basedir": "/builds/slave/test", 06:45:43 INFO - "project": "", 06:45:43 INFO - "platform": "ubuntu64_hw", 06:45:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:45:43 INFO - "slavebuilddir": "test", 06:45:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:45:43 INFO - "branch": "fx-team", 06:45:43 INFO - "repo_path": "integration/fx-team", 06:45:43 INFO - "stage_platform": "linux64", 06:45:43 INFO - "builduid": "97dead39603e490489cb09fcbc4fa5cf", 06:45:43 INFO - "revision": "45a3b79cc3a474a576e96f3039f976538f55ac3e" 06:45:43 INFO - }, 06:45:43 INFO - "sourcestamp": { 06:45:43 INFO - "repository": "", 06:45:43 INFO - "hasPatch": false, 06:45:43 INFO - "project": "", 06:45:43 INFO - "branch": "fx-team-linux64-talos", 06:45:43 INFO - "changes": [ 06:45:43 INFO - { 06:45:43 INFO - "category": null, 06:45:43 INFO - "files": [ 06:45:43 INFO - { 06:45:43 INFO - "url": null, 06:45:43 INFO - "name": "https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 06:45:43 INFO - } 06:45:43 INFO - ], 06:45:43 INFO - "repository": "", 06:45:43 INFO - "rev": "45a3b79cc3a474a576e96f3039f976538f55ac3e", 06:45:43 INFO - "who": "gijskruitbosch@gmail.com", 06:45:43 INFO - "when": 1450277096, 06:45:43 INFO - "number": 7366372, 06:45:43 INFO - "comments": "Bug 1232421 - followup: fix test to not use 'inline comments' which are not supported elsewhere, rs=bustage on a CLOSED TREE", 06:45:43 INFO - "project": "", 06:45:43 INFO - "at": "Wed 16 Dec 2015 06:44:56", 06:45:43 INFO - "branch": "fx-team-linux64-talos", 06:45:43 INFO - "revlink": "", 06:45:43 INFO - "properties": [ 06:45:43 INFO - [ 06:45:43 INFO - "buildid", 06:45:43 INFO - "20151216060609", 06:45:43 INFO - "Change" 06:45:43 INFO - ], 06:45:43 INFO - [ 06:45:43 INFO - "builduid", 06:45:43 INFO - "97dead39603e490489cb09fcbc4fa5cf", 06:45:43 INFO - "Change" 06:45:43 INFO - ], 06:45:43 INFO - [ 06:45:43 INFO - "pgo_build", 06:45:43 INFO - "False", 06:45:43 INFO - "Change" 06:45:43 INFO - ] 06:45:43 INFO - ], 06:45:43 INFO - "revision": "45a3b79cc3a474a576e96f3039f976538f55ac3e" 06:45:43 INFO - } 06:45:43 INFO - ], 06:45:43 INFO - "revision": "45a3b79cc3a474a576e96f3039f976538f55ac3e" 06:45:43 INFO - } 06:45:43 INFO - } 06:45:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:45:43 INFO - Running post-action listener: _resource_record_post_action 06:45:43 INFO - ##### 06:45:43 INFO - ##### Running download-and-extract step. 06:45:43 INFO - ##### 06:45:43 INFO - Running pre-action listener: _resource_record_pre_action 06:45:43 INFO - Running main action method: download_and_extract 06:45:43 INFO - mkdir: /builds/slave/test/build/tests 06:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:43 INFO - https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/test_packages.json 06:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/test_packages.json 06:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:45:52 INFO - Downloaded 1302 bytes. 06:45:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:45:52 INFO - Using the following test package requirements: 06:45:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:45:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:45:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:52 INFO - u'jsshell-linux-x86_64.zip'], 06:45:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:45:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:45:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:45:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:45:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:45:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:45:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:45:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:45:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:52 INFO - https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:45:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:45:55 INFO - Downloaded 21869080 bytes. 06:45:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:45:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:45:56 INFO - Return code: 0 06:45:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:56 INFO - https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:45:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:45:59 INFO - Downloaded 21869080 bytes. 06:45:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:45:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:45:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:46:03 INFO - Return code: 0 06:46: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')]} 06:46:03 INFO - https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:46:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:46:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:46:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:46:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:46:04 INFO - Downloaded 11132052 bytes. 06:46:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 06:46:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:46:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:46:04 INFO - Return code: 0 06:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:04 INFO - https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:46:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:46:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:46:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:46:05 INFO - Downloaded 57747405 bytes. 06:46:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:46:05 INFO - mkdir: /builds/slave/test/properties 06:46:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:46:05 INFO - Writing to file /builds/slave/test/properties/build_url 06:46:05 INFO - Contents: 06:46:05 INFO - build_url:https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:46:05 INFO - Running post-action listener: _resource_record_post_action 06:46:05 INFO - Running post-action listener: set_extra_try_arguments 06:46:05 INFO - ##### 06:46:05 INFO - ##### Running populate-webroot step. 06:46:05 INFO - ##### 06:46:05 INFO - Running pre-action listener: _resource_record_pre_action 06:46:05 INFO - Running main action method: populate_webroot 06:46:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:46:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:46:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:46:05 INFO - '--tppagecycles', 06:46:05 INFO - '7'], 06:46:05 INFO - 'tests': ['tsvgm']}}, 06:46:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:46:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:46:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:46:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:46:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'tests': ['damp', 'tps']}, 06:46:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['damp', 'tps']}, 06:46:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:46:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:46:05 INFO - 'other': {'tests': ['a11yr', 06:46:05 INFO - 'ts_paint', 06:46:05 INFO - 'tpaint', 06:46:05 INFO - 'sessionrestore', 06:46:05 INFO - 'sessionrestore_no_auto_restore']}, 06:46:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['a11yr', 06:46:05 INFO - 'ts_paint', 06:46:05 INFO - 'tpaint', 06:46:05 INFO - 'sessionrestore', 06:46:05 INFO - 'sessionrestore_no_auto_restore']}, 06:46:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['a11yr', 06:46:05 INFO - 'ts_paint', 06:46:05 INFO - 'tpaint', 06:46:05 INFO - 'sessionrestore', 06:46:05 INFO - 'sessionrestore_no_auto_restore']}, 06:46:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['a11yr', 06:46:05 INFO - 'ts_paint', 06:46:05 INFO - 'tpaint', 06:46:05 INFO - 'sessionrestore', 06:46:05 INFO - 'sessionrestore_no_auto_restore']}, 06:46:05 INFO - 'other_l64': {'tests': ['a11yr', 06:46:05 INFO - 'ts_paint', 06:46:05 INFO - 'tpaint', 06:46:05 INFO - 'sessionrestore', 06:46:05 INFO - 'sessionrestore_no_auto_restore']}, 06:46:05 INFO - 'other_nol64': {'tests': ['a11yr', 06:46:05 INFO - 'ts_paint', 06:46:05 INFO - 'tpaint', 06:46:05 INFO - 'sessionrestore', 06:46:05 INFO - 'sessionrestore_no_auto_restore']}, 06:46:05 INFO - 'svgr': {'tests': ['tsvgx', 06:46:05 INFO - 'tsvgr_opacity', 06:46:05 INFO - 'tart', 06:46:05 INFO - 'tscrollx', 06:46:05 INFO - 'cart']}, 06:46:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['tsvgx', 06:46:05 INFO - 'tsvgr_opacity', 06:46:05 INFO - 'tart', 06:46:05 INFO - 'tscrollx', 06:46:05 INFO - 'cart']}, 06:46:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'tests': ['tp5o']}, 06:46:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'talos_options': ['--e10s'], 06:46:05 INFO - 'tests': ['tp5o']}, 06:46:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'talos_options': ['--xperf_path', 06:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:05 INFO - 'tests': ['tp5n']}, 06:46:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:05 INFO - 'talos_options': ['--e10s', 06:46:05 INFO - '--xperf_path', 06:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:05 INFO - 'tests': ['tp5n']}}, 06:46:05 INFO - 'talos.zip': {'path': '', 06:46:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:46:05 INFO - Running post-action listener: _resource_record_post_action 06:46:05 INFO - ##### 06:46:05 INFO - ##### Running create-virtualenv step. 06:46:05 INFO - ##### 06:46:05 INFO - Running pre-action listener: _resource_record_pre_action 06:46:05 INFO - Running main action method: create_virtualenv 06:46:05 INFO - Creating virtualenv /builds/slave/test/build/venv 06:46:05 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 06:46:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:46:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:46:06 INFO - Using real prefix '/usr' 06:46:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:46:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:46:10 INFO - Installing pip.................done. 06:46:10 INFO - Return code: 0 06:46:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:46:10 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')]} 06:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:10 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')]} 06:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:10 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:10 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 06:46:10 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 06:46:10 INFO - Using env: {'DISPLAY': ':0', 06:46:10 INFO - 'HOME': '/home/cltbld', 06:46:10 INFO - 'LANG': 'en_US.UTF-8', 06:46:10 INFO - 'LANGUAGE': 'en_US:en', 06:46:10 INFO - 'LOGNAME': 'cltbld', 06:46:10 INFO - 'MAIL': '/var/mail/cltbld', 06:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:10 INFO - 'MOZ_NO_REMOTE': '1', 06:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:10 INFO - 'NO_EM_RESTART': '1', 06:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:10 INFO - 'PWD': '/builds/slave/test', 06:46:10 INFO - 'SHELL': '/bin/bash', 06:46:10 INFO - 'SHLVL': '1', 06:46:10 INFO - 'TERM': 'linux', 06:46:10 INFO - 'TMOUT': '86400', 06:46:10 INFO - 'USER': 'cltbld', 06:46:10 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:10 INFO - '_': '/tools/buildbot/bin/python'} 06:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:12 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 06:46:12 INFO - Cleaning up... 06:46:12 INFO - Return code: 0 06:46:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:46:12 INFO - Using env: {'DISPLAY': ':0', 06:46:12 INFO - 'HOME': '/home/cltbld', 06:46:12 INFO - 'LANG': 'en_US.UTF-8', 06:46:12 INFO - 'LANGUAGE': 'en_US:en', 06:46:12 INFO - 'LOGNAME': 'cltbld', 06:46:12 INFO - 'MAIL': '/var/mail/cltbld', 06:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:12 INFO - 'MOZ_NO_REMOTE': '1', 06:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:12 INFO - 'NO_EM_RESTART': '1', 06:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:12 INFO - 'PWD': '/builds/slave/test', 06:46:12 INFO - 'SHELL': '/bin/bash', 06:46:12 INFO - 'SHLVL': '1', 06:46:12 INFO - 'TERM': 'linux', 06:46:12 INFO - 'TMOUT': '86400', 06:46:12 INFO - 'USER': 'cltbld', 06:46:12 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:12 INFO - '_': '/tools/buildbot/bin/python'} 06:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:12 INFO - Downloading/unpacking psutil>=0.7.1 06:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:46:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:46:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:14 INFO - Installing collected packages: psutil 06:46:14 INFO - Running setup.py install for psutil 06:46:14 INFO - building 'psutil._psutil_linux' extension 06:46:14 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 06:46:15 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 06:46:15 INFO - building 'psutil._psutil_posix' extension 06:46:15 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 06:46:15 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 06:46:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:16 INFO - Successfully installed psutil 06:46:16 INFO - Cleaning up... 06:46:16 INFO - Return code: 0 06:46:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:16 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:16 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 06:46:16 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 06:46:16 INFO - Using env: {'DISPLAY': ':0', 06:46:16 INFO - 'HOME': '/home/cltbld', 06:46:16 INFO - 'LANG': 'en_US.UTF-8', 06:46:16 INFO - 'LANGUAGE': 'en_US:en', 06:46:16 INFO - 'LOGNAME': 'cltbld', 06:46:16 INFO - 'MAIL': '/var/mail/cltbld', 06:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:16 INFO - 'MOZ_NO_REMOTE': '1', 06:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:16 INFO - 'NO_EM_RESTART': '1', 06:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:16 INFO - 'PWD': '/builds/slave/test', 06:46:16 INFO - 'SHELL': '/bin/bash', 06:46:16 INFO - 'SHLVL': '1', 06:46:16 INFO - 'TERM': 'linux', 06:46:16 INFO - 'TMOUT': '86400', 06:46:16 INFO - 'USER': 'cltbld', 06:46:16 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:16 INFO - '_': '/tools/buildbot/bin/python'} 06:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:46:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:46:18 INFO - Installing collected packages: mozsystemmonitor 06:46:18 INFO - Running setup.py install for mozsystemmonitor 06:46:18 INFO - Successfully installed mozsystemmonitor 06:46:18 INFO - Cleaning up... 06:46:18 INFO - Return code: 0 06:46:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:46:18 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')]} 06:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:18 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')]} 06:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:18 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:18 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 06:46:18 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 06:46:18 INFO - Using env: {'DISPLAY': ':0', 06:46:18 INFO - 'HOME': '/home/cltbld', 06:46:18 INFO - 'LANG': 'en_US.UTF-8', 06:46:18 INFO - 'LANGUAGE': 'en_US:en', 06:46:18 INFO - 'LOGNAME': 'cltbld', 06:46:18 INFO - 'MAIL': '/var/mail/cltbld', 06:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:18 INFO - 'MOZ_NO_REMOTE': '1', 06:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:18 INFO - 'NO_EM_RESTART': '1', 06:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:18 INFO - 'PWD': '/builds/slave/test', 06:46:18 INFO - 'SHELL': '/bin/bash', 06:46:18 INFO - 'SHLVL': '1', 06:46:18 INFO - 'TERM': 'linux', 06:46:18 INFO - 'TMOUT': '86400', 06:46:18 INFO - 'USER': 'cltbld', 06:46:18 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:18 INFO - '_': '/tools/buildbot/bin/python'} 06:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:18 INFO - Downloading/unpacking blobuploader==1.2.4 06:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:20 INFO - Downloading blobuploader-1.2.4.tar.gz 06:46:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:46:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:46:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 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 06:46:20 INFO - Downloading docopt-0.6.1.tar.gz 06:46:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:46:20 INFO - Installing collected packages: blobuploader, requests, docopt 06:46:20 INFO - Running setup.py install for blobuploader 06:46:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:46:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:46:20 INFO - Running setup.py install for requests 06:46:21 INFO - Running setup.py install for docopt 06:46:21 INFO - Successfully installed blobuploader requests docopt 06:46:21 INFO - Cleaning up... 06:46:21 INFO - Return code: 0 06:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46:21 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')]} 06:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:21 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')]} 06:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:21 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:21 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 06:46:21 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 06:46:21 INFO - Using env: {'DISPLAY': ':0', 06:46:21 INFO - 'HOME': '/home/cltbld', 06:46:21 INFO - 'LANG': 'en_US.UTF-8', 06:46:21 INFO - 'LANGUAGE': 'en_US:en', 06:46:21 INFO - 'LOGNAME': 'cltbld', 06:46:21 INFO - 'MAIL': '/var/mail/cltbld', 06:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:21 INFO - 'MOZ_NO_REMOTE': '1', 06:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:21 INFO - 'NO_EM_RESTART': '1', 06:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:21 INFO - 'PWD': '/builds/slave/test', 06:46:21 INFO - 'SHELL': '/bin/bash', 06:46:21 INFO - 'SHLVL': '1', 06:46:21 INFO - 'TERM': 'linux', 06:46:21 INFO - 'TMOUT': '86400', 06:46:21 INFO - 'USER': 'cltbld', 06:46:21 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:21 INFO - '_': '/tools/buildbot/bin/python'} 06:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:46:21 INFO - Running setup.py (path:/tmp/pip-4zDYAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:46:21 INFO - Running setup.py (path:/tmp/pip-IJ2WEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:46:21 INFO - Running setup.py (path:/tmp/pip-WeRZmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:46:21 INFO - Running setup.py (path:/tmp/pip-HnuhSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:46:21 INFO - Running setup.py (path:/tmp/pip-qV6q1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:46:21 INFO - Running setup.py (path:/tmp/pip-oUMgT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:46:22 INFO - Running setup.py (path:/tmp/pip-oFU1U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:46:22 INFO - Running setup.py (path:/tmp/pip-dhD4KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:46:22 INFO - Running setup.py (path:/tmp/pip-UADZz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:46:22 INFO - Running setup.py (path:/tmp/pip-k5ZvAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:46:22 INFO - Running setup.py (path:/tmp/pip-hPZfOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:46:22 INFO - Running setup.py (path:/tmp/pip-8mpPyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:46:22 INFO - Running setup.py (path:/tmp/pip-LWY3XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:46:22 INFO - Running setup.py (path:/tmp/pip-6Q9nSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:22 INFO - Running setup.py (path:/tmp/pip-55aC1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:46:22 INFO - Running setup.py (path:/tmp/pip-Clbcju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:46:22 INFO - Running setup.py (path:/tmp/pip-txr7GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:46:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:46:22 INFO - Running setup.py install for manifestparser 06:46:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:46:22 INFO - Running setup.py install for mozcrash 06:46:23 INFO - Running setup.py install for mozdebug 06:46:23 INFO - Running setup.py install for mozdevice 06:46:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Running setup.py install for mozfile 06:46:23 INFO - Running setup.py install for mozhttpd 06:46:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Running setup.py install for mozinfo 06:46:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Running setup.py install for mozInstall 06:46:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Running setup.py install for mozleak 06:46:23 INFO - Running setup.py install for mozlog 06:46:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Running setup.py install for moznetwork 06:46:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:46:23 INFO - Running setup.py install for mozprocess 06:46:24 INFO - Running setup.py install for mozprofile 06:46:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:46:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:46:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:46:24 INFO - Running setup.py install for mozrunner 06:46:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:46:24 INFO - Running setup.py install for mozscreenshot 06:46:24 INFO - Running setup.py install for moztest 06:46:24 INFO - Running setup.py install for mozversion 06:46:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:46:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:46:24 INFO - Cleaning up... 06:46:24 INFO - Return code: 0 06:46:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46:24 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')]} 06:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:24 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')]} 06:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:24 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:24 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 06:46:24 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 06:46:24 INFO - Using env: {'DISPLAY': ':0', 06:46:24 INFO - 'HOME': '/home/cltbld', 06:46:24 INFO - 'LANG': 'en_US.UTF-8', 06:46:24 INFO - 'LANGUAGE': 'en_US:en', 06:46:24 INFO - 'LOGNAME': 'cltbld', 06:46:24 INFO - 'MAIL': '/var/mail/cltbld', 06:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:24 INFO - 'MOZ_NO_REMOTE': '1', 06:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:24 INFO - 'NO_EM_RESTART': '1', 06:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:24 INFO - 'PWD': '/builds/slave/test', 06:46:24 INFO - 'SHELL': '/bin/bash', 06:46:24 INFO - 'SHLVL': '1', 06:46:24 INFO - 'TERM': 'linux', 06:46:24 INFO - 'TMOUT': '86400', 06:46:24 INFO - 'USER': 'cltbld', 06:46:24 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:24 INFO - '_': '/tools/buildbot/bin/python'} 06:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:46:24 INFO - Running setup.py (path:/tmp/pip-uKqlPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:46:24 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)) 06:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:46:24 INFO - Running setup.py (path:/tmp/pip-L3sdDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:46:24 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)) 06:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:46:24 INFO - Running setup.py (path:/tmp/pip-SDPfqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:46:25 INFO - Running setup.py (path:/tmp/pip-Br4JrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:46:25 INFO - Running setup.py (path:/tmp/pip-c_g4rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:46:25 INFO - Running setup.py (path:/tmp/pip-Hqe1hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:46:25 INFO - Running setup.py (path:/tmp/pip-BfUlpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:46:25 INFO - Running setup.py (path:/tmp/pip-mrlBDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:46:25 INFO - Running setup.py (path:/tmp/pip-WuItHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:46:25 INFO - Running setup.py (path:/tmp/pip-RmOk_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:46:25 INFO - Running setup.py (path:/tmp/pip-P6ccUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:46:25 INFO - Running setup.py (path:/tmp/pip-igb8aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:46:25 INFO - Running setup.py (path:/tmp/pip-skfNVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:46:25 INFO - Running setup.py (path:/tmp/pip-2hW3ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:25 INFO - Running setup.py (path:/tmp/pip-CLf3GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:46:25 INFO - Running setup.py (path:/tmp/pip-OdeXBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:46:25 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)) 06:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:46:25 INFO - Running setup.py (path:/tmp/pip-oF63AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:46:26 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)) 06:46:26 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)) 06:46:26 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)) 06:46:26 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)) 06:46:26 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)) 06:46:26 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)) 06:46:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:46:26 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 06:46:26 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 06:46:26 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 06:46:26 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 06:46:26 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 06:46:26 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 06:46:27 INFO - Downloading blessings-1.5.1.tar.gz 06:46:27 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 06:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:46:27 INFO - Installing collected packages: blessings 06:46:27 INFO - Running setup.py install for blessings 06:46:27 INFO - Successfully installed blessings 06:46:27 INFO - Cleaning up... 06:46:28 INFO - Return code: 0 06:46:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:46:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:28 INFO - Reading from file tmpfile_stdout 06:46:28 INFO - Current package versions: 06:46:28 INFO - argparse == 1.2.1 06:46:28 INFO - blessings == 1.5.1 06:46:28 INFO - blobuploader == 1.2.4 06:46:28 INFO - docopt == 0.6.1 06:46:28 INFO - manifestparser == 1.1 06:46:28 INFO - mozInstall == 1.12 06:46:28 INFO - mozcrash == 0.16 06:46:28 INFO - mozdebug == 0.1 06:46:28 INFO - mozdevice == 0.47 06:46:28 INFO - mozfile == 1.2 06:46:28 INFO - mozhttpd == 0.7 06:46:28 INFO - mozinfo == 0.9 06:46:28 INFO - mozleak == 0.1 06:46:28 INFO - mozlog == 3.1 06:46:28 INFO - moznetwork == 0.27 06:46:28 INFO - mozprocess == 0.22 06:46:28 INFO - mozprofile == 0.27 06:46:28 INFO - mozrunner == 6.11 06:46:28 INFO - mozscreenshot == 0.1 06:46:28 INFO - mozsystemmonitor == 0.0 06:46:28 INFO - moztest == 0.7 06:46:28 INFO - mozversion == 1.4 06:46:28 INFO - psutil == 3.1.1 06:46:28 INFO - requests == 1.2.3 06:46:28 INFO - wsgiref == 0.1.2 06:46:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:28 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:28 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 06:46:28 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 06:46:28 INFO - Using env: {'DISPLAY': ':0', 06:46:28 INFO - 'HOME': '/home/cltbld', 06:46:28 INFO - 'LANG': 'en_US.UTF-8', 06:46:28 INFO - 'LANGUAGE': 'en_US:en', 06:46:28 INFO - 'LOGNAME': 'cltbld', 06:46:28 INFO - 'MAIL': '/var/mail/cltbld', 06:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:28 INFO - 'MOZ_NO_REMOTE': '1', 06:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:28 INFO - 'NO_EM_RESTART': '1', 06:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:28 INFO - 'PWD': '/builds/slave/test', 06:46:28 INFO - 'SHELL': '/bin/bash', 06:46:28 INFO - 'SHLVL': '1', 06:46:28 INFO - 'TERM': 'linux', 06:46:28 INFO - 'TMOUT': '86400', 06:46:28 INFO - 'USER': 'cltbld', 06:46:28 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:28 INFO - '_': '/tools/buildbot/bin/python'} 06:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 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)) 06:46:28 INFO - Cleaning up... 06:46:28 INFO - Return code: 0 06:46:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:28 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:28 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 06:46:28 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 06:46:28 INFO - Using env: {'DISPLAY': ':0', 06:46:28 INFO - 'HOME': '/home/cltbld', 06:46:28 INFO - 'LANG': 'en_US.UTF-8', 06:46:28 INFO - 'LANGUAGE': 'en_US:en', 06:46:28 INFO - 'LOGNAME': 'cltbld', 06:46:28 INFO - 'MAIL': '/var/mail/cltbld', 06:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:28 INFO - 'MOZ_NO_REMOTE': '1', 06:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:28 INFO - 'NO_EM_RESTART': '1', 06:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:28 INFO - 'PWD': '/builds/slave/test', 06:46:28 INFO - 'SHELL': '/bin/bash', 06:46:28 INFO - 'SHLVL': '1', 06:46:28 INFO - 'TERM': 'linux', 06:46:28 INFO - 'TMOUT': '86400', 06:46:28 INFO - 'USER': 'cltbld', 06:46:28 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:28 INFO - '_': '/tools/buildbot/bin/python'} 06:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:28 INFO - Downloading/unpacking jsonschema 06:46:28 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 06:46:28 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 06:46:28 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 06:46:28 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 06:46:28 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 06:46:28 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 06:46:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:46:30 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 06:46:30 INFO - Downloading/unpacking functools32 (from jsonschema) 06:46:30 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 06:46:30 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 06:46:30 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 06:46:30 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 06:46:30 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 06:46:30 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 06:46:30 INFO - Downloading functools32-3.2.3-2.tar.gz 06:46:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:46:30 INFO - warning: no files found matching '*.txt' 06:46:30 INFO - no previously-included directories found matching 'build' 06:46:30 INFO - no previously-included directories found matching 'dist' 06:46:30 INFO - no previously-included directories found matching '.git*' 06:46:30 INFO - Installing collected packages: jsonschema, functools32 06:46:30 INFO - Running setup.py install for functools32 06:46:30 INFO - warning: no files found matching '*.txt' 06:46:30 INFO - no previously-included directories found matching 'build' 06:46:30 INFO - no previously-included directories found matching 'dist' 06:46:30 INFO - no previously-included directories found matching '.git*' 06:46:30 INFO - Successfully installed jsonschema functools32 06:46:30 INFO - Cleaning up... 06:46:30 INFO - Return code: 0 06:46:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:30 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 0x7f6d6243bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', '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 06:46:30 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 06:46:30 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 06:46:30 INFO - Using env: {'DISPLAY': ':0', 06:46:30 INFO - 'HOME': '/home/cltbld', 06:46:30 INFO - 'LANG': 'en_US.UTF-8', 06:46:30 INFO - 'LANGUAGE': 'en_US:en', 06:46:30 INFO - 'LOGNAME': 'cltbld', 06:46:30 INFO - 'MAIL': '/var/mail/cltbld', 06:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:30 INFO - 'MOZ_NO_REMOTE': '1', 06:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:30 INFO - 'NO_EM_RESTART': '1', 06:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:30 INFO - 'PWD': '/builds/slave/test', 06:46:30 INFO - 'SHELL': '/bin/bash', 06:46:30 INFO - 'SHLVL': '1', 06:46:30 INFO - 'TERM': 'linux', 06:46:30 INFO - 'TMOUT': '86400', 06:46:30 INFO - 'USER': 'cltbld', 06:46:30 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:30 INFO - '_': '/tools/buildbot/bin/python'} 06:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:31 INFO - Downloading/unpacking flake8 06:46:31 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 06:46:31 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 06:46:31 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 06:46:31 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 06:46:31 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 06:46:31 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 06:46:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:46:32 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 06:46:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:46:32 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 06:46:32 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 06:46:32 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 06:46:32 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 06:46:32 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 06:46:32 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 06:46:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:46:32 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 06:46:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:46:32 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 06:46:32 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 06:46:32 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 06:46:32 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 06:46:32 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 06:46:32 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 06:46:33 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 06:46:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:46: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 06:46: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 06:46: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 06:46: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 06:46: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 06:46: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 06:46:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:46:33 INFO - no previously-included directories found matching 'docs/_build' 06:46:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:46:33 INFO - Running setup.py install for pep8 06:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:46:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:46:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:46:33 INFO - no previously-included directories found matching 'docs/_build' 06:46:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:46:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:46:33 INFO - Cleaning up... 06:46:33 INFO - Return code: 0 06:46:33 INFO - Running post-action listener: _resource_record_post_action 06:46:33 INFO - Running post-action listener: _start_resource_monitoring 06:46:33 INFO - Starting resource monitoring. 06:46:33 INFO - ##### 06:46:33 INFO - ##### Running install step. 06:46:33 INFO - ##### 06:46:33 INFO - Running pre-action listener: _resource_record_pre_action 06:46:33 INFO - Running main action method: install 06:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:33 INFO - Reading from file tmpfile_stdout 06:46:33 INFO - Detecting whether we're running mozinstall >=1.0... 06:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:46:33 INFO - Reading from file tmpfile_stdout 06:46:33 INFO - Output received: 06:46:33 INFO - Usage: mozinstall [options] installer 06:46:33 INFO - Options: 06:46:33 INFO - -h, --help show this help message and exit 06:46:33 INFO - -d DEST, --destination=DEST 06:46:33 INFO - Directory to install application into. [default: 06:46:33 INFO - "/builds/slave/test"] 06:46:33 INFO - --app=APP Application being installed. [default: firefox] 06:46:33 INFO - mkdir: /builds/slave/test/build/application 06:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:46:48 INFO - Reading from file tmpfile_stdout 06:46:48 INFO - Output received: 06:46:48 INFO - /builds/slave/test/build/application/firefox/firefox 06:46:48 INFO - Running post-action listener: _resource_record_post_action 06:46:48 INFO - ##### 06:46:48 INFO - ##### Running run-tests step. 06:46:48 INFO - ##### 06:46:48 INFO - Running pre-action listener: _resource_record_pre_action 06:46:48 INFO - Running main action method: run_tests 06:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:46:48 INFO - Python 2.7.3 06:46:48 INFO - Return code: 0 06:46:48 INFO - grabbing minidump binary from tooltool 06:46:48 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')]} 06:46:48 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 0x27f60b0>, '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 0x27f6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:46:48 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 06:46:48 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 06:46:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:46:48 INFO - Return code: 0 06:46:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:46:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:46:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:46:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:46:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:46:49 INFO - Return code: 0 06:46:49 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/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test/build 06:46:49 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/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 06:46:49 INFO - Using env: {'DISPLAY': ':0', 06:46:49 INFO - 'HOME': '/home/cltbld', 06:46:49 INFO - 'LANG': 'en_US.UTF-8', 06:46:49 INFO - 'LANGUAGE': 'en_US:en', 06:46:49 INFO - 'LOGNAME': 'cltbld', 06:46:49 INFO - 'MAIL': '/var/mail/cltbld', 06:46:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:46:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:49 INFO - 'MOZ_NO_REMOTE': '1', 06:46:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:49 INFO - 'NO_EM_RESTART': '1', 06:46:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:49 INFO - 'PWD': '/builds/slave/test', 06:46:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:46:49 INFO - 'SHELL': '/bin/bash', 06:46:49 INFO - 'SHLVL': '1', 06:46:49 INFO - 'TERM': 'linux', 06:46:49 INFO - 'TMOUT': '86400', 06:46:49 INFO - 'USER': 'cltbld', 06:46:49 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562', 06:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:49 INFO - '_': '/tools/buildbot/bin/python'} 06:46:49 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/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 06:46:49 INFO - mozversion INFO | application_buildid: 20151216060609 06:46:49 INFO - mozversion INFO | application_changeset: 45a3b79cc3a474a576e96f3039f976538f55ac3e 06:46:49 INFO - mozversion INFO | application_display_name: Nightly 06:46:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:46:49 INFO - mozversion INFO | application_name: Firefox 06:46:49 INFO - mozversion INFO | application_remotingname: firefox 06:46:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:46:49 INFO - mozversion INFO | application_vendor: Mozilla 06:46:49 INFO - mozversion INFO | application_version: 46.0a1 06:46:49 INFO - mozversion INFO | platform_buildid: 20151216060609 06:46:49 INFO - mozversion INFO | platform_changeset: 45a3b79cc3a474a576e96f3039f976538f55ac3e 06:46:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:46:49 INFO - mozversion INFO | platform_version: 46.0a1 06:46:49 INFO - 2015-12-16 06:46:49,803 DEBUG : using testdate: 1450277209 06:46:49 INFO - 2015-12-16 06:46:49,803 DEBUG : actual date: 1450277209 06:46:49 INFO - 2015-12-16 06:46:49,851 INFO : starting webserver on 'localhost:36179' 06:46:49 INFO - 2015-12-16 06:46:49,852 INFO : Starting test suite talos-linux64-ix-011.e 06:46:49 INFO - 2015-12-16 06:46:49,852 INFO : Starting test dromaeo_css 06:46:49 INFO - 2015-12-16 06:46:49,852 DEBUG : operating with platform_type : linux_ 06:46:49 INFO - 2015-12-16 06:46:49,853 INFO : Initialising browser for dromaeo_css test... 06:46:49 INFO - 2015-12-16 06:46:49,884 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQv9CxR/profile http://localhost:36179/getInfo.html 06:47:00 INFO - 2015-12-16 06:47:00,103 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:47:00 INFO - 2015-12-16 06:47:00,103 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:47:00 INFO - 2015-12-16 06:47:00,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:47:00 INFO - 2015-12-16 06:47:00,103 DEBUG : BROWSER_OUTPUT: __metrics 06:47:00 INFO - 2015-12-16 06:47:00,207 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] 06:47:01 INFO - 2015-12-16 06:47:01,133 INFO : Browser initialized. 06:47:01 INFO - 2015-12-16 06:47:01,134 INFO : Running cycle 1/1 for dromaeo_css test... 06:47:01 INFO - 2015-12-16 06:47:01,134 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQv9CxR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:47:13 INFO - 2015-12-16 06:47:13,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 142290944 06:47:13 INFO - 2015-12-16 06:47:13,113 DEBUG : BROWSER_OUTPUT: 06:48:02 INFO - 2015-12-16 06:48:02,748 DEBUG : BROWSER_OUTPUT: 1450277282744 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] 06:50:13 INFO - 2015-12-16 06:50:13,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36179/tests/dromaeo/cssquery-ext.html) 06:50:15 INFO - 2015-12-16 06:50:15,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 147308544 06:50:15 INFO - 2015-12-16 06:50:15,049 DEBUG : BROWSER_OUTPUT: 06:53:17 INFO - 2015-12-16 06:53:17,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/dromaeo/cssquery-ext.html (next: http://localhost:36179/tests/dromaeo/cssquery-jquery.html) 06:53:17 INFO - 2015-12-16 06:53:17,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 143912960 06:53:17 INFO - 2015-12-16 06:53:17,693 DEBUG : BROWSER_OUTPUT: 06:56:19 INFO - 2015-12-16 06:56:19,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36179/tests/dromaeo/cssquery-mootools.html) 06:56:20 INFO - 2015-12-16 06:56:20,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 145809408 06:56:20 INFO - 2015-12-16 06:56:20,058 DEBUG : BROWSER_OUTPUT: 06:59:21 INFO - 2015-12-16 06:59:21,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36179/tests/dromaeo/cssquery-prototype.html) 06:59:22 INFO - 2015-12-16 06:59:22,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 144228352 06:59:22 INFO - 2015-12-16 06:59:22,500 DEBUG : BROWSER_OUTPUT: 07:02:25 INFO - 2015-12-16 07:02:25,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36179/tests/dromaeo/cssquery-yui.html) 07:02:25 INFO - 2015-12-16 07:02:25,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 145104896 07:02:25 INFO - 2015-12-16 07:02:25,820 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/dromaeo/cssquery-yui.html (next: http://localhost:36179/tests/dromaeo/cssquery-dojo.html) 07:05:28 INFO - 2015-12-16 07:05:28,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 147349504 07:05:28 INFO - 2015-12-16 07:05:28,313 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,314 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:05:28 INFO - 2015-12-16 07:05:28,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:05:28 INFO - 2015-12-16 07:05:28,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:05:28 INFO - 2015-12-16 07:05:28,315 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:05:28 INFO - 2015-12-16 07:05:28,316 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2695.878685459154;2762.3646561290916;2768.750812426881;2781.443711257749;2781.9721802781964;4675.322078298645;4750.928736068961;4762.666613337064;4786.593139583135;4796.952030479694;4697.788599513022;4711.78796954137;4756.881077973044;4818.927716084261;4848.587870031043;4346.739195648263;4395.736255824645;4445.110977804436;4451.221036318631;4462.3752674625575;191.75688140200978;4397.868063958071;4410.3825464435;4500.617447516948;4549.818007279705;4487.9551204488025;4493.5506449355125;4511.684182107254;4520.434945631796;4553.408056952608;4249.851255206084;4534.773261336953;4553.4991150973365;4580.175568397687;4580.9541904580865;4332.870013899556;4369.060651959844;4384.12317536494;4425.955740442587;4442.178197033559;4669.41632295963;4713.528647135259;4715.740634265114;4739.810407583693;4789.161896668069;4903.754812259408;5018.548330650259;5202.193659982709;5216.921746173811;5242.370915490127;5085.821996230115;5145.151050076733;5146.897062058775;5183.2743415921805;5279.340082489689;4785.712857228577;4843.927341089921;4857.489963553776;4862.78117484714;4906.043321552299;5075.847724568195;5152;5184.948150518522;5336.573074154058;5350.652207606493;5133.8716532087;5146.948530514722;5154.9484505155215;5164.715940623227;5185;5228.477152284741;5241.135212689864;5246.527812496894;5247.606429517801;5289.153735402394;4910.06708725341;5017.096922553976;5039.042581909425;5155.149400348901;5183.870403239874;5163.199704045879;5164.7934082636275;5166.380034395821;5173.767180476888;5178.792848286026;4290.356446532983;4318.179545886272;4318.373835793793;4339.500957389941;4353.455818022747;3602.6217247189193;3684.7236457265276;3686.3364594372733;3687.3178461984617;3706.7034637229494;4480.260756975063;4523.977380113079;4524.366588677588;4531.728096314166;4576.107659006529;5274.841754747287;5282.075636763551;5289.523942845085;5291.259223708684;5294.788208471618;4283.164782867373;4389.209942210433;4405.933910991338;4513.88715282114;4528.569785870337;4585.564371384713;4590.701604395704;4602.585767280893;4611.446626404786;4645.372874661877;4954.058728841508;4958.281049247839;4960.280759289811;4966.801327946841;5004.074246264453;4954.430240522386;5074.847754567369;5091.770870310919;5137.588992880485;5190.506901844319;4927.679700819435;4969.279454479152;4982.377202849644;4991.850244492671;5025.246213068069;4857.101436234308;5182.97408512955;5204.453532379046;5204.557612602971;5205.713685747321;5065.4174769900455;5137.537621614073;5219.19102539107;5230.869228269172;5277.736113194402;4991.07665081961;5003.974980125076;5039.3448851649055;5040.067587496325;5074.5686616637995;4751.477337492942;4894.241392584155;5076;5096.0827051131155;5101.8724531887;4854.514548545118;4908.165611845923;4912.803487860446;4940.110780059624;4981.37732783402;4972.751362431792;5011.047900898818;5015.322931404214;5020.698758074527;5035.446100928822;4758.571728544448;4864.975675121602;4874.561289483963;4911.901761964812;4963.379577552806 07:05:28 INFO - 2015-12-16 07:05:28,316 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.1477783325015;569.0354848531738;570.2729020498865;572.6564061563063;579.3598074128091;33967.49048764267;34780.65219347809;34862.477062844046;34884.3023139537;34902.65097349026;38892.22215555687;39496.40755388672;39546;39591;39657;7712.151663317045;7804.336631386339;7890.3293220076075;7981.28168464838;7992.680292788282;7724.497907635986;7984.161663025386;8000.919990800105;8004.199580041978;8006.879896801553;7902.328302094329;7979.920200797976;7981.161977992314;7985.600719963979;7987.920120798804;7934.365250779923;7981.161977992285;8020.959895200545;8026.4381493295205;8029.799255018613;7792.41556883236;7838.764837054898;7866.252705992922;7883.36933045355;7964.641591128413;36240.09399765001;36389.27221455582;36553;36586;36634.08414789625;2386.9283921482383;2701.1121639818384;2790.190844655068;2974.3307755755;3011.6988301169927;25937.351566210808;26077.608835867286;26101;26400.07599734;26681;3094.3037816491333;3097.798643088192;3166.5408515765316;3182.0453863840753;3195.8402079896146;174505;174543;174676.12661936608;174874;175954.99999999872;37689.62310376861;38273.024506813934;38328.80835595804;49150.75424622854;49485.75257123692;35440.291194175974;36287.4556881647;36326.636733632324;36433;36487;13104.082714209913;13468.124571902796;13535.729285414236;13538.052336336363;13562.864371356358;10535.473226338652;10606.734831629272;10607.15142788575;10617.575296988189;10650.573977040987;13088.869111308955;13098.279594622196;13170.736585268241;13189.670258243621;13198.076134670673;5431.511163995259;5484.588306857742;5541.33503979525;5558.471945165203;5584.553235741131;858.2790456016976;864.8443280209623;881.7883707910183;915.7481692534607;1083.4366129612558;25875;25988.610170847074;29484.705152948194;29515.85242073776;30688;968.5205823117602;982.5332966840693;1019.3578045831227;1020.6121673763922;1049.1344640671477;13168;13401.53094641683;13440.731185376238;13503.932480337535;13558.728825423435;306521;306627;311650;311881;313138;44407.33388999168;44635.77682111569;45360.77319613381;45375;45668.314975275396;1224.8836360545733;1228.3121451986915;1252.8872401483911;1265.5760320292804;1266.5123927287875;24782.752172478045;25097.749022509543;25429.23712288634;25543.87228063848;25972.480550388507;38791.6120838788;39413.802930986305;39453.802730986165;39520.604793951694;39555.40666890056;241336;242954;243825;243902;244560;29175.7082429173;29488;40813.59186408217;42167;42639;36676.26647466982;37798.81100594479;37835;37860.810695947446;38229.61770382261;32190.517142243352;32514.18714532061;33133;33429.83285083559;33656.83171584126;32276.67723322737;32296.35407291794;32593.837030814695;32600.673993259763;32831.343373132884;32922;32973.50539741858;32987;32994.505082424264;33125.66874331226;28096;28959;29610.00034737206;29641.85179074177;30021.249468763457;24006.39984000344;25158.177477119418;26466.603000955387;26582.86708566445;26721.86639066792 07:05:28 INFO - 2015-12-16 07:05:28,319 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.7939456931273;340.83639852870624;341.8820506925111;343.2705500810777;343.8779233372152;12362.814557781641;12744;15008.924955375222;15198.544043678694;17125.314987400503;14905.180215088165;15234.771478427805;16130.596735081628;16141.596460088504;16214.351425942978;4841.201201801708;4853.126437241295;4921.18800397934;4995.275685025669;5008.223725322581;4975.850724478253;4977.427595826472;4988.176950803131;5006.27409025691;5059.316992206061;4810.9037819243595;4913.803447862099;4940.752962351886;4945.23348880924;4949.886275587982;5003.099442100421;5004.074246264453;5015.974920125413;5029.446760856303;5029.924551131736;4355.651547876194;4419.116176764628;4439.844605438794;4467.731936083813;4518.390017347649;19476.610467790564;19584.51038724029;19852.30516931915;19927.103280352276;19930.800691993183;1843.797182309945;1938.447542450409;1943.8736482128616;1964.882107073566;2030.7360043194437;8561.315094792402;12856.357182140855;12883.162594431333;12993.572539193698;13609;1755.3856150347403;1763.4885883093887;1768.7081631530782;1770.557360659835;1836.742856000161;50550;50802.74598626983;51302;51952.99999999962;56045.71977140129;9240.907590924005;9624.085711857362;9661.661841835643;9674.516274186404;9692.806143877224;10806.189535784848;10984.450777461096;11347.602833900773;12303.384830758427;12332.445039973223;5595.020871347498;5618.157276408489;6325.810225693236;7302.48882578225;7342.4493163012985;7096.432285417154;7121.465890058266;7131.572105673677;7159.856802863914;7176.210616832144;3983.780892050907;4060.634542891154;4093.324601440729;4109.856155034619;4201.264778663722;1706.1725063344268;1728.1532049296006;1741.1729428521605;1753.3074435597866;1800.7388928605278;888.2139306713476;945.333539854401;959.9856002159974;1021.9386836789816;1036.8496567997597;15969.426802238315;15978.360865565248;16045.759313610306;16115;16297.67404651924;862.4221771413169;870.5516658920661;871.7166920750782;904.3172404834309;920.2637889688357;9043.638254469748;9202.769930751785;9250.21373183287;9375.437473751597;9499.335046546676;514051;519470.92742196756;519909;536547;537969;72100.63949680218;72952.63523682454;73822.63088684522;75280;75709;1083.3662307550014;1105.7898999190288;1106.2256420505678;1121.899029087386;1121.9719507012553;14509.201993890438;14659.706805864036;14669.26653667291;14805.333759980611;15194.544163675107;28719.282017949718;32098.037058888272;33363.163236228145;33644;34578.48132277968;35690;37153.442698360086;37192.256154877294;37596.24807503889;38064.23871522609;8010.679572817022;8070.596470176585;8440.24037836573;8512.829743404973;8531.274841638531;12834.67913302175;14952.252387380806;15430.5370838875;15609.609759755642;15753.842461575237;13510.392032358372;13642.386092625657;13846.861531384557;13981.440742370598;14205.28973551339;13618.591442256748;13633.318334083058;13691.520796772065;14039.929800350932;14188.645283867985;13634.181949083088;13636.250006249751;13995.930020349833;14186.574402767934;14623.122612643276;8856.512891791013;8870.02429732716;9048.68329608487;9176.58705358247;9183.954080229556;9367.20378767785;10878.510467028844;13467;13555.457781688621;13662.18026918388 07:05:28 INFO - 2015-12-16 07:05:28,323 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1490.053815826951;1650.0924491529659;1710.657868426315;1717.5019244419118;1748.9799281829487;7042.330978557042;7106.573605583656;7236.059312289395;7280.599567023812;7322.926770732298;7243;7268.0914885639295;7343;7376.55740655561;7383.187849336582;2097.3707887633727;2141.5716856628737;2145.495808485005;2145.6888751131078;2149.7420309562876;2153.8599991000533;2201.680756290337;2202.41635966469;2204.184451752854;2210.8120809731113;2071.513194399315;2119.2264823339524;2125.5855108253895;2157.46063484129;2189.124350259901;2055.691646253059;2093.8010888965523;2101.1280318667737;2110.13484471366;2112.9049192786283;2147.1304121830685;2184.2791878679996;2188.5513469738667;2188.912443502258;2191.6712493126;7283.562986220843;7337.156227033853;7355;7366.668499917517;7367.373773229282;4245.341971994346;4327.004788898539;4331.826726930919;4340.348947657845;4343.283358245885;2744.6157537944705;2768.806183567151;2776.8195067320557;2786.637737094185;2816.985915070432;864.3258258558335;910.1308250620641;917.8623206519009;1585.492642354447;1596.904185748847;9730.610775568968;9913.355631883904;9914.256430767722;9925.255605829592;9937.453440060794;3942.3692209246956;3944.2111577684577;3962.167944731581;4023.879283621496;4036.475258216472;7967.8406431871035;7978.720744774021;7982.880256796153;7983;7987.760367188994;4264.04059086703;4299.806508707115;4331.891702707458;4337.089211265669;4350.847720329773;3938.4683067786054;3954.7429417087797;3987.501562304712;3991.1219531702977;3993.3211354069877;3207.550942868;3236.2556611978907;3241.4651582488627;3246.513023046562;3257.478803391446;957.4398976598628;959.0792838874619;968.6997030920437;984.5520288268821;986.4722373530127;846.9661213551512;888.8266787976282;939.2439086535404;994.7761753605525;1189.5241903238773;6763.797086087426;6808.6936087876165;6817.659117044128;6841.589504629738;6883.518153729191;578.138573525444;582.408855012163;591.8786648736999;604.6221111805122;720.9531380460253;5163.896722065613;5242.397124330751;5307.49578790022;5327.706976116273;5348.090824559834;8171.63227654757;8393.580320983927;8425.957870210732;8693.956530217434;8764;8507.532085735344;8664.176903194186;8668.479891206547;8696.565171741515;8755.781105472413;6515.54391192612;6802.795916122524;6850.6574671266235;6861.4853885957755;6931.133608298963;6806.9659651703405;6911.930880691129;6916.308369163044;6931.514793964374;6940.305969403019;7531.209223031503;7704.884426733492;7729.033870766154;7782.92217077822;7792.688292468238;7812.53124812513;7964.920350796418;8025.23760242776;8032.116467188722;8032.317253033324;6533.118029066015;6583.078369028436;6587.769428069994;6613.437857782143;6613.470922326106;6203.100550420074;6234.501239900887;6252.781152659635;6255;6256.436920677161;5592.133219351007;6480.740770369132;6489.383508566867;6578.638174900427;6627.668616569249;5160.922586161286;6540.215174179129;6595.505337099641;6638.037484564615;6681.432078273401;6691.397774200345;6722.394984451423;6730.730770769114;6734.56225345351;6736.124303840469;6142.078688196628;6159.476444502088;6173.6913154343;6192.535559833121;6221.06683997404;6144.907826382519;6162.691865406622;6236.75052997875;6279.591826531261;6294.0558916162945 07:05:28 INFO - 2015-12-16 07:05:28,323 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.3026248840202;307.6477433338827;310.32659129688574;312.17585574084404;313.80387257963775;5519.806806761764;5540.335159780832;5578.219049333092;5740.339860916001;5764.308283006035;5604.8038318658855;5642.210090587321;5672.319321681393;5676.063449530822;5683.3464151622575;4163.7293575917465;4264.466941632296;4329.502107257674;4339.370791235269;4340.08858139791;4254.978725106385;4269.893252668692;4285.400043993844;4287.635550978155;4315.741055536662;4188.078622703;4206.684498662597;4214.831406743727;4216.219999300124;4226.852060177895;4224.809883555247;4261.126469073848;4274.850380236677;4276.828926842923;4282.48610166782;3639.2357604903004;3708.295423869456;3714.312852122366;3719.4606782016726;3723.7951912644794;5293.682379057269;5396.406395296514;5398.433164517748;5404.270423492857;5418.972905135489;4874.122657921573;4882.7558622068755;4889.902201955941;4890.486498917598;4892.119418504668;5922.97038514809;5924.289085309747;5926.348101708809;5944.7027648617395;5948.434898684618;3877.4377715231417;4007.479027726406;4012.2376748417705;4013.9197216055513;4039.899002524931;6170.907436388457;6217.253929528486;6227.065940108974;6235.064740288993;6235.282942461629;4133.318002529549;4147.108371700038;4148.460700108966;4154.169166166779;4169.1661667665985;4209.3896385024;4214.683898707548;4217.283061879488;4218.367244913226;4224.894377640522;4749.1926372516755;4835.782389792468;4860.684055536379;4861.732604706775;4862.7113814839095;5856.385079566669;5870.853228669317;5883.882322353529;5889.528837692974;5897.7935772247765;1447.182341976801;1489.4414594527052;1489.4637930345068;1490.0314795383088;1494.1184701026446;984.8030393921101;1006.8791744990648;1022.2537547590152;1024.7591815923251;1025.4052649463292;5109.335786347751;5157.329547158845;5159.716215608178;5162.92255616166;5176.50823171798;6138.815835524852;6147.569670123048;6147.84630384244;6147.907781383283;6158.445739883342;5102.642815002914;5149.201873709581;5155.200943853709;5160.948390516121;5164.612654050961;3261.0705948804475;3282.7702060855513;3304.619968703582;3309.6690330966712;3319.987403841803;5680.11958146488;5746.913796293059;5754.136879468113;5756.712164391847;5812.360640329561;6383.202099737533;6389.297177310492;6398.840028999312;6404.7117879695525;6417.2299324081405;5782.508486778671;5845.210896528914;5850.912236316459;5857.062869940789;5863.648181109147;5976.103584462366;6202.069689546604;6203.8138855834395;6204.038374051848;6207.751689932533;6019.789307374221;6063.818085457443;6072.514198864169;6076.848078797889;6080.0575910733905;5838.562107842014;5853.326867410302;5872.236609240771;5872.442117998783;5879.353271140257;4158.313878210061;4189.141226048714;4207.76857272853;4210.494740631144;4211.578842115764;6041.365656605993;6145.539084568586;6169.84575385619;6171.290301615371;6173;5865.706714664335;5894.233749612523;5894.410558944071;5897.5576831736935;5915.792947246826;5887.735051922759;5918.496927761188;5938.346781853907;5938.792142275;5954.166416701752;5622.634528755618;5810.244668193108;5826.184334193301;5826.679532625746;5829;5994.610350327215;6018.067199584071;6020.608660437058;6022.608530445507;6022.789202377896;5860.355360910382;5865.765369385177;5869.442402971711;5872.207252020922;5875.3243377010485 07:05:28 INFO - 2015-12-16 07:05:28,324 DEBUG : BROWSER_OUTPUT: |5;yui.html;774.7056118674905;776.3905334312566;777.6111944027984;780.1847069812046;785.359931655701;11963.880361196385;12125.393730313472;12171.513139474422;12184.695382615428;12209.511619535208;11271.887281127187;11287.209895307331;11293.943530282357;11333.886661133387;11762.470688819003;815.4536460571431;815.975520734379;821.8849361089452;822.0833770346051;830.6137645994611;819.3035919468434;821.109096630157;821.5481485183155;831.7005877883956;838.2120806441956;863.8574635185187;873.1486800369621;874.5758307220992;876.3077169036485;876.7501262140291;846.3609974469298;855.6021450025705;860.178529504325;860.8149247911698;861.5347712235417;633.9175907132089;640.9391107844747;641.3009819296942;641.3394203969872;642.2902692524787;12136.211146275464;12241.938790305992;12243.081768867281;12264.202826816228;12294.077944154224;10877.401742904138;10878.782424351468;11022;11082.390468524229;11225.887741122566;9362;9495.192908602778;9530.666426675103;9584.607442119077;9587.616495340179;3315.436375816093;3336.632970373257;3343.5987681478136;3358.194033431959;3377.290768938526;36767.63232367669;36906.261874762626;37450.43824342637;37669.43495847564;37795;9185.770355741026;9198.172164505228;9215.815683686424;9309.115634014757;9464.621415143318;15821.762673559906;15855.207239637972;15910.76133857993;15911.681766364607;15914.283857226452;6128.601640893327;6290.8427289317215;6499.653371770002;6551.737930482823;6717.966410167918;3519.5011541805607;3532.4348104303704;3546.095745584911;3555.2000799820353;3604.567451905788;2500.2749202731006;2504.699436067647;2540.9237722868343;2545.5418024755722;2562.6027965665353;460.61078388761445;477.07209477566494;479.45821222018895;481.1027433835941;488.2334734466924;591.1753104419397;602.7950496831098;612.3111499562991;646.4279112985042;652.4128284543948;7718.729844455417;8013.198680132056;8097.554634495159;8151.836963260702;8215.753527394188;577.656294504769;612.7487730030755;616.8488720263564;624.09506215987;635.3106879036205;3534.7525673203145;3800.771953682788;3823.0633494793396;3836.961630383716;3865.3622152344547;46231;46473.53526464692;46622.76688616535;46834.76582617065;47036.29445558319;40344;41256.38115428271;41385.58614413817;41708.58291417108;41993;38909;39884.80057599693;40180;41227.1754564907;41618.37572436416;7962;8193.877091843746;8323.791905202419;8461.196186362286;8483.236508714246;29706.55440168356;29803.85098074496;30237.848810756685;30276;30902.53646195264;37442.812785935894;38134.618653814214;38388;38702;39090.218195636495;9996.550155242887;10242.846357304497;10275;10355;10540.104091152338;11044.558217671203;11389.202755807013;11426.085913127095;11491.367974761468;11632.360220187971;10645.201609879445;10909.399983000694;11039.558417663526;11069.833952490559;11513.654590362303;10858.728531786452;10918.23572349928;10918.344899306067;10978.341299522055;11030.779384412106;10391.37651740898;10518;10557.947210264207;10666.786664266827;10812.297200681931;9332.766680833034;9469.10043545862;9474.905250947402;9483.241340692866;9523.904760952579;8785.12148785142;8876.289896808368;8921.375503714678;9077.228435583049;9152.63389464414 07:05:28 INFO - 2015-12-16 07:05:28,324 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:05:28 INFO - 2015-12-16 07:05:28,324 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:05:28 INFO - 2015-12-16 07:05:28,324 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,331 07:05:28 INFO - 2015-12-16 07:05:28,325 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:05:28 INFO - 2015-12-16 07:05:28,325 DEBUG : BROWSER_OUTPUT: __startTimestamp1450278328313__endTimestamp 07:05:28 INFO - 2015-12-16 07:05:28,325 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,325 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:05:28 INFO - 2015-12-16 07:05:28,325 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:05:28 INFO - 2015-12-16 07:05:28,325 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,325 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4740.90 Median:4906.04 stddev:617.82 (12.6%) stddev-sans-first:598.52 07:05:28 INFO - 2015-12-16 07:05:28,326 DEBUG : BROWSER_OUTPUT: Values: 2695.9 2762.4 2768.8 2781.4 2782.0 4675.3 4750.9 4762.7 4786.6 4797.0 4697.8 4711.8 4756.9 4818.9 4848.6 4346.7 4395.7 4445.1 4451.2 4462.4 191.8 4397.9 4410.4 4500.6 4549.8 4488.0 4493.6 4511.7 4520.4 4553.4 4249.9 4534.8 4553.5 4580.2 4581.0 4332.9 4369.1 4384.1 4426.0 4442.2 4669.4 4713.5 4715.7 4739.8 4789.2 4903.8 5018.5 5202.2 5216.9 5242.4 5085.8 5145.2 5146.9 5183.3 5279.3 4785.7 4843.9 4857.5 4862.8 4906.0 5075.8 5152.0 5184.9 5336.6 5350.7 5133.9 5146.9 5154.9 5164.7 5185.0 5228.5 5241.1 5246.5 5247.6 5289.2 4910.1 5017.1 5039.0 5155.1 5183.9 5163.2 5164.8 5166.4 5173.8 5178.8 4290.4 4318.2 4318.4 4339.5 4353.5 3602.6 3684.7 3686.3 3687.3 3706.7 4480.3 4524.0 4524.4 4531.7 4576.1 5274.8 5282.1 5289.5 5291.3 5294.8 4283.2 4389.2 4405.9 4513.9 4528.6 4585.6 4590.7 4602.6 4611.4 4645.4 4954.1 4958.3 4960.3 4966.8 5004.1 4954.4 5074.8 5091.8 5137.6 5190.5 4927.7 4969.3 4982.4 4991.9 5025.2 4857.1 5183.0 5204.5 5204.6 5205.7 5065.4 5137.5 5219.2 5230.9 5277.7 4991.1 5004.0 5039.3 5040.1 5074.6 4751.5 4894.2 5076.0 5096.1 5101.9 4854.5 4908.2 4912.8 4940.1 4981.4 4972.8 5011.0 5015.3 5020.7 5035.4 4758.6 4865.0 4874.6 4911.9 4963.4 07:05:28 INFO - 2015-12-16 07:05:28,326 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,326 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39318.49 Median:32990.75 stddev:65112.28 (197.4%) stddev-sans-first:65229.93 07:05:28 INFO - 2015-12-16 07:05:28,327 DEBUG : BROWSER_OUTPUT: Values: 568.1 569.0 570.3 572.7 579.4 33967.5 34780.7 34862.5 34884.3 34902.7 38892.2 39496.4 39546.0 39591.0 39657.0 7712.2 7804.3 7890.3 7981.3 7992.7 7724.5 7984.2 8000.9 8004.2 8006.9 7902.3 7979.9 7981.2 7985.6 7987.9 7934.4 7981.2 8021.0 8026.4 8029.8 7792.4 7838.8 7866.3 7883.4 7964.6 36240.1 36389.3 36553.0 36586.0 36634.1 2386.9 2701.1 2790.2 2974.3 3011.7 25937.4 26077.6 26101.0 26400.1 26681.0 3094.3 3097.8 3166.5 3182.0 3195.8 174505.0 174543.0 174676.1 174874.0 175955.0 37689.6 38273.0 38328.8 49150.8 49485.8 35440.3 36287.5 36326.6 36433.0 36487.0 13104.1 13468.1 13535.7 13538.1 13562.9 10535.5 10606.7 10607.2 10617.6 10650.6 13088.9 13098.3 13170.7 13189.7 13198.1 5431.5 5484.6 5541.3 5558.5 5584.6 858.3 864.8 881.8 915.7 1083.4 25875.0 25988.6 29484.7 29515.9 30688.0 968.5 982.5 1019.4 1020.6 1049.1 13168.0 13401.5 13440.7 13503.9 13558.7 306521.0 306627.0 311650.0 311881.0 313138.0 44407.3 44635.8 45360.8 45375.0 45668.3 1224.9 1228.3 1252.9 1265.6 1266.5 24782.8 25097.7 25429.2 25543.9 25972.5 38791.6 39413.8 39453.8 39520.6 39555.4 241336.0 242954.0 243825.0 243902.0 244560.0 29175.7 29488.0 40813.6 42167.0 42639.0 36676.3 37798.8 37835.0 37860.8 38229.6 32190.5 32514.2 33133.0 33429.8 33656.8 32276.7 32296.4 32593.8 32600.7 32831.3 32922.0 32973.5 32987.0 32994.5 33125.7 28096.0 28959.0 29610.0 29641.9 30021.2 24006.4 25158.2 26466.6 26582.9 26721.9 07:05:28 INFO - 2015-12-16 07:05:28,327 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,327 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27266.11 Median:36421.72 stddev:85767.60 (235.5%) stddev-sans-first:85984.37 07:05:28 INFO - 2015-12-16 07:05:28,328 DEBUG : BROWSER_OUTPUT: Values: 337.8 340.8 341.9 343.3 343.9 12362.8 12744.0 15008.9 15198.5 17125.3 14905.2 15234.8 16130.6 16141.6 16214.4 4841.2 4853.1 4921.2 4995.3 5008.2 4975.9 4977.4 4988.2 5006.3 5059.3 4810.9 4913.8 4940.8 4945.2 4949.9 5003.1 5004.1 5016.0 5029.4 5029.9 4355.7 4419.1 4439.8 4467.7 4518.4 19476.6 19584.5 19852.3 19927.1 19930.8 1843.8 1938.4 1943.9 1964.9 2030.7 8561.3 12856.4 12883.2 12993.6 13609.0 1755.4 1763.5 1768.7 1770.6 1836.7 50550.0 50802.7 51302.0 51953.0 56045.7 9240.9 9624.1 9661.7 9674.5 9692.8 10806.2 10984.5 11347.6 12303.4 12332.4 5595.0 5618.2 6325.8 7302.5 7342.4 7096.4 7121.5 7131.6 7159.9 7176.2 3983.8 4060.6 4093.3 4109.9 4201.3 1706.2 1728.2 1741.2 1753.3 1800.7 888.2 945.3 960.0 1021.9 1036.8 15969.4 15978.4 16045.8 16115.0 16297.7 862.4 870.6 871.7 904.3 920.3 9043.6 9202.8 9250.2 9375.4 9499.3 514051.0 519470.9 519909.0 536547.0 537969.0 72100.6 72952.6 73822.6 75280.0 75709.0 1083.4 1105.8 1106.2 1121.9 1122.0 14509.2 14659.7 14669.3 14805.3 15194.5 28719.3 32098.0 33363.2 33644.0 34578.5 35690.0 37153.4 37192.3 37596.2 38064.2 8010.7 8070.6 8440.2 8512.8 8531.3 12834.7 14952.3 15430.5 15609.6 15753.8 13510.4 13642.4 13846.9 13981.4 14205.3 13618.6 13633.3 13691.5 14039.9 14188.6 13634.2 13636.3 13995.9 14186.6 14623.1 8856.5 8870.0 9048.7 9176.6 9184.0 9367.2 10878.5 13467.0 13555.5 13662.2 07:05:28 INFO - 2015-12-16 07:05:28,328 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,328 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5047.78 Median:6502.46 stddev:2609.50 (40.1%) stddev-sans-first:2603.12 07:05:28 INFO - 2015-12-16 07:05:28,328 DEBUG : BROWSER_OUTPUT: Values: 1490.1 1650.1 1710.7 1717.5 1749.0 7042.3 7106.6 7236.1 7280.6 7322.9 7243.0 7268.1 7343.0 7376.6 7383.2 2097.4 2141.6 2145.5 2145.7 2149.7 2153.9 2201.7 2202.4 2204.2 2210.8 2071.5 2119.2 2125.6 2157.5 2189.1 2055.7 2093.8 2101.1 2110.1 2112.9 2147.1 2184.3 2188.6 2188.9 2191.7 7283.6 7337.2 7355.0 7366.7 7367.4 4245.3 4327.0 4331.8 4340.3 4343.3 2744.6 2768.8 2776.8 2786.6 2817.0 864.3 910.1 917.9 1585.5 1596.9 9730.6 9913.4 9914.3 9925.3 9937.5 3942.4 3944.2 3962.2 4023.9 4036.5 7967.8 7978.7 7982.9 7983.0 7987.8 4264.0 4299.8 4331.9 4337.1 4350.8 3938.5 3954.7 3987.5 3991.1 3993.3 3207.6 3236.3 3241.5 3246.5 3257.5 957.4 959.1 968.7 984.6 986.5 847.0 888.8 939.2 994.8 1189.5 6763.8 6808.7 6817.7 6841.6 6883.5 578.1 582.4 591.9 604.6 721.0 5163.9 5242.4 5307.5 5327.7 5348.1 8171.6 8393.6 8426.0 8694.0 8764.0 8507.5 8664.2 8668.5 8696.6 8755.8 6515.5 6802.8 6850.7 6861.5 6931.1 6807.0 6911.9 6916.3 6931.5 6940.3 7531.2 7704.9 7729.0 7782.9 7792.7 7812.5 7964.9 8025.2 8032.1 8032.3 6533.1 6583.1 6587.8 6613.4 6613.5 6203.1 6234.5 6252.8 6255.0 6256.4 5592.1 6480.7 6489.4 6578.6 6627.7 5160.9 6540.2 6595.5 6638.0 6681.4 6691.4 6722.4 6730.7 6734.6 6736.1 6142.1 6159.5 6173.7 6192.5 6221.1 6144.9 6162.7 6236.8 6279.6 6294.1 07:05:28 INFO - 2015-12-16 07:05:28,328 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,328 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4887.89 Median:5559.28 stddev:1466.22 (26.4%) stddev-sans-first:1429.31 07:05:28 INFO - 2015-12-16 07:05:28,328 DEBUG : BROWSER_OUTPUT: Values: 299.3 307.6 310.3 312.2 313.8 5519.8 5540.3 5578.2 5740.3 5764.3 5604.8 5642.2 5672.3 5676.1 5683.3 4163.7 4264.5 4329.5 4339.4 4340.1 4255.0 4269.9 4285.4 4287.6 4315.7 4188.1 4206.7 4214.8 4216.2 4226.9 4224.8 4261.1 4274.9 4276.8 4282.5 3639.2 3708.3 3714.3 3719.5 3723.8 5293.7 5396.4 5398.4 5404.3 5419.0 4874.1 4882.8 4889.9 4890.5 4892.1 5923.0 5924.3 5926.3 5944.7 5948.4 3877.4 4007.5 4012.2 4013.9 4039.9 6170.9 6217.3 6227.1 6235.1 6235.3 4133.3 4147.1 4148.5 4154.2 4169.2 4209.4 4214.7 4217.3 4218.4 4224.9 4749.2 4835.8 4860.7 4861.7 4862.7 5856.4 5870.9 5883.9 5889.5 5897.8 1447.2 1489.4 1489.5 1490.0 1494.1 984.8 1006.9 1022.3 1024.8 1025.4 5109.3 5157.3 5159.7 5162.9 5176.5 6138.8 6147.6 6147.8 6147.9 6158.4 5102.6 5149.2 5155.2 5160.9 5164.6 3261.1 3282.8 3304.6 3309.7 3320.0 5680.1 5746.9 5754.1 5756.7 5812.4 6383.2 6389.3 6398.8 6404.7 6417.2 5782.5 5845.2 5850.9 5857.1 5863.6 5976.1 6202.1 6203.8 6204.0 6207.8 6019.8 6063.8 6072.5 6076.8 6080.1 5838.6 5853.3 5872.2 5872.4 5879.4 4158.3 4189.1 4207.8 4210.5 4211.6 6041.4 6145.5 6169.8 6171.3 6173.0 5865.7 5894.2 5894.4 5897.6 5915.8 5887.7 5918.5 5938.3 5938.8 5954.2 5622.6 5810.2 5826.2 5826.7 5829.0 5994.6 6018.1 6020.6 6022.6 6022.8 5860.4 5865.8 5869.4 5872.2 5875.3 07:05:28 INFO - 2015-12-16 07:05:28,329 DEBUG : BROWSER_OUTPUT: 07:05:28 INFO - 2015-12-16 07:05:28,330 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11965.93 Median:41501.98 stddev:13048.51 (31.4%) stddev-sans-first:13058.04 07:05:28 INFO - 2015-12-16 07:05:28,330 DEBUG : BROWSER_OUTPUT: Values: 774.7 776.4 777.6 780.2 785.4 11963.9 12125.4 12171.5 12184.7 12209.5 11271.9 11287.2 11293.9 11333.9 11762.5 815.5 816.0 821.9 822.1 830.6 819.3 821.1 821.5 831.7 838.2 863.9 873.1 874.6 876.3 876.8 846.4 855.6 860.2 860.8 861.5 633.9 640.9 641.3 641.3 642.3 12136.2 12241.9 12243.1 12264.2 12294.1 10877.4 10878.8 11022.0 11082.4 11225.9 9362.0 9495.2 9530.7 9584.6 9587.6 3315.4 3336.6 3343.6 3358.2 3377.3 36767.6 36906.3 37450.4 37669.4 37795.0 9185.8 9198.2 9215.8 9309.1 9464.6 15821.8 15855.2 15910.8 15911.7 15914.3 6128.6 6290.8 6499.7 6551.7 6718.0 3519.5 3532.4 3546.1 3555.2 3604.6 2500.3 2504.7 2540.9 2545.5 2562.6 460.6 477.1 479.5 481.1 488.2 591.2 602.8 612.3 646.4 652.4 7718.7 8013.2 8097.6 8151.8 8215.8 577.7 612.7 616.8 624.1 635.3 3534.8 3800.8 3823.1 3837.0 3865.4 46231.0 46473.5 46622.8 46834.8 47036.3 40344.0 41256.4 41385.6 41708.6 41993.0 38909.0 39884.8 40180.0 41227.2 41618.4 7962.0 8193.9 8323.8 8461.2 8483.2 29706.6 29803.9 30237.8 30276.0 30902.5 37442.8 38134.6 38388.0 38702.0 39090.2 9996.6 10242.8 10275.0 10355.0 10540.1 11044.6 11389.2 11426.1 11491.4 11632.4 10645.2 10909.4 11039.6 11069.8 11513.7 10858.7 10918.2 10918.3 10978.3 11030.8 10391.4 10518.0 10557.9 10666.8 10812.3 9332.8 9469.1 9474.9 9483.2 9523.9 8785.1 8876.3 8921.4 9077.2 9152.6 07:05:28 INFO - 2015-12-16 07:05:28,330 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:05:28 INFO - 2015-12-16 07:05:28,330 DEBUG : BROWSER_OUTPUT: 07:05:29 INFO - 2015-12-16 07:05:29,105 INFO : Browser exited with error code: 0 07:05:29 INFO - 2015-12-16 07:05:29,131 INFO : Completed test dromaeo_css (00:18:39) 07:05:29 INFO - 2015-12-16 07:05:29,131 INFO : Starting test kraken 07:05:29 INFO - 2015-12-16 07:05:29,131 DEBUG : operating with platform_type : linux_ 07:05:29 INFO - 2015-12-16 07:05:29,132 INFO : Initialising browser for kraken test... 07:05:29 INFO - 2015-12-16 07:05:29,138 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZisgow/profile http://localhost:36179/getInfo.html 07:05:34 INFO - 2015-12-16 07:05:34,483 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:05:34 INFO - 2015-12-16 07:05:34,484 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:05:34 INFO - 2015-12-16 07:05:34,484 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:05:34 INFO - 2015-12-16 07:05:34,484 DEBUG : BROWSER_OUTPUT: __metrics 07:05:34 INFO - 2015-12-16 07:05:34,632 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] 07:05:35 INFO - 2015-12-16 07:05:35,565 INFO : Browser initialized. 07:05:35 INFO - 2015-12-16 07:05:35,566 INFO : Running cycle 1/1 for kraken test... 07:05:35 INFO - 2015-12-16 07:05:35,566 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZisgow/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:05:47 INFO - 2015-12-16 07:05:47,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 143044608 07:05:47 INFO - 2015-12-16 07:05:47,620 DEBUG : BROWSER_OUTPUT: 07:05:50 INFO - 2015-12-16 07:05:50,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36179/tests/kraken/driver.html?testName=audio-beat-detection) 07:05:50 INFO - 2015-12-16 07:05:50,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 144146432 07:05:50 INFO - 2015-12-16 07:05:50,822 DEBUG : BROWSER_OUTPUT: 07:05:53 INFO - 2015-12-16 07:05:53,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36179/tests/kraken/driver.html?testName=audio-dft) 07:05:54 INFO - 2015-12-16 07:05:54,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 143646720 07:05:54 INFO - 2015-12-16 07:05:54,186 DEBUG : BROWSER_OUTPUT: 07:05:57 INFO - 2015-12-16 07:05:57,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36179/tests/kraken/driver.html?testName=audio-fft) 07:05:57 INFO - 2015-12-16 07:05:57,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 139055104 07:05:57 INFO - 2015-12-16 07:05:57,671 DEBUG : BROWSER_OUTPUT: 07:05:59 INFO - 2015-12-16 07:05:59,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36179/tests/kraken/driver.html?testName=audio-oscillator) 07:06:00 INFO - 2015-12-16 07:06:00,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 139419648 07:06:00 INFO - 2015-12-16 07:06:00,347 DEBUG : BROWSER_OUTPUT: 07:06:02 INFO - 2015-12-16 07:06:02,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36179/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:06:03 INFO - 2015-12-16 07:06:03,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 139468800 07:06:03 INFO - 2015-12-16 07:06:03,235 DEBUG : BROWSER_OUTPUT: 07:06:06 INFO - 2015-12-16 07:06:06,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36179/tests/kraken/driver.html?testName=imaging-darkroom) 07:06:06 INFO - 2015-12-16 07:06:06,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 140480512 07:06:06 INFO - 2015-12-16 07:06:06,859 DEBUG : BROWSER_OUTPUT: 07:06:10 INFO - 2015-12-16 07:06:10,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36179/tests/kraken/driver.html?testName=imaging-desaturate) 07:06:10 INFO - 2015-12-16 07:06:10,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 141344768 07:06:10 INFO - 2015-12-16 07:06:10,886 DEBUG : BROWSER_OUTPUT: 07:06:13 INFO - 2015-12-16 07:06:13,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36179/tests/kraken/driver.html?testName=json-parse-financial) 07:06:14 INFO - 2015-12-16 07:06:14,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 141635584 07:06:14 INFO - 2015-12-16 07:06:14,431 DEBUG : BROWSER_OUTPUT: 07:06:16 INFO - 2015-12-16 07:06:16,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36179/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:06:16 INFO - 2015-12-16 07:06:16,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 141492224 07:06:16 INFO - 2015-12-16 07:06:16,787 DEBUG : BROWSER_OUTPUT: 07:06:18 INFO - 2015-12-16 07:06:18,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:06:19 INFO - 2015-12-16 07:06:19,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 07:06:19 INFO - 2015-12-16 07:06:19,270 DEBUG : BROWSER_OUTPUT: 07:06:21 INFO - 2015-12-16 07:06:21,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:06:22 INFO - 2015-12-16 07:06:22,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 140447744 07:06:22 INFO - 2015-12-16 07:06:22,009 DEBUG : BROWSER_OUTPUT: 07:06:24 INFO - 2015-12-16 07:06:24,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:06:25 INFO - 2015-12-16 07:06:25,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 141922304 07:06:25 INFO - 2015-12-16 07:06:25,206 DEBUG : BROWSER_OUTPUT: 07:06:27 INFO - 2015-12-16 07:06:27,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:06:28 INFO - 2015-12-16 07:06:28,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 140935168 07:06:28 INFO - 2015-12-16 07:06:28,484 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36179/tests/kraken/driver.html?testName=ai-astar) 07:06:30 INFO - 2015-12-16 07:06:30,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 142438400 07:06:30 INFO - 2015-12-16 07:06:30,497 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,500 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:06:30 INFO - 2015-12-16 07:06:30,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:06:30 INFO - 2015-12-16 07:06:30,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:06:30 INFO - 2015-12-16 07:06:30,501 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:06:30 INFO - 2015-12-16 07:06:30,501 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;110;115;115;115;126;114;116;115;115 07:06:30 INFO - 2015-12-16 07:06:30,501 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;132;155;183;135;155;151;139;172;136 07:06:30 INFO - 2015-12-16 07:06:30,501 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;162;162;164;164;170;161;164;162 07:06:30 INFO - 2015-12-16 07:06:30,501 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;79;140;71;78;72;71;87 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;130;95;96;95;141;95;95;130 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;110;110;110;110;110 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;148;148;149;148;148;148;147;148 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;95;95;96;97;96;96 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;75;73;75;75;76;75;81;70;72 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;68;67;70;68 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;89;86;86;86;86;86;86;96;85 07:06:30 INFO - 2015-12-16 07:06:30,502 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;132;131;128;136;129;128;131;132;129 07:06:30 INFO - 2015-12-16 07:06:30,503 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;153;154;154;153;151;153;154;150;140 07:06:30 INFO - 2015-12-16 07:06:30,503 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;74;71;71;71;69;69;71;71;73 07:06:30 INFO - 2015-12-16 07:06:30,503 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:06:30 INFO - 2015-12-16 07:06:30,503 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:06:30 INFO - 2015-12-16 07:06:30,503 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,784 07:06:30 INFO - 2015-12-16 07:06:30,503 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:06:30 INFO - 2015-12-16 07:06:30,503 DEBUG : BROWSER_OUTPUT: __startTimestamp1450278390499__endTimestamp 07:06:30 INFO - 2015-12-16 07:06:30,504 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,507 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:06:30 INFO - 2015-12-16 07:06:30,507 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:06:30 INFO - 2015-12-16 07:06:30,507 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,507 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.60 Median:115.00 stddev:4.01 (3.5%) stddev-sans-first:4.24 07:06:30 INFO - 2015-12-16 07:06:30,507 DEBUG : BROWSER_OUTPUT: Values: 115.0 110.0 115.0 115.0 115.0 126.0 114.0 116.0 115.0 115.0 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.00 Median:155.00 stddev:16.98 (11.0%) stddev-sans-first:17.62 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: Values: 162.0 132.0 155.0 183.0 135.0 155.0 151.0 139.0 172.0 136.0 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.55 (1.6%) stddev-sans-first:2.65 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 162.0 162.0 164.0 164.0 170.0 161.0 164.0 162.0 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:73.50 stddev:21.03 (28.6%) stddev-sans-first:22.07 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 79.0 140.0 71.0 78.0 72.0 71.0 87.0 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,508 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:18.85 (19.8%) stddev-sans-first:19.51 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 130.0 95.0 96.0 95.0 141.0 95.0 95.0 130.0 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.50 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 148.0 148.0 149.0 148.0 148.0 148.0 147.0 148.0 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 97.0 96.0 96.0 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.60 Median:75.00 stddev:2.88 (3.8%) stddev-sans-first:3.04 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 73.0 75.0 75.0 76.0 75.0 81.0 70.0 72.0 07:06:30 INFO - 2015-12-16 07:06:30,509 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 68.0 67.0 70.0 68.0 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.00 stddev:3.24 (3.8%) stddev-sans-first:3.43 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 86.0 86.0 86.0 86.0 86.0 86.0 96.0 85.0 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:131.00 stddev:3.89 (3.0%) stddev-sans-first:2.55 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: Values: 121.0 132.0 131.0 128.0 136.0 129.0 128.0 131.0 132.0 129.0 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:153.00 stddev:5.53 (3.6%) stddev-sans-first:4.47 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: Values: 140.0 153.0 154.0 154.0 153.0 151.0 153.0 154.0 150.0 140.0 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.56 (2.2%) stddev-sans-first:1.62 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: Values: 70.0 74.0 71.0 71.0 71.0 69.0 69.0 71.0 71.0 73.0 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:06:30 INFO - 2015-12-16 07:06:30,510 DEBUG : BROWSER_OUTPUT: 07:06:31 INFO - 2015-12-16 07:06:31,477 INFO : Browser exited with error code: 0 07:06:31 INFO - 2015-12-16 07:06:31,526 INFO : Completed test kraken (00:01:02) 07:06:31 INFO - 2015-12-16 07:06:31,526 INFO : Starting test v8_7 07:06:31 INFO - 2015-12-16 07:06:31,526 DEBUG : operating with platform_type : linux_ 07:06:31 INFO - 2015-12-16 07:06:31,526 INFO : Initialising browser for v8_7 test... 07:06:31 INFO - 2015-12-16 07:06:31,532 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzUdUU/profile http://localhost:36179/getInfo.html 07:06:36 INFO - 2015-12-16 07:06:36,403 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:06:36 INFO - 2015-12-16 07:06:36,403 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:06:36 INFO - 2015-12-16 07:06:36,403 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:06:36 INFO - 2015-12-16 07:06:36,403 DEBUG : BROWSER_OUTPUT: __metrics 07:06:36 INFO - 2015-12-16 07:06:36,601 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] 07:06:37 INFO - 2015-12-16 07:06:37,473 INFO : Browser initialized. 07:06:37 INFO - 2015-12-16 07:06:37,474 INFO : Running cycle 1/1 for v8_7 test... 07:06:37 INFO - 2015-12-16 07:06:37,474 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzUdUU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:06:49 INFO - 2015-12-16 07:06:49,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 142921728 07:06:49 INFO - 2015-12-16 07:06:49,494 DEBUG : BROWSER_OUTPUT: 07:07:10 INFO - 2015-12-16 07:07:10,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36179/tests/v8_7/run.html (next: http://localhost:36179/tests/v8_7/run.html) 07:07:11 INFO - 2015-12-16 07:07:11,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 137973760 07:07:11 INFO - 2015-12-16 07:07:11,217 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: |0;Richards;164.39256945586058 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.57250612860645 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 07:07:11 INFO - 2015-12-16 07:07:11,219 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 07:07:11 INFO - 2015-12-16 07:07:11,220 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1069.51871657754 07:07:11 INFO - 2015-12-16 07:07:11,220 DEBUG : BROWSER_OUTPUT: |5;Earley;695.8942240779402 07:07:11 INFO - 2015-12-16 07:07:11,220 DEBUG : BROWSER_OUTPUT: |6;Boyer;12228.915662650603 07:07:11 INFO - 2015-12-16 07:07:11,220 DEBUG : BROWSER_OUTPUT: |7;RegExp;26552.63157894737 07:07:11 INFO - 2015-12-16 07:07:11,220 DEBUG : BROWSER_OUTPUT: |8;Splay;592.7682276229995 07:07:11 INFO - 2015-12-16 07:07:11,220 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:07:11 INFO - 2015-12-16 07:07:11,220 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:07:11 INFO - 2015-12-16 07:07:11,221 DEBUG : BROWSER_OUTPUT: __startTimestamp1450278431217__endTimestamp 07:07:11 INFO - 2015-12-16 07:07:11,221 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,222 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:07:11 INFO - 2015-12-16 07:07:11,222 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:07:11 INFO - 2015-12-16 07:07:11,222 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,222 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.39 Median:164.39 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,222 DEBUG : BROWSER_OUTPUT: Values: 164.4 07:07:11 INFO - 2015-12-16 07:07:11,222 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,222 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.57 Median:188.57 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: Values: 188.6 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: Values: 277.8 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: Values: 5202.1 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: Values: 1069.5 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.89 Median:695.89 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: Values: 695.9 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12228.92 Median:12228.92 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,223 DEBUG : BROWSER_OUTPUT: Values: 12228.9 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: Values: 26552.6 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:592.77 Median:592.77 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: Values: 592.8 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:07:11 INFO - 2015-12-16 07:07:11,224 DEBUG : BROWSER_OUTPUT: 07:07:12 INFO - 2015-12-16 07:07:12,157 INFO : Browser exited with error code: 0 07:07:12 INFO - 2015-12-16 07:07:12,172 INFO : Completed test v8_7 (00:00:40) 07:07:12 INFO - 2015-12-16 07:07:12,195 INFO : Completed test suite (00:20:22) 07:07:12 INFO - 2015-12-16 07:07:12,195 DEBUG : Working with test: dromaeo_css 07:07:12 INFO - 2015-12-16 07:07:12,195 DEBUG : Generating results file: dromaeo_css 07:07:12 INFO - 2015-12-16 07:07:12,196 DEBUG : Working with test: kraken 07:07:12 INFO - 2015-12-16 07:07:12,196 DEBUG : Generating results file: kraken 07:07:12 INFO - 2015-12-16 07:07:12,197 INFO : javascript benchmark 07:07:12 INFO - 2015-12-16 07:07:12,197 DEBUG : Working with test: v8_7 07:07:12 INFO - 2015-12-16 07:07:12,197 DEBUG : Generating results file: v8_7 07:07:12 INFO - 2015-12-16 07:07:12,197 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:07:12 INFO - 2015-12-16 07:07:12,251 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:07:12 INFO - 2015-12-16 07:07:12,251 DEBUG : process_Request line: dromaeo_css 6359.45 graph.html#tests=[[72,132,43]] 07:07:12 INFO - 2015-12-16 07:07:12,251 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:07:12 INFO - 2015-12-16 07:07:12,296 DEBUG : process_Request line: kraken 1554.30 graph.html#tests=[[232,132,43]] 07:07:12 INFO - 2015-12-16 07:07:12,296 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:07:12 INFO - 2015-12-16 07:07:12,336 DEBUG : process_Request line: v8_7 21398.37 graph.html#tests=[[230,132,43]] 07:07:12 INFO - 2015-12-16 07:07:12,337 INFO : javascript benchmark 07:07:12 INFO - 2015-12-16 07:07:12,341 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2695.878685459154, 2762.3646561290916, 2768.750812426881, 2781.443711257749, 2781.9721802781964, 4675.322078298645, 4750.928736068961, 4762.666613337064, 4786.593139583135, 4796.952030479694, 4697.788599513022, 4711.78796954137, 4756.881077973044, 4818.927716084261, 4848.587870031043, 4346.739195648263, 4395.736255824645, 4445.110977804436, 4451.221036318631, 4462.3752674625575, 191.75688140200978, 4397.868063958071, 4410.3825464435, 4500.617447516948, 4549.818007279705, 4487.9551204488025, 4493.5506449355125, 4511.684182107254, 4520.434945631796, 4553.408056952608, 4249.851255206084, 4534.773261336953, 4553.4991150973365, 4580.175568397687, 4580.9541904580865, 4332.870013899556, 4369.060651959844, 4384.12317536494, 4425.955740442587, 4442.178197033559, 4669.41632295963, 4713.528647135259, 4715.740634265114, 4739.810407583693, 4789.161896668069, 4903.754812259408, 5018.548330650259, 5202.193659982709, 5216.921746173811, 5242.370915490127, 5085.821996230115, 5145.151050076733, 5146.897062058775, 5183.2743415921805, 5279.340082489689, 4785.712857228577, 4843.927341089921, 4857.489963553776, 4862.78117484714, 4906.043321552299, 5075.847724568195, 5152.0, 5184.948150518522, 5336.573074154058, 5350.652207606493, 5133.8716532087, 5146.948530514722, 5154.9484505155215, 5164.715940623227, 5185.0, 5228.477152284741, 5241.135212689864, 5246.527812496894, 5247.606429517801, 5289.153735402394, 4910.06708725341, 5017.096922553976, 5039.042581909425, 5155.149400348901, 5183.870403239874, 5163.199704045879, 5164.7934082636275, 5166.380034395821, 5173.767180476888, 5178.792848286026, 4290.356446532983, 4318.179545886272, 4318.373835793793, 4339.500957389941, 4353.455818022747, 3602.6217247189193, 3684.7236457265276, 3686.3364594372733, 3687.3178461984617, 3706.7034637229494, 4480.260756975063, 4523.977380113079, 4524.366588677588, 4531.728096314166, 4576.107659006529, 5274.841754747287, 5282.075636763551, 5289.523942845085, 5291.259223708684, 5294.788208471618, 4283.164782867373, 4389.209942210433, 4405.933910991338, 4513.88715282114, 4528.569785870337, 4585.564371384713, 4590.701604395704, 4602.585767280893, 4611.446626404786, 4645.372874661877, 4954.058728841508, 4958.281049247839, 4960.280759289811, 4966.801327946841, 5004.074246264453, 4954.430240522386, 5074.847754567369, 5091.770870310919, 5137.588992880485, 5190.506901844319, 4927.679700819435, 4969.279454479152, 4982.377202849644, 4991.850244492671, 5025.246213068069, 4857.101436234308, 5182.97408512955, 5204.453532379046, 5204.557612602971, 5205.713685747321, 5065.4174769900455, 5137.537621614073, 5219.19102539107, 5230.869228269172, 5277.736113194402, 4991.07665081961, 5003.974980125076, 5039.3448851649055, 5040.067587496325, 5074.5686616637995, 4751.477337492942, 4894.241392584155, 5076.0, 5096.0827051131155, 5101.8724531887, 4854.514548545118, 4908.165611845923, 4912.803487860446, 4940.110780059624, 4981.37732783402, 4972.751362431792, 5011.047900898818, 5015.322931404214, 5020.698758074527, 5035.446100928822, 4758.571728544448, 4864.975675121602, 4874.561289483963, 4911.901761964812, 4963.379577552806], "unit": "score", "name": "dojo.html", "value": 4704.540968977679}, {"lowerIsBetter": false, "replicates": [568.1477783325015, 569.0354848531738, 570.2729020498865, 572.6564061563063, 579.3598074128091, 33967.49048764267, 34780.65219347809, 34862.477062844046, 34884.3023139537, 34902.65097349026, 38892.22215555687, 39496.40755388672, 39546.0, 39591.0, 39657.0, 7712.151663317045, 7804.336631386339, 7890.3293220076075, 7981.28168464838, 7992.680292788282, 7724.497907635986, 7984.161663025386, 8000.919990800105, 8004.199580041978, 8006.879896801553, 7902.328302094329, 7979.920200797976, 7981.161977992314, 7985.600719963979, 7987.920120798804, 7934.365250779923, 7981.161977992285, 8020.959895200545, 8026.4381493295205, 8029.799255018613, 7792.41556883236, 7838.764837054898, 7866.252705992922, 7883.36933045355, 7964.641591128413, 36240.09399765001, 36389.27221455582, 36553.0, 36586.0, 36634.08414789625, 2386.9283921482383, 2701.1121639818384, 2790.190844655068, 2974.3307755755, 3011.6988301169927, 25937.351566210808, 26077.608835867286, 26101.0, 26400.07599734, 26681.0, 3094.3037816491333, 3097.798643088192, 3166.5408515765316, 3182.0453863840753, 3195.8402079896146, 174505.0, 174543.0, 174676.12661936608, 174874.0, 175954.99999999872, 37689.62310376861, 38273.024506813934, 38328.80835595804, 49150.75424622854, 49485.75257123692, 35440.291194175974, 36287.4556881647, 36326.636733632324, 36433.0, 36487.0, 13104.082714209913, 13468.124571902796, 13535.729285414236, 13538.052336336363, 13562.864371356358, 10535.473226338652, 10606.734831629272, 10607.15142788575, 10617.575296988189, 10650.573977040987, 13088.869111308955, 13098.279594622196, 13170.736585268241, 13189.670258243621, 13198.076134670673, 5431.511163995259, 5484.588306857742, 5541.33503979525, 5558.471945165203, 5584.553235741131, 858.2790456016976, 864.8443280209623, 881.7883707910183, 915.7481692534607, 1083.4366129612558, 25875.0, 25988.610170847074, 29484.705152948194, 29515.85242073776, 30688.0, 968.5205823117602, 982.5332966840693, 1019.3578045831227, 1020.6121673763922, 1049.1344640671477, 13168.0, 13401.53094641683, 13440.731185376238, 13503.932480337535, 13558.728825423435, 306521.0, 306627.0, 311650.0, 311881.0, 313138.0, 44407.33388999168, 44635.77682111569, 45360.77319613381, 45375.0, 45668.314975275396, 1224.8836360545733, 1228.3121451986915, 1252.8872401483911, 1265.5760320292804, 1266.5123927287875, 24782.752172478045, 25097.749022509543, 25429.23712288634, 25543.87228063848, 25972.480550388507, 38791.6120838788, 39413.802930986305, 39453.802730986165, 39520.604793951694, 39555.40666890056, 241336.0, 242954.0, 243825.0, 243902.0, 244560.0, 29175.7082429173, 29488.0, 40813.59186408217, 42167.0, 42639.0, 36676.26647466982, 37798.81100594479, 37835.0, 37860.810695947446, 38229.61770382261, 32190.517142243352, 32514.18714532061, 33133.0, 33429.83285083559, 33656.83171584126, 32276.67723322737, 32296.35407291794, 32593.837030814695, 32600.673993259763, 32831.343373132884, 32922.0, 32973.50539741858, 32987.0, 32994.505082424264, 33125.66874331226, 28096.0, 28959.0, 29610.00034737206, 29641.85179074177, 30021.249468763457, 24006.39984000344, 25158.177477119418, 26466.603000955387, 26582.86708566445, 26721.86639066792], "unit": "score", "name": "ext.html", "value": 16158.717238756055}, {"lowerIsBetter": false, "replicates": [337.7939456931273, 340.83639852870624, 341.8820506925111, 343.2705500810777, 343.8779233372152, 12362.814557781641, 12744.0, 15008.924955375222, 15198.544043678694, 17125.314987400503, 14905.180215088165, 15234.771478427805, 16130.596735081628, 16141.596460088504, 16214.351425942978, 4841.201201801708, 4853.126437241295, 4921.18800397934, 4995.275685025669, 5008.223725322581, 4975.850724478253, 4977.427595826472, 4988.176950803131, 5006.27409025691, 5059.316992206061, 4810.9037819243595, 4913.803447862099, 4940.752962351886, 4945.23348880924, 4949.886275587982, 5003.099442100421, 5004.074246264453, 5015.974920125413, 5029.446760856303, 5029.924551131736, 4355.651547876194, 4419.116176764628, 4439.844605438794, 4467.731936083813, 4518.390017347649, 19476.610467790564, 19584.51038724029, 19852.30516931915, 19927.103280352276, 19930.800691993183, 1843.797182309945, 1938.447542450409, 1943.8736482128616, 1964.882107073566, 2030.7360043194437, 8561.315094792402, 12856.357182140855, 12883.162594431333, 12993.572539193698, 13609.0, 1755.3856150347403, 1763.4885883093887, 1768.7081631530782, 1770.557360659835, 1836.742856000161, 50550.0, 50802.74598626983, 51302.0, 51952.99999999962, 56045.71977140129, 9240.907590924005, 9624.085711857362, 9661.661841835643, 9674.516274186404, 9692.806143877224, 10806.189535784848, 10984.450777461096, 11347.602833900773, 12303.384830758427, 12332.445039973223, 5595.020871347498, 5618.157276408489, 6325.810225693236, 7302.48882578225, 7342.4493163012985, 7096.432285417154, 7121.465890058266, 7131.572105673677, 7159.856802863914, 7176.210616832144, 3983.780892050907, 4060.634542891154, 4093.324601440729, 4109.856155034619, 4201.264778663722, 1706.1725063344268, 1728.1532049296006, 1741.1729428521605, 1753.3074435597866, 1800.7388928605278, 888.2139306713476, 945.333539854401, 959.9856002159974, 1021.9386836789816, 1036.8496567997597, 15969.426802238315, 15978.360865565248, 16045.759313610306, 16115.0, 16297.67404651924, 862.4221771413169, 870.5516658920661, 871.7166920750782, 904.3172404834309, 920.2637889688357, 9043.638254469748, 9202.769930751785, 9250.21373183287, 9375.437473751597, 9499.335046546676, 514051.0, 519470.92742196756, 519909.0, 536547.0, 537969.0, 72100.63949680218, 72952.63523682454, 73822.63088684522, 75280.0, 75709.0, 1083.3662307550014, 1105.7898999190288, 1106.2256420505678, 1121.899029087386, 1121.9719507012553, 14509.201993890438, 14659.706805864036, 14669.26653667291, 14805.333759980611, 15194.544163675107, 28719.282017949718, 32098.037058888272, 33363.163236228145, 33644.0, 34578.48132277968, 35690.0, 37153.442698360086, 37192.256154877294, 37596.24807503889, 38064.23871522609, 8010.679572817022, 8070.596470176585, 8440.24037836573, 8512.829743404973, 8531.274841638531, 12834.67913302175, 14952.252387380806, 15430.5370838875, 15609.609759755642, 15753.842461575237, 13510.392032358372, 13642.386092625657, 13846.861531384557, 13981.440742370598, 14205.28973551339, 13618.591442256748, 13633.318334083058, 13691.520796772065, 14039.929800350932, 14188.645283867985, 13634.181949083088, 13636.250006249751, 13995.930020349833, 14186.574402767934, 14623.122612643276, 8856.512891791013, 8870.02429732716, 9048.68329608487, 9176.58705358247, 9183.954080229556, 9367.20378767785, 10878.510467028844, 13467.0, 13555.457781688621, 13662.18026918388], "unit": "score", "name": "jquery.html", "value": 8295.282363712251}, {"lowerIsBetter": false, "replicates": [1490.053815826951, 1650.0924491529659, 1710.657868426315, 1717.5019244419118, 1748.9799281829487, 7042.330978557042, 7106.573605583656, 7236.059312289395, 7280.599567023812, 7322.926770732298, 7243.0, 7268.0914885639295, 7343.0, 7376.55740655561, 7383.187849336582, 2097.3707887633727, 2141.5716856628737, 2145.495808485005, 2145.6888751131078, 2149.7420309562876, 2153.8599991000533, 2201.680756290337, 2202.41635966469, 2204.184451752854, 2210.8120809731113, 2071.513194399315, 2119.2264823339524, 2125.5855108253895, 2157.46063484129, 2189.124350259901, 2055.691646253059, 2093.8010888965523, 2101.1280318667737, 2110.13484471366, 2112.9049192786283, 2147.1304121830685, 2184.2791878679996, 2188.5513469738667, 2188.912443502258, 2191.6712493126, 7283.562986220843, 7337.156227033853, 7355.0, 7366.668499917517, 7367.373773229282, 4245.341971994346, 4327.004788898539, 4331.826726930919, 4340.348947657845, 4343.283358245885, 2744.6157537944705, 2768.806183567151, 2776.8195067320557, 2786.637737094185, 2816.985915070432, 864.3258258558335, 910.1308250620641, 917.8623206519009, 1585.492642354447, 1596.904185748847, 9730.610775568968, 9913.355631883904, 9914.256430767722, 9925.255605829592, 9937.453440060794, 3942.3692209246956, 3944.2111577684577, 3962.167944731581, 4023.879283621496, 4036.475258216472, 7967.8406431871035, 7978.720744774021, 7982.880256796153, 7983.0, 7987.760367188994, 4264.04059086703, 4299.806508707115, 4331.891702707458, 4337.089211265669, 4350.847720329773, 3938.4683067786054, 3954.7429417087797, 3987.501562304712, 3991.1219531702977, 3993.3211354069877, 3207.550942868, 3236.2556611978907, 3241.4651582488627, 3246.513023046562, 3257.478803391446, 957.4398976598628, 959.0792838874619, 968.6997030920437, 984.5520288268821, 986.4722373530127, 846.9661213551512, 888.8266787976282, 939.2439086535404, 994.7761753605525, 1189.5241903238773, 6763.797086087426, 6808.6936087876165, 6817.659117044128, 6841.589504629738, 6883.518153729191, 578.138573525444, 582.408855012163, 591.8786648736999, 604.6221111805122, 720.9531380460253, 5163.896722065613, 5242.397124330751, 5307.49578790022, 5327.706976116273, 5348.090824559834, 8171.63227654757, 8393.580320983927, 8425.957870210732, 8693.956530217434, 8764.0, 8507.532085735344, 8664.176903194186, 8668.479891206547, 8696.565171741515, 8755.781105472413, 6515.54391192612, 6802.795916122524, 6850.6574671266235, 6861.4853885957755, 6931.133608298963, 6806.9659651703405, 6911.930880691129, 6916.308369163044, 6931.514793964374, 6940.305969403019, 7531.209223031503, 7704.884426733492, 7729.033870766154, 7782.92217077822, 7792.688292468238, 7812.53124812513, 7964.920350796418, 8025.23760242776, 8032.116467188722, 8032.317253033324, 6533.118029066015, 6583.078369028436, 6587.769428069994, 6613.437857782143, 6613.470922326106, 6203.100550420074, 6234.501239900887, 6252.781152659635, 6255.0, 6256.436920677161, 5592.133219351007, 6480.740770369132, 6489.383508566867, 6578.638174900427, 6627.668616569249, 5160.922586161286, 6540.215174179129, 6595.505337099641, 6638.037484564615, 6681.432078273401, 6691.397774200345, 6722.394984451423, 6730.730770769114, 6734.56225345351, 6736.124303840469, 6142.078688196628, 6159.476444502088, 6173.6913154343, 6192.535559833121, 6221.06683997404, 6144.907826382519, 6162.691865406622, 6236.75052997875, 6279.591826531261, 6294.0558916162945], "unit": "score", "name": "mootools.html", "value": 4120.194562455831}, {"lowerIsBetter": false, "replicates": [299.3026248840202, 307.6477433338827, 310.32659129688574, 312.17585574084404, 313.80387257963775, 5519.806806761764, 5540.335159780832, 5578.219049333092, 5740.339860916001, 5764.308283006035, 5604.8038318658855, 5642.210090587321, 5672.319321681393, 5676.063449530822, 5683.3464151622575, 4163.7293575917465, 4264.466941632296, 4329.502107257674, 4339.370791235269, 4340.08858139791, 4254.978725106385, 4269.893252668692, 4285.400043993844, 4287.635550978155, 4315.741055536662, 4188.078622703, 4206.684498662597, 4214.831406743727, 4216.219999300124, 4226.852060177895, 4224.809883555247, 4261.126469073848, 4274.850380236677, 4276.828926842923, 4282.48610166782, 3639.2357604903004, 3708.295423869456, 3714.312852122366, 3719.4606782016726, 3723.7951912644794, 5293.682379057269, 5396.406395296514, 5398.433164517748, 5404.270423492857, 5418.972905135489, 4874.122657921573, 4882.7558622068755, 4889.902201955941, 4890.486498917598, 4892.119418504668, 5922.97038514809, 5924.289085309747, 5926.348101708809, 5944.7027648617395, 5948.434898684618, 3877.4377715231417, 4007.479027726406, 4012.2376748417705, 4013.9197216055513, 4039.899002524931, 6170.907436388457, 6217.253929528486, 6227.065940108974, 6235.064740288993, 6235.282942461629, 4133.318002529549, 4147.108371700038, 4148.460700108966, 4154.169166166779, 4169.1661667665985, 4209.3896385024, 4214.683898707548, 4217.283061879488, 4218.367244913226, 4224.894377640522, 4749.1926372516755, 4835.782389792468, 4860.684055536379, 4861.732604706775, 4862.7113814839095, 5856.385079566669, 5870.853228669317, 5883.882322353529, 5889.528837692974, 5897.7935772247765, 1447.182341976801, 1489.4414594527052, 1489.4637930345068, 1490.0314795383088, 1494.1184701026446, 984.8030393921101, 1006.8791744990648, 1022.2537547590152, 1024.7591815923251, 1025.4052649463292, 5109.335786347751, 5157.329547158845, 5159.716215608178, 5162.92255616166, 5176.50823171798, 6138.815835524852, 6147.569670123048, 6147.84630384244, 6147.907781383283, 6158.445739883342, 5102.642815002914, 5149.201873709581, 5155.200943853709, 5160.948390516121, 5164.612654050961, 3261.0705948804475, 3282.7702060855513, 3304.619968703582, 3309.6690330966712, 3319.987403841803, 5680.11958146488, 5746.913796293059, 5754.136879468113, 5756.712164391847, 5812.360640329561, 6383.202099737533, 6389.297177310492, 6398.840028999312, 6404.7117879695525, 6417.2299324081405, 5782.508486778671, 5845.210896528914, 5850.912236316459, 5857.062869940789, 5863.648181109147, 5976.103584462366, 6202.069689546604, 6203.8138855834395, 6204.038374051848, 6207.751689932533, 6019.789307374221, 6063.818085457443, 6072.514198864169, 6076.848078797889, 6080.0575910733905, 5838.562107842014, 5853.326867410302, 5872.236609240771, 5872.442117998783, 5879.353271140257, 4158.313878210061, 4189.141226048714, 4207.76857272853, 4210.494740631144, 4211.578842115764, 6041.365656605993, 6145.539084568586, 6169.84575385619, 6171.290301615371, 6173.0, 5865.706714664335, 5894.233749612523, 5894.410558944071, 5897.5576831736935, 5915.792947246826, 5887.735051922759, 5918.496927761188, 5938.346781853907, 5938.792142275, 5954.166416701752, 5622.634528755618, 5810.244668193108, 5826.184334193301, 5826.679532625746, 5829.0, 5994.610350327215, 6018.067199584071, 6020.608660437058, 6022.608530445507, 6022.789202377896, 5860.355360910382, 5865.765369385177, 5869.442402971711, 5872.207252020922, 5875.3243377010485], "unit": "score", "name": "prototype.html", "value": 4412.31761965686}, {"lowerIsBetter": false, "replicates": [774.7056118674905, 776.3905334312566, 777.6111944027984, 780.1847069812046, 785.359931655701, 11963.880361196385, 12125.393730313472, 12171.513139474422, 12184.695382615428, 12209.511619535208, 11271.887281127187, 11287.209895307331, 11293.943530282357, 11333.886661133387, 11762.470688819003, 815.4536460571431, 815.975520734379, 821.8849361089452, 822.0833770346051, 830.6137645994611, 819.3035919468434, 821.109096630157, 821.5481485183155, 831.7005877883956, 838.2120806441956, 863.8574635185187, 873.1486800369621, 874.5758307220992, 876.3077169036485, 876.7501262140291, 846.3609974469298, 855.6021450025705, 860.178529504325, 860.8149247911698, 861.5347712235417, 633.9175907132089, 640.9391107844747, 641.3009819296942, 641.3394203969872, 642.2902692524787, 12136.211146275464, 12241.938790305992, 12243.081768867281, 12264.202826816228, 12294.077944154224, 10877.401742904138, 10878.782424351468, 11022.0, 11082.390468524229, 11225.887741122566, 9362.0, 9495.192908602778, 9530.666426675103, 9584.607442119077, 9587.616495340179, 3315.436375816093, 3336.632970373257, 3343.5987681478136, 3358.194033431959, 3377.290768938526, 36767.63232367669, 36906.261874762626, 37450.43824342637, 37669.43495847564, 37795.0, 9185.770355741026, 9198.172164505228, 9215.815683686424, 9309.115634014757, 9464.621415143318, 15821.762673559906, 15855.207239637972, 15910.76133857993, 15911.681766364607, 15914.283857226452, 6128.601640893327, 6290.8427289317215, 6499.653371770002, 6551.737930482823, 6717.966410167918, 3519.5011541805607, 3532.4348104303704, 3546.095745584911, 3555.2000799820353, 3604.567451905788, 2500.2749202731006, 2504.699436067647, 2540.9237722868343, 2545.5418024755722, 2562.6027965665353, 460.61078388761445, 477.07209477566494, 479.45821222018895, 481.1027433835941, 488.2334734466924, 591.1753104419397, 602.7950496831098, 612.3111499562991, 646.4279112985042, 652.4128284543948, 7718.729844455417, 8013.198680132056, 8097.554634495159, 8151.836963260702, 8215.753527394188, 577.656294504769, 612.7487730030755, 616.8488720263564, 624.09506215987, 635.3106879036205, 3534.7525673203145, 3800.771953682788, 3823.0633494793396, 3836.961630383716, 3865.3622152344547, 46231.0, 46473.53526464692, 46622.76688616535, 46834.76582617065, 47036.29445558319, 40344.0, 41256.38115428271, 41385.58614413817, 41708.58291417108, 41993.0, 38909.0, 39884.80057599693, 40180.0, 41227.1754564907, 41618.37572436416, 7962.0, 8193.877091843746, 8323.791905202419, 8461.196186362286, 8483.236508714246, 29706.55440168356, 29803.85098074496, 30237.848810756685, 30276.0, 30902.53646195264, 37442.812785935894, 38134.618653814214, 38388.0, 38702.0, 39090.218195636495, 9996.550155242887, 10242.846357304497, 10275.0, 10355.0, 10540.104091152338, 11044.558217671203, 11389.202755807013, 11426.085913127095, 11491.367974761468, 11632.360220187971, 10645.201609879445, 10909.399983000694, 11039.558417663526, 11069.833952490559, 11513.654590362303, 10858.728531786452, 10918.23572349928, 10918.344899306067, 10978.341299522055, 11030.779384412106, 10391.37651740898, 10518.0, 10557.947210264207, 10666.786664266827, 10812.297200681931, 9332.766680833034, 9469.10043545862, 9474.905250947402, 9483.241340692866, 9523.904760952579, 8785.12148785142, 8876.289896808368, 8921.375503714678, 9077.228435583049, 9152.63389464414], "unit": "score", "name": "yui.html", "value": 5769.507288255805}], "name": "dromaeo_css", "value": 6359.455075876788}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 115.0, 115.0, 126.0, 114.0, 116.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [162.0, 132.0, 155.0, 183.0, 135.0, 155.0, 151.0, 139.0, 172.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 162.0, 162.0, 164.0, 164.0, 170.0, 161.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 79.0, 140.0, 71.0, 78.0, 72.0, 71.0, 87.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 130.0, 95.0, 96.0, 95.0, 141.0, 95.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 75.0, 75.0, 76.0, 75.0, 81.0, 70.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 74.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 67.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [88.0, 89.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 96.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [121.0, 132.0, 131.0, 128.0, 136.0, 129.0, 128.0, 131.0, 132.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.7}, {"lowerIsBetter": true, "replicates": [140.0, 153.0, 154.0, 154.0, 153.0, 151.0, 153.0, 154.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 71.0, 71.0, 71.0, 69.0, 69.0, 71.0, 71.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1554.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.39256945586058], "unit": "score", "name": "Richards", "value": 214.742066}, {"lowerIsBetter": false, "replicates": [188.57250612860645], "unit": "score", "name": "DeltaBlue", "value": 350.62375399999996}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1069.51871657754], "unit": "score", "name": "RayTrace", "value": 691.889715}, {"lowerIsBetter": false, "replicates": [695.8942240779402], "unit": "score", "name": "Earley", "value": 957.7073310000004}, {"lowerIsBetter": false, "replicates": [12228.915662650603], "unit": "score", "name": "Boyer", "value": 54.498944827586165}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [592.7682276229995], "unit": "score", "name": "Splay", "value": 137.47531699999993}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21398.373531137237}]} 07:07:12 INFO - RETURN: dromaeo_css: 6359.45 07:07:12 INFO - RETURN: kraken: 1554.30 07:07:12 INFO - RETURN: v8_7: 21398.37 07:07:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21398.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1554.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6359.45"}}} 07:07:12 INFO - Return code: 0 07:07:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:07:12 INFO - # TBPL SUCCESS # 07:07:12 INFO - Running post-action listener: _resource_record_post_action 07:07:12 INFO - Running post-run listener: _resource_record_post_run 07:07:13 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 10448896; Write bytes: 393945088; Read time: 4468; Write time: 596908 07:07:13 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5455872; Read time: 0; Write time: 416 07:07:13 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 8552448; Write bytes: 388489216; Read time: 4068; Write time: 596492 07:07:13 INFO - Running post-run listener: _upload_blobber_files 07:07:13 INFO - Blob upload gear active. 07:07:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:07:13 INFO - Copying logs to upload dir... 07:07:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1293.461813 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-12-16 07:07:13.640191) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 07:07:13.643473) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009807 build_url: 'https://queue.taskcluster.net/v1/task/miQHOh5oTTOnnYZAiT6D0A/artifacts/public/build/firefox-46.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-16 07:07:13.697787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 07:07:13.698425) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450273354.581842-731578562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 07:07:13.748563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 07:07:13.748959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 07:07:13.749319) ========= ========= Total master_lag: 0.25 =========