builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1449669624.21 results: success (0) buildid: 20151209052340 builduid: 9d4aee8eca744cbeabf30cd3e060d81b revision: 64fc74a36a1606092a3cf23b949773b0518908cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.206999) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.207813) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.208155) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006349 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.248132) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.248552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.301981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.302282) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.368031) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.368336) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.368780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.369096) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 06:00:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-09 06:00:28 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107717 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.509175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.509509) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022335 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.581392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:24.581762) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 64fc74a36a1606092a3cf23b949773b0518908cb --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 64fc74a36a1606092a3cf23b949773b0518908cb --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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 06:00:28,382 truncating revision to first 12 chars 2015-12-09 06:00:28,382 Setting DEBUG logging. 2015-12-09 06:00:28,382 attempt 1/10 2015-12-09 06:00:28,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/64fc74a36a16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 06:00:28,635 unpacking tar archive at: fx-team-64fc74a36a16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.150400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.150758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.162254) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.162676) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 06:00:25.163182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-09 06:00:25.163583) ========= /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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:29 INFO - MultiFileLogger online at 20151209 06:00:29 in /builds/slave/test 06:00:29 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:00:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:29 INFO - {'append_to_log': False, 06:00:29 INFO - 'base_work_dir': '/builds/slave/test', 06:00:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:00:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:29 INFO - 'branch': 'Fx-Team-Non-PGO', 06:00:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:29 INFO - 'config_files': ('talos/linux_config.py',), 06:00:29 INFO - 'default_actions': ('clobber', 06:00:29 INFO - 'read-buildbot-config', 06:00:29 INFO - 'download-and-extract', 06:00:29 INFO - 'populate-webroot', 06:00:29 INFO - 'create-virtualenv', 06:00:29 INFO - 'install', 06:00:29 INFO - 'run-tests'), 06:00:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:29 INFO - 'download_minidump_stackwalk': True, 06:00:29 INFO - 'download_symbols': 'ondemand', 06:00:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:29 INFO - 'installer_path': 'installer.exe', 06:00:29 INFO - 'log_level': 'info', 06:00:29 INFO - 'log_name': 'talos', 06:00:29 INFO - 'log_to_console': True, 06:00:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:29 INFO - 'opt_config_files': (), 06:00:29 INFO - 'pip_index': False, 06:00:29 INFO - 'sps_profile': False, 06:00:29 INFO - 'sps_profile_interval': 0, 06:00:29 INFO - 'suite': 'dromaeojs-e10s', 06:00:29 INFO - 'system_bits': '64', 06:00:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:29 INFO - 'title': 'talos-linux64-ix-048', 06:00:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:29 INFO - 'use_talos_json': True, 06:00:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:29 INFO - 'work_dir': 'build'} 06:00:29 INFO - ##### 06:00:29 INFO - ##### Running clobber step. 06:00:29 INFO - ##### 06:00:29 INFO - Running pre-action listener: _resource_record_pre_action 06:00:29 INFO - Running main action method: clobber 06:00:29 INFO - rmtree: /builds/slave/test/build 06:00:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:29 INFO - Running post-action listener: _resource_record_post_action 06:00:29 INFO - ##### 06:00:29 INFO - ##### Running read-buildbot-config step. 06:00:29 INFO - ##### 06:00:29 INFO - Running pre-action listener: _resource_record_pre_action 06:00:29 INFO - Running main action method: read_buildbot_config 06:00:29 INFO - Using buildbot properties: 06:00:29 INFO - { 06:00:29 INFO - "properties": { 06:00:29 INFO - "buildnumber": 556, 06:00:29 INFO - "product": "firefox", 06:00:29 INFO - "script_repo_revision": "production", 06:00:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:00:29 INFO - "repository": "", 06:00:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:00:29 INFO - "buildid": "20151209052340", 06:00:29 INFO - "slavename": "talos-linux64-ix-048", 06:00:29 INFO - "pgo_build": "False", 06:00:29 INFO - "basedir": "/builds/slave/test", 06:00:29 INFO - "project": "", 06:00:29 INFO - "platform": "ubuntu64_hw", 06:00:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:00:29 INFO - "slavebuilddir": "test", 06:00:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:00:29 INFO - "branch": "fx-team", 06:00:29 INFO - "repo_path": "integration/fx-team", 06:00:29 INFO - "stage_platform": "linux64", 06:00:29 INFO - "builduid": "9d4aee8eca744cbeabf30cd3e060d81b", 06:00:29 INFO - "revision": "64fc74a36a1606092a3cf23b949773b0518908cb" 06:00:29 INFO - }, 06:00:29 INFO - "sourcestamp": { 06:00:29 INFO - "repository": "", 06:00:29 INFO - "hasPatch": false, 06:00:29 INFO - "project": "", 06:00:29 INFO - "branch": "fx-team-linux64-talos", 06:00:29 INFO - "changes": [ 06:00:29 INFO - { 06:00:29 INFO - "category": null, 06:00:29 INFO - "files": [ 06:00:29 INFO - { 06:00:29 INFO - "url": null, 06:00:29 INFO - "name": "https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:00:29 INFO - } 06:00:29 INFO - ], 06:00:29 INFO - "repository": "", 06:00:29 INFO - "rev": "64fc74a36a1606092a3cf23b949773b0518908cb", 06:00:29 INFO - "who": "cbook@mozilla.com", 06:00:29 INFO - "when": 1449669523, 06:00:29 INFO - "number": 7153036, 06:00:29 INFO - "comments": "Backed out changeset e2708b9fdadc (bug 1137681) for test failures in browser_ua_emulation.js", 06:00:29 INFO - "project": "", 06:00:29 INFO - "at": "Wed 09 Dec 2015 05:58:43", 06:00:29 INFO - "branch": "fx-team-linux64-talos", 06:00:29 INFO - "revlink": "", 06:00:29 INFO - "properties": [ 06:00:29 INFO - [ 06:00:29 INFO - "buildid", 06:00:29 INFO - "20151209052340", 06:00:29 INFO - "Change" 06:00:29 INFO - ], 06:00:29 INFO - [ 06:00:29 INFO - "builduid", 06:00:29 INFO - "9d4aee8eca744cbeabf30cd3e060d81b", 06:00:29 INFO - "Change" 06:00:29 INFO - ], 06:00:29 INFO - [ 06:00:29 INFO - "pgo_build", 06:00:29 INFO - "False", 06:00:29 INFO - "Change" 06:00:29 INFO - ] 06:00:29 INFO - ], 06:00:29 INFO - "revision": "64fc74a36a1606092a3cf23b949773b0518908cb" 06:00:29 INFO - } 06:00:29 INFO - ], 06:00:29 INFO - "revision": "64fc74a36a1606092a3cf23b949773b0518908cb" 06:00:29 INFO - } 06:00:29 INFO - } 06:00:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:00:29 INFO - Running post-action listener: _resource_record_post_action 06:00:29 INFO - ##### 06:00:29 INFO - ##### Running download-and-extract step. 06:00:29 INFO - ##### 06:00:29 INFO - Running pre-action listener: _resource_record_pre_action 06:00:29 INFO - Running main action method: download_and_extract 06:00:29 INFO - mkdir: /builds/slave/test/build/tests 06:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:29 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json 06:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json 06:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:00:30 INFO - Downloaded 1302 bytes. 06:00:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:00:30 INFO - Using the following test package requirements: 06:00:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:30 INFO - u'jsshell-linux-x86_64.zip'], 06:00:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00: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:00:30 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:32 INFO - Downloaded 21860154 bytes. 06:00:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:00:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:00:33 INFO - Return code: 0 06:00:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:00:33 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:00:33 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:38 INFO - Downloaded 21860154 bytes. 06:00:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:00:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:00:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:00:39 INFO - Return code: 0 06:00:39 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:00:39 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:00:40 INFO - Downloaded 11132038 bytes. 06:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 06:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:00:40 INFO - Return code: 0 06:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:40 INFO - https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:00:43 INFO - Downloaded 57728114 bytes. 06:00:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:43 INFO - mkdir: /builds/slave/test/properties 06:00:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:43 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:43 INFO - Contents: 06:00:43 INFO - build_url:https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:00:43 INFO - Running post-action listener: _resource_record_post_action 06:00:43 INFO - Running post-action listener: set_extra_try_arguments 06:00:43 INFO - ##### 06:00:43 INFO - ##### Running populate-webroot step. 06:00:43 INFO - ##### 06:00:43 INFO - Running pre-action listener: _resource_record_pre_action 06:00:43 INFO - Running main action method: populate_webroot 06:00:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:43 INFO - '--tppagecycles', 06:00:43 INFO - '7'], 06:00:43 INFO - 'tests': ['tsvgm']}}, 06:00:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:00:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'tests': ['damp', 'tps']}, 06:00:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['damp', 'tps']}, 06:00:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:00:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:43 INFO - 'other': {'tests': ['a11yr', 06:00:43 INFO - 'ts_paint', 06:00:43 INFO - 'tpaint', 06:00:43 INFO - 'sessionrestore', 06:00:43 INFO - 'sessionrestore_no_auto_restore']}, 06:00:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['a11yr', 06:00:43 INFO - 'ts_paint', 06:00:43 INFO - 'tpaint', 06:00:43 INFO - 'sessionrestore', 06:00:43 INFO - 'sessionrestore_no_auto_restore']}, 06:00:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['a11yr', 06:00:43 INFO - 'ts_paint', 06:00:43 INFO - 'tpaint', 06:00:43 INFO - 'sessionrestore', 06:00:43 INFO - 'sessionrestore_no_auto_restore']}, 06:00:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['a11yr', 06:00:43 INFO - 'ts_paint', 06:00:43 INFO - 'tpaint', 06:00:43 INFO - 'sessionrestore', 06:00:43 INFO - 'sessionrestore_no_auto_restore']}, 06:00:43 INFO - 'other_l64': {'tests': ['a11yr', 06:00:43 INFO - 'ts_paint', 06:00:43 INFO - 'tpaint', 06:00:43 INFO - 'sessionrestore', 06:00:43 INFO - 'sessionrestore_no_auto_restore']}, 06:00:43 INFO - 'other_nol64': {'tests': ['a11yr', 06:00:43 INFO - 'ts_paint', 06:00:43 INFO - 'tpaint', 06:00:43 INFO - 'sessionrestore', 06:00:43 INFO - 'sessionrestore_no_auto_restore']}, 06:00:43 INFO - 'svgr': {'tests': ['tsvgx', 06:00:43 INFO - 'tsvgr_opacity', 06:00:43 INFO - 'tart', 06:00:43 INFO - 'tscrollx', 06:00:43 INFO - 'cart']}, 06:00:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['tsvgx', 06:00:43 INFO - 'tsvgr_opacity', 06:00:43 INFO - 'tart', 06:00:43 INFO - 'tscrollx', 06:00:43 INFO - 'cart']}, 06:00:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'tests': ['tp5o']}, 06:00:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'talos_options': ['--e10s'], 06:00:43 INFO - 'tests': ['tp5o']}, 06:00:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'talos_options': ['--xperf_path', 06:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:43 INFO - 'tests': ['tp5n']}, 06:00:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:43 INFO - 'talos_options': ['--e10s', 06:00:43 INFO - '--xperf_path', 06:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:43 INFO - 'tests': ['tp5n']}}, 06:00:43 INFO - 'talos.zip': {'path': '', 06:00:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:43 INFO - Running post-action listener: _resource_record_post_action 06:00:43 INFO - ##### 06:00:43 INFO - ##### Running create-virtualenv step. 06:00:43 INFO - ##### 06:00:43 INFO - Running pre-action listener: _resource_record_pre_action 06:00:43 INFO - Running main action method: create_virtualenv 06:00:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:43 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:00:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:44 INFO - Using real prefix '/usr' 06:00:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:44 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:46 INFO - Installing pip.................done. 06:00:46 INFO - Return code: 0 06:00:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:00:46 INFO - Using env: {'DISPLAY': ':0', 06:00:46 INFO - 'HOME': '/home/cltbld', 06:00:46 INFO - 'LANG': 'en_US.UTF-8', 06:00:46 INFO - 'LANGUAGE': 'en_US:en', 06:00:46 INFO - 'LOGNAME': 'cltbld', 06:00:46 INFO - 'MAIL': '/var/mail/cltbld', 06:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:46 INFO - 'MOZ_NO_REMOTE': '1', 06:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:46 INFO - 'NO_EM_RESTART': '1', 06:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:46 INFO - 'PWD': '/builds/slave/test', 06:00:46 INFO - 'SHELL': '/bin/bash', 06:00:46 INFO - 'SHLVL': '1', 06:00:46 INFO - 'TERM': 'linux', 06:00:46 INFO - 'TMOUT': '86400', 06:00:46 INFO - 'USER': 'cltbld', 06:00:46 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:46 INFO - '_': '/tools/buildbot/bin/python'} 06:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:46 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:00:46 INFO - Cleaning up... 06:00:46 INFO - Return code: 0 06:00:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:00:46 INFO - Using env: {'DISPLAY': ':0', 06:00:46 INFO - 'HOME': '/home/cltbld', 06:00:46 INFO - 'LANG': 'en_US.UTF-8', 06:00:46 INFO - 'LANGUAGE': 'en_US:en', 06:00:46 INFO - 'LOGNAME': 'cltbld', 06:00:46 INFO - 'MAIL': '/var/mail/cltbld', 06:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:46 INFO - 'MOZ_NO_REMOTE': '1', 06:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:46 INFO - 'NO_EM_RESTART': '1', 06:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:46 INFO - 'PWD': '/builds/slave/test', 06:00:46 INFO - 'SHELL': '/bin/bash', 06:00:46 INFO - 'SHLVL': '1', 06:00:46 INFO - 'TERM': 'linux', 06:00:46 INFO - 'TMOUT': '86400', 06:00:46 INFO - 'USER': 'cltbld', 06:00:46 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:46 INFO - '_': '/tools/buildbot/bin/python'} 06:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:46 INFO - Downloading/unpacking psutil>=0.7.1 06:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:48 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:00:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:48 INFO - Installing collected packages: psutil 06:00:48 INFO - Running setup.py install for psutil 06:00:48 INFO - building 'psutil._psutil_linux' extension 06:00:48 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:00:49 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:00:49 INFO - building 'psutil._psutil_posix' extension 06:00:49 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:00:49 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:00:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:49 INFO - Successfully installed psutil 06:00:49 INFO - Cleaning up... 06:00:49 INFO - Return code: 0 06:00:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:49 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 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:00:49 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:00:49 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:00:49 INFO - Using env: {'DISPLAY': ':0', 06:00:49 INFO - 'HOME': '/home/cltbld', 06:00:49 INFO - 'LANG': 'en_US.UTF-8', 06:00:49 INFO - 'LANGUAGE': 'en_US:en', 06:00:49 INFO - 'LOGNAME': 'cltbld', 06:00:49 INFO - 'MAIL': '/var/mail/cltbld', 06:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:49 INFO - 'MOZ_NO_REMOTE': '1', 06:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:49 INFO - 'NO_EM_RESTART': '1', 06:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:49 INFO - 'PWD': '/builds/slave/test', 06:00:49 INFO - 'SHELL': '/bin/bash', 06:00:49 INFO - 'SHLVL': '1', 06:00:49 INFO - 'TERM': 'linux', 06:00:49 INFO - 'TMOUT': '86400', 06:00:49 INFO - 'USER': 'cltbld', 06:00:49 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:49 INFO - '_': '/tools/buildbot/bin/python'} 06:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00:49 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:00:49 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:00:49 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:00:49 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:00:49 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:00:49 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:00:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:51 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:00:51 INFO - Installing collected packages: mozsystemmonitor 06:00:51 INFO - Running setup.py install for mozsystemmonitor 06:00:51 INFO - Successfully installed mozsystemmonitor 06:00:51 INFO - Cleaning up... 06:00:51 INFO - Return code: 0 06:00:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00:51 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:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:51 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:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:51 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 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:00:51 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:00:51 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:00:51 INFO - Using env: {'DISPLAY': ':0', 06:00:51 INFO - 'HOME': '/home/cltbld', 06:00:51 INFO - 'LANG': 'en_US.UTF-8', 06:00:51 INFO - 'LANGUAGE': 'en_US:en', 06:00:51 INFO - 'LOGNAME': 'cltbld', 06:00:51 INFO - 'MAIL': '/var/mail/cltbld', 06:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:51 INFO - 'MOZ_NO_REMOTE': '1', 06:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:51 INFO - 'NO_EM_RESTART': '1', 06:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:51 INFO - 'PWD': '/builds/slave/test', 06:00:51 INFO - 'SHELL': '/bin/bash', 06:00:51 INFO - 'SHLVL': '1', 06:00:51 INFO - 'TERM': 'linux', 06:00:51 INFO - 'TMOUT': '86400', 06:00:51 INFO - 'USER': 'cltbld', 06:00:51 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:51 INFO - '_': '/tools/buildbot/bin/python'} 06:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:51 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:51 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:00:51 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:00:51 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:00:51 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:00:51 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:00:51 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:00:53 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:00:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:53 INFO - Downloading docopt-0.6.1.tar.gz 06:00:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:54 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:54 INFO - Running setup.py install for blobuploader 06:00:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:00:54 INFO - Running setup.py install for requests 06:00:54 INFO - Running setup.py install for docopt 06:00:54 INFO - Successfully installed blobuploader requests docopt 06:00:54 INFO - Cleaning up... 06:00:54 INFO - Return code: 0 06:00:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:54 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:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 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 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:00:54 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:00:54 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:00:54 INFO - Using env: {'DISPLAY': ':0', 06:00:54 INFO - 'HOME': '/home/cltbld', 06:00:54 INFO - 'LANG': 'en_US.UTF-8', 06:00:54 INFO - 'LANGUAGE': 'en_US:en', 06:00:54 INFO - 'LOGNAME': 'cltbld', 06:00:54 INFO - 'MAIL': '/var/mail/cltbld', 06:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:54 INFO - 'MOZ_NO_REMOTE': '1', 06:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:54 INFO - 'NO_EM_RESTART': '1', 06:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:54 INFO - 'PWD': '/builds/slave/test', 06:00:54 INFO - 'SHELL': '/bin/bash', 06:00:54 INFO - 'SHLVL': '1', 06:00:54 INFO - 'TERM': 'linux', 06:00:54 INFO - 'TMOUT': '86400', 06:00:54 INFO - 'USER': 'cltbld', 06:00:54 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:54 INFO - '_': '/tools/buildbot/bin/python'} 06:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:54 INFO - Running setup.py (path:/tmp/pip-T_xYaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:54 INFO - Running setup.py (path:/tmp/pip-Sc40w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:54 INFO - Running setup.py (path:/tmp/pip-CXFW3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:55 INFO - Running setup.py (path:/tmp/pip-UKRZBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:55 INFO - Running setup.py (path:/tmp/pip-MVVEK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:55 INFO - Running setup.py (path:/tmp/pip-Rx_gue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:55 INFO - Running setup.py (path:/tmp/pip-8WuwGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:55 INFO - Running setup.py (path:/tmp/pip-h0JX6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:55 INFO - Running setup.py (path:/tmp/pip-swQlGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:55 INFO - Running setup.py (path:/tmp/pip-ipSc9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:55 INFO - Running setup.py (path:/tmp/pip-7RHSFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:55 INFO - Running setup.py (path:/tmp/pip-aqbs7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:55 INFO - Running setup.py (path:/tmp/pip-lxUZjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:55 INFO - Running setup.py (path:/tmp/pip-D9tM4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:55 INFO - Running setup.py (path:/tmp/pip-p2AT3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:55 INFO - Running setup.py (path:/tmp/pip-0jkjVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:55 INFO - Running setup.py (path:/tmp/pip-h1vdCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:56 INFO - Running setup.py install for manifestparser 06:00:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Running setup.py install for mozcrash 06:00:56 INFO - Running setup.py install for mozdebug 06:00:56 INFO - Running setup.py install for mozdevice 06:00:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Running setup.py install for mozfile 06:00:56 INFO - Running setup.py install for mozhttpd 06:00:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Running setup.py install for mozinfo 06:00:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Running setup.py install for mozInstall 06:00:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:00:56 INFO - Running setup.py install for mozleak 06:00:56 INFO - Running setup.py install for mozlog 06:00:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:00:57 INFO - Running setup.py install for moznetwork 06:00:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:00:57 INFO - Running setup.py install for mozprocess 06:00:57 INFO - Running setup.py install for mozprofile 06:00:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:00:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:00:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:00:57 INFO - Running setup.py install for mozrunner 06:00:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:00:57 INFO - Running setup.py install for mozscreenshot 06:00:57 INFO - Running setup.py install for moztest 06:00:57 INFO - Running setup.py install for mozversion 06:00:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:00:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:57 INFO - Cleaning up... 06:00:57 INFO - Return code: 0 06:00:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:00:57 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:00:57 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:00:57 INFO - Using env: {'DISPLAY': ':0', 06:00:57 INFO - 'HOME': '/home/cltbld', 06:00:57 INFO - 'LANG': 'en_US.UTF-8', 06:00:57 INFO - 'LANGUAGE': 'en_US:en', 06:00:57 INFO - 'LOGNAME': 'cltbld', 06:00:57 INFO - 'MAIL': '/var/mail/cltbld', 06:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:57 INFO - 'MOZ_NO_REMOTE': '1', 06:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:57 INFO - 'NO_EM_RESTART': '1', 06:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:57 INFO - 'PWD': '/builds/slave/test', 06:00:57 INFO - 'SHELL': '/bin/bash', 06:00:57 INFO - 'SHLVL': '1', 06:00:57 INFO - 'TERM': 'linux', 06:00:57 INFO - 'TMOUT': '86400', 06:00:57 INFO - 'USER': 'cltbld', 06:00:57 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:57 INFO - '_': '/tools/buildbot/bin/python'} 06:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:58 INFO - Running setup.py (path:/tmp/pip-2vcrCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:58 INFO - Running setup.py (path:/tmp/pip-hffjkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:58 INFO - Running setup.py (path:/tmp/pip-zk6EL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:58 INFO - Running setup.py (path:/tmp/pip-qeLmQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:58 INFO - Running setup.py (path:/tmp/pip-zwdwo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:58 INFO - Running setup.py (path:/tmp/pip-oAMj7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:58 INFO - Running setup.py (path:/tmp/pip-Z_NdIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:58 INFO - Running setup.py (path:/tmp/pip-vmbTBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:58 INFO - Running setup.py (path:/tmp/pip-ASb_pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:58 INFO - Running setup.py (path:/tmp/pip-5mv7cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:58 INFO - Running setup.py (path:/tmp/pip-S9He3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:58 INFO - Running setup.py (path:/tmp/pip-qHWCjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:58 INFO - Running setup.py (path:/tmp/pip-MiqmWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:58 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:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:59 INFO - Running setup.py (path:/tmp/pip-cwg8R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:59 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:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:59 INFO - Running setup.py (path:/tmp/pip-7zFiDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:59 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:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:59 INFO - Running setup.py (path:/tmp/pip-wMMXFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:59 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:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:59 INFO - Running setup.py (path:/tmp/pip-ZMi6u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:00:59 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:00:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:00 INFO - Downloading blessings-1.5.1.tar.gz 06:01:00 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:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:01 INFO - Installing collected packages: blessings 06:01:01 INFO - Running setup.py install for blessings 06:01:01 INFO - Successfully installed blessings 06:01:01 INFO - Cleaning up... 06:01:01 INFO - Return code: 0 06:01:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:01 INFO - Reading from file tmpfile_stdout 06:01:01 INFO - Current package versions: 06:01:01 INFO - argparse == 1.2.1 06:01:01 INFO - blessings == 1.5.1 06:01:01 INFO - blobuploader == 1.2.4 06:01:01 INFO - docopt == 0.6.1 06:01:01 INFO - manifestparser == 1.1 06:01:01 INFO - mozInstall == 1.12 06:01:01 INFO - mozcrash == 0.16 06:01:01 INFO - mozdebug == 0.1 06:01:01 INFO - mozdevice == 0.47 06:01:01 INFO - mozfile == 1.2 06:01:01 INFO - mozhttpd == 0.7 06:01:01 INFO - mozinfo == 0.9 06:01:01 INFO - mozleak == 0.1 06:01:01 INFO - mozlog == 3.1 06:01:01 INFO - moznetwork == 0.27 06:01:01 INFO - mozprocess == 0.22 06:01:01 INFO - mozprofile == 0.27 06:01:01 INFO - mozrunner == 6.11 06:01:01 INFO - mozscreenshot == 0.1 06:01:01 INFO - mozsystemmonitor == 0.0 06:01:01 INFO - moztest == 0.7 06:01:01 INFO - mozversion == 1.4 06:01:01 INFO - psutil == 3.1.1 06:01:01 INFO - requests == 1.2.3 06:01:01 INFO - wsgiref == 0.1.2 06:01:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:01:01 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:01:01 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:01:01 INFO - Using env: {'DISPLAY': ':0', 06:01:01 INFO - 'HOME': '/home/cltbld', 06:01:01 INFO - 'LANG': 'en_US.UTF-8', 06:01:01 INFO - 'LANGUAGE': 'en_US:en', 06:01:01 INFO - 'LOGNAME': 'cltbld', 06:01:01 INFO - 'MAIL': '/var/mail/cltbld', 06:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:01 INFO - 'MOZ_NO_REMOTE': '1', 06:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:01 INFO - 'NO_EM_RESTART': '1', 06:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:01 INFO - 'PWD': '/builds/slave/test', 06:01:01 INFO - 'SHELL': '/bin/bash', 06:01:01 INFO - 'SHLVL': '1', 06:01:01 INFO - 'TERM': 'linux', 06:01:01 INFO - 'TMOUT': '86400', 06:01:01 INFO - 'USER': 'cltbld', 06:01:01 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:01 INFO - '_': '/tools/buildbot/bin/python'} 06:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 INFO - Cleaning up... 06:01:01 INFO - Return code: 0 06:01:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:01:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:01:01 INFO - Using env: {'DISPLAY': ':0', 06:01:01 INFO - 'HOME': '/home/cltbld', 06:01:01 INFO - 'LANG': 'en_US.UTF-8', 06:01:01 INFO - 'LANGUAGE': 'en_US:en', 06:01:01 INFO - 'LOGNAME': 'cltbld', 06:01:01 INFO - 'MAIL': '/var/mail/cltbld', 06:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:01 INFO - 'MOZ_NO_REMOTE': '1', 06:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:01 INFO - 'NO_EM_RESTART': '1', 06:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:01 INFO - 'PWD': '/builds/slave/test', 06:01:01 INFO - 'SHELL': '/bin/bash', 06:01:01 INFO - 'SHLVL': '1', 06:01:01 INFO - 'TERM': 'linux', 06:01:01 INFO - 'TMOUT': '86400', 06:01:01 INFO - 'USER': 'cltbld', 06:01:01 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:01 INFO - '_': '/tools/buildbot/bin/python'} 06:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:01 INFO - Downloading/unpacking jsonschema 06:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:01 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:01:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:03 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:01:03 INFO - Downloading/unpacking functools32 (from jsonschema) 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:03 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:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:03 INFO - warning: no files found matching '*.txt' 06:01:03 INFO - no previously-included directories found matching 'build' 06:01:03 INFO - no previously-included directories found matching 'dist' 06:01:03 INFO - no previously-included directories found matching '.git*' 06:01:03 INFO - Installing collected packages: jsonschema, functools32 06:01:03 INFO - Running setup.py install for functools32 06:01:03 INFO - warning: no files found matching '*.txt' 06:01:03 INFO - no previously-included directories found matching 'build' 06:01:03 INFO - no previously-included directories found matching 'dist' 06:01:03 INFO - no previously-included directories found matching '.git*' 06:01:03 INFO - Successfully installed jsonschema functools32 06:01:03 INFO - Cleaning up... 06:01:04 INFO - Return code: 0 06:01:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:01: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:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885958ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', '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:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:01:04 INFO - Using env: {'DISPLAY': ':0', 06:01:04 INFO - 'HOME': '/home/cltbld', 06:01:04 INFO - 'LANG': 'en_US.UTF-8', 06:01:04 INFO - 'LANGUAGE': 'en_US:en', 06:01:04 INFO - 'LOGNAME': 'cltbld', 06:01:04 INFO - 'MAIL': '/var/mail/cltbld', 06:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:04 INFO - 'MOZ_NO_REMOTE': '1', 06:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:04 INFO - 'NO_EM_RESTART': '1', 06:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:04 INFO - 'PWD': '/builds/slave/test', 06:01:04 INFO - 'SHELL': '/bin/bash', 06:01:04 INFO - 'SHLVL': '1', 06:01:04 INFO - 'TERM': 'linux', 06:01:04 INFO - 'TMOUT': '86400', 06:01:04 INFO - 'USER': 'cltbld', 06:01:04 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:04 INFO - '_': '/tools/buildbot/bin/python'} 06:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:04 INFO - Downloading/unpacking flake8 06:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:01:05 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:01:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:01:06 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:01:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:06 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:01:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:06 INFO - no previously-included directories found matching 'docs/_build' 06:01:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:01:06 INFO - Running setup.py install for pep8 06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:01:06 INFO - no previously-included directories found matching 'docs/_build' 06:01:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:01:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:01:06 INFO - Cleaning up... 06:01:06 INFO - Return code: 0 06:01:06 INFO - Running post-action listener: _resource_record_post_action 06:01:06 INFO - Running post-action listener: _start_resource_monitoring 06:01:06 INFO - Starting resource monitoring. 06:01:06 INFO - ##### 06:01:06 INFO - ##### Running install step. 06:01:06 INFO - ##### 06:01:06 INFO - Running pre-action listener: _resource_record_pre_action 06:01:06 INFO - Running main action method: install 06:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:07 INFO - Reading from file tmpfile_stdout 06:01:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:07 INFO - Reading from file tmpfile_stdout 06:01:07 INFO - Output received: 06:01:07 INFO - Usage: mozinstall [options] installer 06:01:07 INFO - Options: 06:01:07 INFO - -h, --help show this help message and exit 06:01:07 INFO - -d DEST, --destination=DEST 06:01:07 INFO - Directory to install application into. [default: 06:01:07 INFO - "/builds/slave/test"] 06:01:07 INFO - --app=APP Application being installed. [default: firefox] 06:01:07 INFO - mkdir: /builds/slave/test/build/application 06:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:01:21 INFO - Reading from file tmpfile_stdout 06:01:21 INFO - Output received: 06:01:21 INFO - /builds/slave/test/build/application/firefox/firefox 06:01:21 INFO - Running post-action listener: _resource_record_post_action 06:01:21 INFO - ##### 06:01:21 INFO - ##### Running run-tests step. 06:01:21 INFO - ##### 06:01:21 INFO - Running pre-action listener: _resource_record_pre_action 06:01:21 INFO - Running main action method: run_tests 06:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:21 INFO - Python 2.7.3 06:01:21 INFO - Return code: 0 06:01:21 INFO - grabbing minidump binary from tooltool 06:01: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:01:21 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 0xde40b0>, '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 0xde4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:21 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:01:21 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:01:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:21 INFO - Return code: 0 06:01:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:01:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:01:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:01:22 INFO - Return code: 0 06:01:22 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/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test/build 06:01:22 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/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 06:01:22 INFO - Using env: {'DISPLAY': ':0', 06:01:22 INFO - 'HOME': '/home/cltbld', 06:01:22 INFO - 'LANG': 'en_US.UTF-8', 06:01:22 INFO - 'LANGUAGE': 'en_US:en', 06:01:22 INFO - 'LOGNAME': 'cltbld', 06:01:22 INFO - 'MAIL': '/var/mail/cltbld', 06:01:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:22 INFO - 'MOZ_NO_REMOTE': '1', 06:01:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:22 INFO - 'NO_EM_RESTART': '1', 06:01:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:22 INFO - 'PWD': '/builds/slave/test', 06:01:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:22 INFO - 'SHELL': '/bin/bash', 06:01:22 INFO - 'SHLVL': '1', 06:01:22 INFO - 'TERM': 'linux', 06:01:22 INFO - 'TMOUT': '86400', 06:01:22 INFO - 'USER': 'cltbld', 06:01:22 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546', 06:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:22 INFO - '_': '/tools/buildbot/bin/python'} 06:01:22 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/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 06:01:22 INFO - mozversion INFO | application_buildid: 20151209052340 06:01:22 INFO - mozversion INFO | application_changeset: 64fc74a36a1606092a3cf23b949773b0518908cb 06:01:22 INFO - mozversion INFO | application_display_name: Nightly 06:01:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:22 INFO - mozversion INFO | application_name: Firefox 06:01:22 INFO - mozversion INFO | application_remotingname: firefox 06:01:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:01:22 INFO - mozversion INFO | application_vendor: Mozilla 06:01:22 INFO - mozversion INFO | application_version: 45.0a1 06:01:22 INFO - mozversion INFO | platform_buildid: 20151209052340 06:01:22 INFO - mozversion INFO | platform_changeset: 64fc74a36a1606092a3cf23b949773b0518908cb 06:01:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:01:22 INFO - mozversion INFO | platform_version: 45.0a1 06:01:22 INFO - 2015-12-09 06:01:22,855 DEBUG : using testdate: 1449669682 06:01:22 INFO - 2015-12-09 06:01:22,855 DEBUG : actual date: 1449669682 06:01:22 INFO - 2015-12-09 06:01:22,865 INFO : starting webserver on 'localhost:34374' 06:01:22 INFO - 2015-12-09 06:01:22,866 INFO : Starting test suite talos-linux64-ix-048.e 06:01:22 INFO - 2015-12-09 06:01:22,866 INFO : Starting test dromaeo_css 06:01:22 INFO - 2015-12-09 06:01:22,866 DEBUG : operating with platform_type : linux_ 06:01:22 INFO - 2015-12-09 06:01:22,867 INFO : Initialising browser for dromaeo_css test... 06:01:22 INFO - 2015-12-09 06:01:22,882 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkqR65y/profile http://localhost:34374/getInfo.html 06:01:27 INFO - 2015-12-09 06:01:27,483 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:01:27 INFO - 2015-12-09 06:01:27,483 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:01:27 INFO - 2015-12-09 06:01:27,483 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:01:27 INFO - 2015-12-09 06:01:27,484 DEBUG : BROWSER_OUTPUT: __metrics 06:01:27 INFO - 2015-12-09 06:01:27,600 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:01:28 INFO - 2015-12-09 06:01:28,549 INFO : Browser initialized. 06:01:28 INFO - 2015-12-09 06:01:28,549 INFO : Running cycle 1/1 for dromaeo_css test... 06:01:28 INFO - 2015-12-09 06:01:28,549 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkqR65y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:01:40 INFO - 2015-12-09 06:01:40,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 142909440 06:01:40 INFO - 2015-12-09 06:01:40,569 DEBUG : BROWSER_OUTPUT: 06:02:30 INFO - 2015-12-09 06:02:30,198 DEBUG : BROWSER_OUTPUT: 1449669750195 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:04:41 INFO - 2015-12-09 06:04:41,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34374/tests/dromaeo/cssquery-ext.html) 06:04:42 INFO - 2015-12-09 06:04:42,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 146849792 06:04:42 INFO - 2015-12-09 06:04:42,413 DEBUG : BROWSER_OUTPUT: 06:07:44 INFO - 2015-12-09 06:07:44,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-ext.html (next: http://localhost:34374/tests/dromaeo/cssquery-jquery.html) 06:07:45 INFO - 2015-12-09 06:07:45,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 145141760 06:07:45 INFO - 2015-12-09 06:07:45,152 DEBUG : BROWSER_OUTPUT: 06:10:46 INFO - 2015-12-09 06:10:46,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34374/tests/dromaeo/cssquery-mootools.html) 06:10:47 INFO - 2015-12-09 06:10:47,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 145903616 06:10:47 INFO - 2015-12-09 06:10:47,466 DEBUG : BROWSER_OUTPUT: 06:13:49 INFO - 2015-12-09 06:13:49,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34374/tests/dromaeo/cssquery-prototype.html) 06:13:49 INFO - 2015-12-09 06:13:49,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 143622144 06:13:49 INFO - 2015-12-09 06:13:49,859 DEBUG : BROWSER_OUTPUT: 06:16:52 INFO - 2015-12-09 06:16:52,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34374/tests/dromaeo/cssquery-yui.html) 06:16:53 INFO - 2015-12-09 06:16:53,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 145199104 06:16:53 INFO - 2015-12-09 06:16:53,080 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-yui.html (next: http://localhost:34374/tests/dromaeo/cssquery-dojo.html) 06:19:55 INFO - 2015-12-09 06:19:55,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 147697664 06:19:55 INFO - 2015-12-09 06:19:55,789 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:19:55 INFO - 2015-12-09 06:19:55,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:19:55 INFO - 2015-12-09 06:19:55,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:19:55 INFO - 2015-12-09 06:19:55,789 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:19:55 INFO - 2015-12-09 06:19:55,790 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2652.5358062339087;2719.428919926815;2744.4922689302466;2744.7941404394664;2755.407587368716;4635.629149668027;4734.313524538939;4759.976200118999;4796.83211087612;4805.447373552042;4647.395838540985;4669.0428462165255;4672.719636821793;4682.391289132408;4830.782614782334;4304.139172165564;4384.4519435070615;4438.4451943507065;4447.088346888896;4488.596026357627;224.59809996151455;4389.868303950887;4444.333349997494;4458.732476051431;4489.955100449003;4170.061736109382;4263.658907287409;4343.630791382736;4378.759168245745;4460.353248778942;4433.955660443419;4446.244138496463;4446.333050042519;4456.086502267028;4499.0776890737325;4234.661227101825;4433.46798384196;4437.955620443787;4444.955550444486;4463.375127482155;4490.753008584559;4497.100579884036;4533.320001999694;4539.137563862855;4578.313253012075;4884.975575122137;4907.116718990616;4924.630652701062;5130.666506677091;5133.922991155136;5124.590032797404;5156.561692256163;5160.845174644766;5165.147750621143;5185.222216667492;4764.071006153767;4773.355596994431;4780.952190478086;4784.378030856001;4836.782344794493;4875.414950205927;4921.630877684116;4974.900501990012;4980.875478113004;4982.800687972513;4844.539768721966;4923.803047878045;5017.046761115376;5028.84913452597;5073.974630126826;5039.193729003342;5068.974655126701;5081.136206844845;5090.490950904954;5103.974480127576;4762.9523704763205;4868.9269660955115;4968.478309777493;5037.546620804145;5059.696418214919;4949.084419382426;4994.775235114428;5010;5010.924836127461;5040.621953353513;4235.555266697014;4246.087091275391;4258.339957306623;4290.506591741927;4291.098869237433;3524.788512689247;3541.557305336833;3656.323580137683;3713.461548075568;3745.85016599333;4343.9348409773875;4351.369051487517;4390.604845563915;4391.560843915583;4440.711353761995;5107.182850743938;5121.28302037715;5122.052420302256;5135.306733590992;5169.095408303607;4163.687723420756;4259.190753756776;4266.210751011073;4372.4315838941375;4383.298672212431;4456.955430445719;4480.708753930984;4498.325251212279;4505.662075344297;4534.614557762628;4793.448753393334;4806.639502037431;4823.807047718193;4824.517548245218;4859.246816743411;4878.317035615088;4992.326035985096;5067.39191297032;5148.9742551287;5191.974040129775;4758.381410416624;4788.353572267839;4796.568308852081;4821.662483626113;4859.781309841136;4796.616270698406;5021.046001259749;5036.244563315532;5038.874028149326;5081.92377114351;4915.508449155056;4972.9254061188385;5015.1975683890405;5085.618578606545;5123;4901.411830580353;4904.117258893433;4904.754762261944;4942.851714448572;4981.701097934136;4710.8351207707565;4792.832250871203;4891.095147397743;4931.802727890844;4960.255961605788;4828.348172996601;4868.756562171948;4876.561109500162;4911.140550403737;4968.0312339093525;4960.578350840075;4969.726665033313;4970.7514624267915;4978.079055374767;4991.176455884738;4524.185646583646;4661.6736828423045;4687.882802929954;4873.342098816614;4918.114739346809 06:19:55 INFO - 2015-12-09 06:19:55,792 DEBUG : BROWSER_OUTPUT: |1;ext.html;515.049733242168;521.1427202252295;523.0297797585479;525.9579233661308;548.7722595123024;35942.2811543769;36244.27511449773;36277;36365;36507.81746091272;40198.39702404459;41301.58698413015;41306.38040429396;41328.38007429883;41345.58654413455;7710.614469276527;7875.724349647763;7886.723964661238;7898.328642065431;7928.960355198216;7762.611869406535;7834.216578342177;7843.607819609026;7875.960620196891;7890.487118337319;7959.164287749761;8060.314873235782;8062.798430039266;8085.070216925041;8092.069412017634;7950.960245198766;8051.0741264754715;8068.798280042987;8073.515589064646;8086.706127019707;7783.844323113506;7965.243301886369;7985.560794156319;7990.520568765893;8001.439899207058;37914.810425947966;38152.80923595392;38380.23239535194;38443;38456.61543384558;2491.700995880488;2959.0974752700417;2987.5369317755567;2992.7456166225898;3088.5984821972997;26380.86809565959;30956.9877957932;31379.37241255162;32310.676893231237;32420.027399178063;3429.605595356541;3446.844891979867;3499.2826470573727;3542.2738338640515;3574.28514297139;177811;178051;178199;178235;178534;51262;52128.73935630373;52293;57453.71273143691;58232.708836455546;50914;51163.74418127885;51337;51493.227601586004;51516.48483515192;13690.247036413093;13970.231637259845;14026.08830426019;14084.2957852107;14087.43650253999;9392.577334019985;9404.905950940403;9417.576209070608;9440.622375104918;9585.424874507551;19012.904935475235;19196.808031919503;19364.225430982602;19415.514612134528;19437.22251109968;7466.440016998747;7533.209013053551;7570.886436703344;7599.810004749926;7677.30904218623;850.4089657687971;892.4020905993;899.3794281945437;936.4615346175976;1053.984190237147;26729.599056014176;27271.51103733586;27322.180334589993;27334.726652733614;27461.725382745917;913.2511340700562;969.8690676758688;985.103555764251;1060.4644654449453;1078.44460103047;14417.495387661382;14587.197704126163;14610.707785844435;14774.778378324334;14784.260786960609;322201;326161;326943;327551;327630;46904;47675;47745;47928.52071479241;48254;1173.7476442564719;1207.830070803834;1210.4855436439655;1213.447881214063;1216.397883047897;25438.618420724073;25517.744822551536;25565.744342557082;25574.488510230065;25735.227943161735;41721.37417938794;42056.78971605122;42137;42183.578164219194;42190.367144492244;300503;301721;302293;303253;303578;38335.04162395962;42309.15381692287;43022.92442688958;43232.13535729331;43333;44483;45455.54544454646;45491.31763023491;45845.77077114593;46048.76975615101;32994.67005330012;33086.338273234884;33524.49713254254;33646.66353336435;33957.830210848784;33130.337393252485;33560.328793423505;33599;33747.15632109217;33757.493637595944;32095;33634;33684.83157584196;33802.49296260607;33811.83094084514;28008.859955700093;33942.49086263659;35595.82202088973;35953;36065;23905.880470597534;24122;24196.87901560481;24402.11345939922;24625.261242162764 06:19:55 INFO - 2015-12-09 06:19:55,793 DEBUG : BROWSER_OUTPUT: |2;jquery.html;269.40730393135095;269.4140244967196;270.8496784284722;272.6319468717233;275.8730983747476;12351.258924464539;14837.258137093142;15423.460178893754;15430.151341676203;16017.599560011005;15779;15873.52379428616;16553.66892662146;16562.58593535159;16619.00285982842;4184.665226781858;4260.7656578888145;4296.398504209413;4324.654027677778;4332.263515202408;3740.756850804689;4340.696151269412;4393.538678438766;4397.098594788077;4889.731064791435;4842.273658951168;4845.6123510119105;4848.418189817226;4851.708897466146;4863.711116554116;4815.638827087965;4843.321934929113;5043.571296439807;5065.265536497206;5069.543741063322;4459.219636563588;4490.034642551867;4497.797599108048;4504.932426013613;4511.210538155809;17979.460616181535;18174;18599.907000465046;18787;18930.148143333583;1872.372755127034;1883.783364913039;1890.1022014543119;1890.6029733755927;1891.0639233579466;8876.156765107304;8902.821943561157;9008.59461324242;9041.909580904172;10122.089011988883;1750.553608829753;1770.3272756352633;1803.5851754096632;1803.8917664940013;1821.5081927879398;55721.72139139319;58000;58700.706496467246;58845;58961.70519147377;9158.587863546156;9347.392419492711;9383.24934005278;9407.435553866653;9430.151286384258;11381;11581.42092895352;11692.883071169179;11699.88300116988;11738.530458781725;6869.107016087876;7080.716771329192;7105.43156547475;7110.182329032227;7166.068411106627;6746.460283177432;6758;6762.357576030269;6867.759628412981;6892.965535172292;4038.212548553063;4061.817218225187;4064.532578753422;4075.144219713893;4151.481064866892;1684;1716.8025677047049;1725.965480690379;1737.973930391045;1740.7649967254258;877.8982377116678;885.1458342699326;915.5834095486538;940.7177846645978;961.8316794560924;15773;15885.285162167731;15940.521784346489;16242.350305987864;16490.34038638465;837.3092198935902;849.3290300662408;850.753281548344;864.4942708515463;883.2977782662798;8576.614052367659;9157.221636160868;9274.907250927405;9392.718218453458;9420.057994200663;471225;475580;481551;492207;492737;74676;77575.61212193903;78125.60937195277;78314.60842695751;78371.60814195893;1054.514923135351;1073.7208325835338;1079.3092420850662;1081.7511972246427;1097.8353247012851;14606.12363258208;14720.705585888436;15024.24878756036;15080.245987700791;15493.535193944199;30537;34363.31273374568;34453.82773086219;35584.46623300601;36427.81786091052;40405.393919090646;41053.178936421704;42146;42362.5763742371;42731.572684274004;8554.529500877512;8586.441881277697;8749.16882896124;8799.648014079365;8830.337724670548;10140.391576505139;13217.603471895858;16405;16448.424305149263;16991.23539440753;13404.195748255135;13666.453341866214;14054.156750594997;14168.291585420482;14499.130052196902;13717.17696938147;13834.792478112635;13947.58157255284;14100.435982560582;14103.365348559135;14339.283035847957;14382.424703011762;14399.856001439852;14845.183514906352;14859.851401485847;8574.442661227;8853.114688531095;8869.290456763572;8878.11218878107;8883.156100170474;9145.131212535065;9192.816143677222;11256;14187.432502699776;14213.928930355281 06:19:55 INFO - 2015-12-09 06:19:55,794 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1400.1878910232067;1648.6620242850215;1684.528332067021;1708.4799920117828;1735.1757914990378;5753.280839895013;5940.34656187819;6370.108184854124;6557.442617377523;6591.209054913405;6494;6658.36745509177;6698.330166983299;6706.161729783777;6757.763478278262;2025.817676409123;2054.6301665700166;2059.2174973510046;2060.3509894383224;2060.556980249246;2022.7168196452508;2057;2062.0514563300826;2063.9587208255825;2065.5765568058514;1979.8614097013215;2012.6377252094617;2043.111246607723;2043.7036629688687;2053.5482193917387;2035.8065983731522;2058.176729308281;2058.289889987959;2061.29915828619;2064.6386882295687;1967.744193254882;1978.485593745622;2001.9599608007904;2005.0576229172266;2013.577148798754;6804.421624161952;6901.792946211622;6939.861202775916;6974.0236366908675;7046.6828992695455;4059.188162367509;4143.81352839123;4145.875623731293;4150.315197992328;4157.792110394468;2722.42829005909;2725.441284536665;2759.8344099354103;2763.019128209477;2764.557670772687;856.546030603781;861.0528418739336;868.1882439918633;870.2646263906988;889.1153302464026;9210.769730756785;9253.861192082124;9303.953480232623;9314.254859611283;9316.254699624014;3694.6305369463375;3741.663250307485;3744.2885851688093;3792.943105853414;3795.1081495848453;8078.7172448964;8096.797580060428;8111.3916456266015;8111.513309201348;8133.8373232536205;4204.87385378433;4208.032152604918;4229.830806767694;4234.597713217239;4247.426597409372;3216.694414030663;3313.055779102944;3735.477033215352;3849.1147036181833;3859.208862183246;3333.6998570557503;3343.7659363844296;3345.2974875275977;3370.7134893533835;3396.0321308427474;1016.339379403379;1019.6533178719122;1021.9744506387251;1054.0882136951482;1071.507106730897;935.1677007463363;1045.1743122932799;1170.3563040327786;1206.6078524479403;1217.9634610961684;6603.603783772989;6642.302558231413;6642.501812364092;6661.666916654148;6673.532852700361;406.92065047316083;409.08161178154637;410.02823308758434;415.97088203826047;419.1156659448561;5301.390340110859;5310.176922577007;5316.867078323073;5319.867003324948;5328.6802791832615;7882.330001949784;8052.235037671412;8100.149484304181;8100.878486822585;8158.592070396457;7985.2014798519685;8003.159668234752;8055.959720201361;8056;8089.150639182919;6502.934970650327;6545.803625891231;6626.503012274099;6646.401823835878;6653.900191497131;6568.27748947625;6583.242927063449;6630.3038180992235;6653.101831252912;6675.33246675348;7258.346748792634;7458.067741532309;7498.58757768328;7528.171901090986;7540.509866858637;7527.962360188164;7725.806854828675;7759.844803104019;7823.882641760264;7828.530288182727;5155.871103222449;5285.471452854684;5775.826725198251;6123.632582045091;6184.783532576338;6514.739410423719;6518.73925043012;6544.051112588552;6647.534672573067;6658.3674550917585;5999.640021598718;6204.13142160107;6232.594881332699;6235.501159907106;6294;6015.518758499397;6061.181740465157;6105.664188469676;6129.295131059986;6159.907601386072;6237.376262373727;6253.249610046823;6305.243370795534;6308.810735677937;6313.43179113882;5774.931637647049;5810.6513609183585;5831.533477321889;5846.649201047951;5862.179294898632;5759.884802303846;5763.077907534775;6022.909656355246;6029.397060293935;6038.184845046038 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: |4;prototype.html;253.99238022859316;254.16253444899056;254.55198850023953;260.1908065915004;261.2879902266325;5520.641158324706;5573.721313934302;5577.86055348616;5612.859678508029;5736.598438109324;5535.086710692731;5573.219749235111;5599.076152434844;5608.915866261999;5609.046462101443;4028.536718277406;4098.323776576861;4115.218108559379;4117.938230926538;4120.052387950758;4074.124063326384;4091.6317531422164;4095.344744840826;4100.917981640366;4111.0339070318605;4061.2689715851134;4062.53280872699;4065.4308396824467;4065.857694980676;4076.103257283393;4064.796760161995;4069.369247766586;4073.022474606073;4120.876373708794;4122.505299364096;3390.9660903390895;3404.8297585120645;3454.3954807908767;3461.0828130545424;3501.527293815328;5296;5313.203019547061;5315.973420132913;5325.520703136697;5362.195670649434;4688.343631891538;4695.483496815347;4696.53034696531;4700.670953033289;4707.5763181313505;5811.593188476808;5822.0684690449325;5823.88352232953;5829.766809327622;5835.095560188178;3691;3773.8490460381554;3784.829682664287;3787.1857550626473;3813.9809300953593;6117.174181485487;6189.412005859436;6192.721327540272;6195.163652906845;6199.721012554446;3860.7104467165077;3864.072622570619;3865.7873816940337;3871.5741268460447;3890;3921.3725803871243;3930.4300876372768;3931.8820435386983;3935.1145992151537;3946.664533514626;4532.841350552715;4581.312803079565;4651.116287905287;4655.4878963314;4663.766811659403;5882.49998750111;5887.911681324784;5888.911666325009;5891.646501209942;5897.3807750185615;1381.8134551835374;1391.679913619873;1392.102094149268;1393.0736060519641;1393.4008376398247;891.5631340643038;904.2449554621833;911.3074063711626;919.0074719303136;921.083521895718;5022.748862556858;5053.343065401547;5063.1898896176435;5063.594912406998;5067.290579318898;6059.909101363483;6062.878742425215;6070.726817293233;6100.542459315569;6141.57009009374;5013.097642424399;5037.19404895215;5057.595392368602;5057.873553161126;5073.289739436482;3224.27453822888;3259.8533066012087;3315.370079684852;3323.3851737428654;3324.750643701732;5710.600257981901;5728.942710572841;5740.6268592541355;5741.167530708024;5755.769769209269;6300.684965751694;6307.621542707452;6308.211473565804;6312.621242725451;6319.146915166394;5603.075492543685;5745.2818397700285;5747.48272655463;5748.798792042342;5755.309362876398;6146.139540464249;6147.907781383372;6151.108089327112;6151.569390142647;6159.19930409044;5982.49148822355;5986.042233242834;5987.820365389045;5995.880082398415;6000.159977603226;5736.483716465538;5739.569532285179;5745.023346031268;5746.741396637245;5755.597108202385;3805.5243094613174;3918.941215881707;3923.1761330120994;3926.8821935341984;3949.2891279569953;6053.4551890330085;6127.938720612737;6134.35589263121;6136.6011209271255;6179.907301390393;5900.468957793819;5916.31962324321;5948.851278718067;5953.255843019622;5974.103884417372;5873.236479257669;5915.733791979285;5923.170756094237;5926.674032928058;5938.406159384027;5708.058170401837;5784.4504772046585;5784.566157538117;5804.883902322014;5841.240638716939;5959.642421454727;5977.880442391215;5983.431574000463;5985.730642121202;5996.820095397145;5788;5809.767609295581;5818.127280907897;5832.445917637818;5833.737481813244 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: |5;yui.html;779.2947382618732;781.3827076609479;792.675003248668;792.6789650191672;795.5584650518966;11624.070074394049;11789.7642047159;11854.525818967253;11881.940590297057;11917.225380350272;10845.674629761119;12092.153549251534;12182.878171218308;12227.877721222785;12284.324362160078;793.9761807145795;807.8465091632571;810.623060276971;811.7118422959853;813.048732982412;790.9129995700468;798.5767543202112;799.5522507395877;799.8680217764062;800.8998875140608;837.1377481194379;838.681301105579;838.739990602912;839.6935118681668;841.9789505262356;837.2632083766247;841.5161282262724;842.2714352085463;842.6081871929582;843.0684094076049;618.4681174190238;622.3341025103141;622.8567429491243;623.6164758673428;624.0825985800866;11888.881111188864;11924.880751192464;11992.580259690869;11996.280223186637;12045.217060891015;11087.889121108767;11134.888651113466;11246.156538259664;11358.204925655207;11529.250598711056;9276.768080797967;9387.62449502019;9452.149306562442;9543.570539325747;9767.658131965418;3257.4136655402017;3269.182704323919;3302.025902358786;3312.5362449257123;3391.2030672791875;35425.1143721409;36200.27599447996;38565.61434385648;39408.60591394078;41534.584654153674;8621.008584012794;9132.360734748636;9353.438793672402;9362.251019918527;9437.811243775086;15990.600234993986;16151.192440377934;16181.4336498222;16187.10970896612;16191.514254572381;6424.614523128627;6495.188101487314;6566.606003639797;6567.9671601641685;6786.4570834333135;3641.253543023674;3661.377565813818;3662.7436079474182;3670.5778835434267;3731.757435766721;2637.709851916288;2672.1983404978428;2679.4641071785722;2681.1554360376417;2683.637708909272;452.5158080853521;470.44487504744046;477.8853075261912;479.80328065493677;481.0475258987225;503.88410665547127;533.9973300133552;588.9352171261157;612.8927437698385;624.6377101281246;7631;7653.349465295512;7732.4200684948855;7769.300762931251;7792.883106753403;442.33649525711434;535.143769968048;583.0670926517623;590.5954421221477;601.8074216250758;3612.945805812915;3647.2158485925124;3674.191677830873;3676.0993556578273;3720.572134204547;48160.75919620379;48369.516304837205;48740.26889596659;48905.510944890804;49336.75331623391;44672.55327446684;44688.77655611701;45605.08789824185;45705.085898281846;45728.542714573094;38398.424023639665;39581.40627890584;40203.195936081116;41248.1750364997;41847;7613.276738709814;7712.383009359126;7964.283214510722;7988.6405111768945;8172.305354044973;32149.517757234127;32654;32822.67177328292;32893.17767055843;34170.48744268788;38301;38689.2262154761;39514.20971580495;39954.60045399625;40027.79986100051;9972.850407243752;10219.233557483367;10468.63359782404;10475.895241047492;10479.371237725762;11407.429628518375;11530.135239857213;11622.302661840316;11717.121215909012;11951.521939122338;10524.736881578021;10599.993000664925;10649.89350106489;11106.666799996014;11108.055815255793;10545.209109316986;10604.734881627712;10873.836892446778;11200.663980080612;11216.102711783202;10576.682699519026;10656.57373705043;11005.944970275097;11123.165762568002;11194.776104477702;9512.38169518979;9574.04259574037;9637.518124093907;9671.806563868824;9683.128518433376;8830.381873268809;9331;9429.3399462037;9455.858162127712;9480.95259523698 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,329 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: __startTimestamp1449670795788__endTimestamp 06:19:55 INFO - 2015-12-09 06:19:55,796 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,797 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:19:55 INFO - 2015-12-09 06:19:55,797 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:19:55 INFO - 2015-12-09 06:19:55,797 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,797 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4638.20 Median:4796.83 stddev:591.49 (12.3%) stddev-sans-first:572.43 06:19:55 INFO - 2015-12-09 06:19:55,798 DEBUG : BROWSER_OUTPUT: Values: 2652.5 2719.4 2744.5 2744.8 2755.4 4635.6 4734.3 4760.0 4796.8 4805.4 4647.4 4669.0 4672.7 4682.4 4830.8 4304.1 4384.5 4438.4 4447.1 4488.6 224.6 4389.9 4444.3 4458.7 4490.0 4170.1 4263.7 4343.6 4378.8 4460.4 4434.0 4446.2 4446.3 4456.1 4499.1 4234.7 4433.5 4438.0 4445.0 4463.4 4490.8 4497.1 4533.3 4539.1 4578.3 4885.0 4907.1 4924.6 5130.7 5133.9 5124.6 5156.6 5160.8 5165.1 5185.2 4764.1 4773.4 4781.0 4784.4 4836.8 4875.4 4921.6 4974.9 4980.9 4982.8 4844.5 4923.8 5017.0 5028.8 5074.0 5039.2 5069.0 5081.1 5090.5 5104.0 4763.0 4868.9 4968.5 5037.5 5059.7 4949.1 4994.8 5010.0 5010.9 5040.6 4235.6 4246.1 4258.3 4290.5 4291.1 3524.8 3541.6 3656.3 3713.5 3745.9 4343.9 4351.4 4390.6 4391.6 4440.7 5107.2 5121.3 5122.1 5135.3 5169.1 4163.7 4259.2 4266.2 4372.4 4383.3 4457.0 4480.7 4498.3 4505.7 4534.6 4793.4 4806.6 4823.8 4824.5 4859.2 4878.3 4992.3 5067.4 5149.0 5192.0 4758.4 4788.4 4796.6 4821.7 4859.8 4796.6 5021.0 5036.2 5038.9 5081.9 4915.5 4972.9 5015.2 5085.6 5123.0 4901.4 4904.1 4904.8 4942.9 4981.7 4710.8 4792.8 4891.1 4931.8 4960.3 4828.3 4868.8 4876.6 4911.1 4968.0 4960.6 4969.7 4970.8 4978.1 4991.2 4524.2 4661.7 4687.9 4873.3 4918.1 06:19:55 INFO - 2015-12-09 06:19:55,798 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,798 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43382.25 Median:36321.00 stddev:72535.40 (199.7%) stddev-sans-first:72667.47 06:19:55 INFO - 2015-12-09 06:19:55,799 DEBUG : BROWSER_OUTPUT: Values: 515.0 521.1 523.0 526.0 548.8 35942.3 36244.3 36277.0 36365.0 36507.8 40198.4 41301.6 41306.4 41328.4 41345.6 7710.6 7875.7 7886.7 7898.3 7929.0 7762.6 7834.2 7843.6 7876.0 7890.5 7959.2 8060.3 8062.8 8085.1 8092.1 7951.0 8051.1 8068.8 8073.5 8086.7 7783.8 7965.2 7985.6 7990.5 8001.4 37914.8 38152.8 38380.2 38443.0 38456.6 2491.7 2959.1 2987.5 2992.7 3088.6 26380.9 30957.0 31379.4 32310.7 32420.0 3429.6 3446.8 3499.3 3542.3 3574.3 177811.0 178051.0 178199.0 178235.0 178534.0 51262.0 52128.7 52293.0 57453.7 58232.7 50914.0 51163.7 51337.0 51493.2 51516.5 13690.2 13970.2 14026.1 14084.3 14087.4 9392.6 9404.9 9417.6 9440.6 9585.4 19012.9 19196.8 19364.2 19415.5 19437.2 7466.4 7533.2 7570.9 7599.8 7677.3 850.4 892.4 899.4 936.5 1054.0 26729.6 27271.5 27322.2 27334.7 27461.7 913.3 969.9 985.1 1060.5 1078.4 14417.5 14587.2 14610.7 14774.8 14784.3 322201.0 326161.0 326943.0 327551.0 327630.0 46904.0 47675.0 47745.0 47928.5 48254.0 1173.7 1207.8 1210.5 1213.4 1216.4 25438.6 25517.7 25565.7 25574.5 25735.2 41721.4 42056.8 42137.0 42183.6 42190.4 300503.0 301721.0 302293.0 303253.0 303578.0 38335.0 42309.2 43022.9 43232.1 43333.0 44483.0 45455.5 45491.3 45845.8 46048.8 32994.7 33086.3 33524.5 33646.7 33957.8 33130.3 33560.3 33599.0 33747.2 33757.5 32095.0 33634.0 33684.8 33802.5 33811.8 28008.9 33942.5 35595.8 35953.0 36065.0 23905.9 24122.0 24196.9 24402.1 24625.3 06:19:55 INFO - 2015-12-09 06:19:55,799 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,799 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26381.01 Median:22602.33 stddev:78980.51 (349.4%) stddev-sans-first:79177.74 06:19:55 INFO - 2015-12-09 06:19:55,800 DEBUG : BROWSER_OUTPUT: Values: 269.4 269.4 270.8 272.6 275.9 12351.3 14837.3 15423.5 15430.2 16017.6 15779.0 15873.5 16553.7 16562.6 16619.0 4184.7 4260.8 4296.4 4324.7 4332.3 3740.8 4340.7 4393.5 4397.1 4889.7 4842.3 4845.6 4848.4 4851.7 4863.7 4815.6 4843.3 5043.6 5065.3 5069.5 4459.2 4490.0 4497.8 4504.9 4511.2 17979.5 18174.0 18599.9 18787.0 18930.1 1872.4 1883.8 1890.1 1890.6 1891.1 8876.2 8902.8 9008.6 9041.9 10122.1 1750.6 1770.3 1803.6 1803.9 1821.5 55721.7 58000.0 58700.7 58845.0 58961.7 9158.6 9347.4 9383.2 9407.4 9430.2 11381.0 11581.4 11692.9 11699.9 11738.5 6869.1 7080.7 7105.4 7110.2 7166.1 6746.5 6758.0 6762.4 6867.8 6893.0 4038.2 4061.8 4064.5 4075.1 4151.5 1684.0 1716.8 1726.0 1738.0 1740.8 877.9 885.1 915.6 940.7 961.8 15773.0 15885.3 15940.5 16242.4 16490.3 837.3 849.3 850.8 864.5 883.3 8576.6 9157.2 9274.9 9392.7 9420.1 471225.0 475580.0 481551.0 492207.0 492737.0 74676.0 77575.6 78125.6 78314.6 78371.6 1054.5 1073.7 1079.3 1081.8 1097.8 14606.1 14720.7 15024.2 15080.2 15493.5 30537.0 34363.3 34453.8 35584.5 36427.8 40405.4 41053.2 42146.0 42362.6 42731.6 8554.5 8586.4 8749.2 8799.6 8830.3 10140.4 13217.6 16405.0 16448.4 16991.2 13404.2 13666.5 14054.2 14168.3 14499.1 13717.2 13834.8 13947.6 14100.4 14103.4 14339.3 14382.4 14399.9 14845.2 14859.9 8574.4 8853.1 8869.3 8878.1 8883.2 9145.1 9192.8 11256.0 14187.4 14213.9 06:19:55 INFO - 2015-12-09 06:19:55,800 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,800 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4815.28 Median:5969.99 stddev:2484.24 (41.6%) stddev-sans-first:2477.95 06:19:55 INFO - 2015-12-09 06:19:55,801 DEBUG : BROWSER_OUTPUT: Values: 1400.2 1648.7 1684.5 1708.5 1735.2 5753.3 5940.3 6370.1 6557.4 6591.2 6494.0 6658.4 6698.3 6706.2 6757.8 2025.8 2054.6 2059.2 2060.4 2060.6 2022.7 2057.0 2062.1 2064.0 2065.6 1979.9 2012.6 2043.1 2043.7 2053.5 2035.8 2058.2 2058.3 2061.3 2064.6 1967.7 1978.5 2002.0 2005.1 2013.6 6804.4 6901.8 6939.9 6974.0 7046.7 4059.2 4143.8 4145.9 4150.3 4157.8 2722.4 2725.4 2759.8 2763.0 2764.6 856.5 861.1 868.2 870.3 889.1 9210.8 9253.9 9304.0 9314.3 9316.3 3694.6 3741.7 3744.3 3792.9 3795.1 8078.7 8096.8 8111.4 8111.5 8133.8 4204.9 4208.0 4229.8 4234.6 4247.4 3216.7 3313.1 3735.5 3849.1 3859.2 3333.7 3343.8 3345.3 3370.7 3396.0 1016.3 1019.7 1022.0 1054.1 1071.5 935.2 1045.2 1170.4 1206.6 1218.0 6603.6 6642.3 6642.5 6661.7 6673.5 406.9 409.1 410.0 416.0 419.1 5301.4 5310.2 5316.9 5319.9 5328.7 7882.3 8052.2 8100.1 8100.9 8158.6 7985.2 8003.2 8056.0 8056.0 8089.2 6502.9 6545.8 6626.5 6646.4 6653.9 6568.3 6583.2 6630.3 6653.1 6675.3 7258.3 7458.1 7498.6 7528.2 7540.5 7528.0 7725.8 7759.8 7823.9 7828.5 5155.9 5285.5 5775.8 6123.6 6184.8 6514.7 6518.7 6544.1 6647.5 6658.4 5999.6 6204.1 6232.6 6235.5 6294.0 6015.5 6061.2 6105.7 6129.3 6159.9 6237.4 6253.2 6305.2 6308.8 6313.4 5774.9 5810.7 5831.5 5846.6 5862.2 5759.9 5763.1 6022.9 6029.4 6038.2 06:19:55 INFO - 2015-12-09 06:19:55,801 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,801 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4784.35 Median:5601.08 stddev:1498.56 (26.8%) stddev-sans-first:1463.67 06:19:55 INFO - 2015-12-09 06:19:55,801 DEBUG : BROWSER_OUTPUT: Values: 254.0 254.2 254.6 260.2 261.3 5520.6 5573.7 5577.9 5612.9 5736.6 5535.1 5573.2 5599.1 5608.9 5609.0 4028.5 4098.3 4115.2 4117.9 4120.1 4074.1 4091.6 4095.3 4100.9 4111.0 4061.3 4062.5 4065.4 4065.9 4076.1 4064.8 4069.4 4073.0 4120.9 4122.5 3391.0 3404.8 3454.4 3461.1 3501.5 5296.0 5313.2 5316.0 5325.5 5362.2 4688.3 4695.5 4696.5 4700.7 4707.6 5811.6 5822.1 5823.9 5829.8 5835.1 3691.0 3773.8 3784.8 3787.2 3814.0 6117.2 6189.4 6192.7 6195.2 6199.7 3860.7 3864.1 3865.8 3871.6 3890.0 3921.4 3930.4 3931.9 3935.1 3946.7 4532.8 4581.3 4651.1 4655.5 4663.8 5882.5 5887.9 5888.9 5891.6 5897.4 1381.8 1391.7 1392.1 1393.1 1393.4 891.6 904.2 911.3 919.0 921.1 5022.7 5053.3 5063.2 5063.6 5067.3 6059.9 6062.9 6070.7 6100.5 6141.6 5013.1 5037.2 5057.6 5057.9 5073.3 3224.3 3259.9 3315.4 3323.4 3324.8 5710.6 5728.9 5740.6 5741.2 5755.8 6300.7 6307.6 6308.2 6312.6 6319.1 5603.1 5745.3 5747.5 5748.8 5755.3 6146.1 6147.9 6151.1 6151.6 6159.2 5982.5 5986.0 5987.8 5995.9 6000.2 5736.5 5739.6 5745.0 5746.7 5755.6 3805.5 3918.9 3923.2 3926.9 3949.3 6053.5 6127.9 6134.4 6136.6 6179.9 5900.5 5916.3 5948.9 5953.3 5974.1 5873.2 5915.7 5923.2 5926.7 5938.4 5708.1 5784.5 5784.6 5804.9 5841.2 5959.6 5977.9 5983.4 5985.7 5996.8 5788.0 5809.8 5818.1 5832.4 5833.7 06:19:55 INFO - 2015-12-09 06:19:55,801 DEBUG : BROWSER_OUTPUT: 06:19:55 INFO - 2015-12-09 06:19:55,802 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12271.10 Median:44680.66 stddev:13678.02 (30.6%) stddev-sans-first:13689.16 06:19:55 INFO - 2015-12-09 06:19:55,802 DEBUG : BROWSER_OUTPUT: Values: 779.3 781.4 792.7 792.7 795.6 11624.1 11789.8 11854.5 11881.9 11917.2 10845.7 12092.2 12182.9 12227.9 12284.3 794.0 807.8 810.6 811.7 813.0 790.9 798.6 799.6 799.9 800.9 837.1 838.7 838.7 839.7 842.0 837.3 841.5 842.3 842.6 843.1 618.5 622.3 622.9 623.6 624.1 11888.9 11924.9 11992.6 11996.3 12045.2 11087.9 11134.9 11246.2 11358.2 11529.3 9276.8 9387.6 9452.1 9543.6 9767.7 3257.4 3269.2 3302.0 3312.5 3391.2 35425.1 36200.3 38565.6 39408.6 41534.6 8621.0 9132.4 9353.4 9362.3 9437.8 15990.6 16151.2 16181.4 16187.1 16191.5 6424.6 6495.2 6566.6 6568.0 6786.5 3641.3 3661.4 3662.7 3670.6 3731.8 2637.7 2672.2 2679.5 2681.2 2683.6 452.5 470.4 477.9 479.8 481.0 503.9 534.0 588.9 612.9 624.6 7631.0 7653.3 7732.4 7769.3 7792.9 442.3 535.1 583.1 590.6 601.8 3612.9 3647.2 3674.2 3676.1 3720.6 48160.8 48369.5 48740.3 48905.5 49336.8 44672.6 44688.8 45605.1 45705.1 45728.5 38398.4 39581.4 40203.2 41248.2 41847.0 7613.3 7712.4 7964.3 7988.6 8172.3 32149.5 32654.0 32822.7 32893.2 34170.5 38301.0 38689.2 39514.2 39954.6 40027.8 9972.9 10219.2 10468.6 10475.9 10479.4 11407.4 11530.1 11622.3 11717.1 11951.5 10524.7 10600.0 10649.9 11106.7 11108.1 10545.2 10604.7 10873.8 11200.7 11216.1 10576.7 10656.6 11005.9 11123.2 11194.8 9512.4 9574.0 9637.5 9671.8 9683.1 8830.4 9331.0 9429.3 9455.9 9481.0 06:19:55 INFO - 2015-12-09 06:19:55,802 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:19:55 INFO - 2015-12-09 06:19:55,802 DEBUG : BROWSER_OUTPUT: 06:19:56 INFO - 2015-12-09 06:19:56,561 INFO : Browser exited with error code: 0 06:19:56 INFO - 2015-12-09 06:19:56,579 INFO : Completed test dromaeo_css (00:18:33) 06:19:56 INFO - 2015-12-09 06:19:56,579 INFO : Starting test kraken 06:19:56 INFO - 2015-12-09 06:19:56,579 DEBUG : operating with platform_type : linux_ 06:19:56 INFO - 2015-12-09 06:19:56,580 INFO : Initialising browser for kraken test... 06:19:56 INFO - 2015-12-09 06:19:56,586 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplE4KX7/profile http://localhost:34374/getInfo.html 06:20:01 INFO - 2015-12-09 06:20:01,037 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:20:01 INFO - 2015-12-09 06:20:01,037 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:20:01 INFO - 2015-12-09 06:20:01,038 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:20:01 INFO - 2015-12-09 06:20:01,038 DEBUG : BROWSER_OUTPUT: __metrics 06:20:01 INFO - 2015-12-09 06:20:01,162 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:20:02 INFO - 2015-12-09 06:20:02,097 INFO : Browser initialized. 06:20:02 INFO - 2015-12-09 06:20:02,097 INFO : Running cycle 1/1 for kraken test... 06:20:02 INFO - 2015-12-09 06:20:02,097 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplE4KX7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:20:14 INFO - 2015-12-09 06:20:14,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 143659008 06:20:14 INFO - 2015-12-09 06:20:14,101 DEBUG : BROWSER_OUTPUT: 06:20:16 INFO - 2015-12-09 06:20:16,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:17 INFO - 2015-12-09 06:20:17,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 143486976 06:20:17 INFO - 2015-12-09 06:20:17,303 DEBUG : BROWSER_OUTPUT: 06:20:20 INFO - 2015-12-09 06:20:20,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-dft) 06:20:20 INFO - 2015-12-09 06:20:20,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 142163968 06:20:20 INFO - 2015-12-09 06:20:20,674 DEBUG : BROWSER_OUTPUT: 06:20:23 INFO - 2015-12-09 06:20:23,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-fft) 06:20:24 INFO - 2015-12-09 06:20:24,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 139214848 06:20:24 INFO - 2015-12-09 06:20:24,179 DEBUG : BROWSER_OUTPUT: 06:20:26 INFO - 2015-12-09 06:20:26,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-oscillator) 06:20:26 INFO - 2015-12-09 06:20:26,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 140087296 06:20:26 INFO - 2015-12-09 06:20:26,853 DEBUG : BROWSER_OUTPUT: 06:20:29 INFO - 2015-12-09 06:20:29,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:29 INFO - 2015-12-09 06:20:29,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 141783040 06:20:29 INFO - 2015-12-09 06:20:29,698 DEBUG : BROWSER_OUTPUT: 06:20:32 INFO - 2015-12-09 06:20:32,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34374/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:33 INFO - 2015-12-09 06:20:33,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 140476416 06:20:33 INFO - 2015-12-09 06:20:33,339 DEBUG : BROWSER_OUTPUT: 06:20:36 INFO - 2015-12-09 06:20:36,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34374/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:37 INFO - 2015-12-09 06:20:37,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 138670080 06:20:37 INFO - 2015-12-09 06:20:37,403 DEBUG : BROWSER_OUTPUT: 06:20:40 INFO - 2015-12-09 06:20:40,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34374/tests/kraken/driver.html?testName=json-parse-financial) 06:20:40 INFO - 2015-12-09 06:20:40,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 138166272 06:20:40 INFO - 2015-12-09 06:20:40,914 DEBUG : BROWSER_OUTPUT: 06:20:42 INFO - 2015-12-09 06:20:42,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:43 INFO - 2015-12-09 06:20:43,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 140902400 06:20:43 INFO - 2015-12-09 06:20:43,277 DEBUG : BROWSER_OUTPUT: 06:20:45 INFO - 2015-12-09 06:20:45,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:45 INFO - 2015-12-09 06:20:45,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 06:20:45 INFO - 2015-12-09 06:20:45,795 DEBUG : BROWSER_OUTPUT: 06:20:47 INFO - 2015-12-09 06:20:47,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:48 INFO - 2015-12-09 06:20:48,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 06:20:48 INFO - 2015-12-09 06:20:48,590 DEBUG : BROWSER_OUTPUT: 06:20:51 INFO - 2015-12-09 06:20:51,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:51 INFO - 2015-12-09 06:20:51,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 06:20:51 INFO - 2015-12-09 06:20:51,707 DEBUG : BROWSER_OUTPUT: 06:20:54 INFO - 2015-12-09 06:20:54,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:54 INFO - 2015-12-09 06:20:54,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 141492224 06:20:54 INFO - 2015-12-09 06:20:54,989 DEBUG : BROWSER_OUTPUT: 06:20:56 INFO - 2015-12-09 06:20:56,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34374/tests/kraken/driver.html?testName=ai-astar) 06:20:57 INFO - 2015-12-09 06:20:57,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 140611584 06:20:57 INFO - 2015-12-09 06:20:57,000 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,004 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:20:57 INFO - 2015-12-09 06:20:57,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:20:57 INFO - 2015-12-09 06:20:57,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:20:57 INFO - 2015-12-09 06:20:57,004 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:20:57 INFO - 2015-12-09 06:20:57,004 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;111;113;115;114;126;115;115;115;114 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;132;158;171;132;151;160;134;169;141 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;165;162;162;166;173;163;164;163 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;73;72;140;72;74;79;74 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;132;95;94;95;129;95;97;135 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;109;110;110;110;110 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;148;154;149;148;148;147;149 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;95;96;95;96;97;96 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;79;75;74;76;76;76;77;75;76;72 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;68;68;69;69 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;88;96;94;86;86;86;87;87 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;127;129;119;119;118;121;132;124;124 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;154;150;152;139;152;162;153;157;138 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;73;75;74;71;71;71;73;72;70 06:20:57 INFO - 2015-12-09 06:20:57,005 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:20:57 INFO - 2015-12-09 06:20:57,006 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:20:57 INFO - 2015-12-09 06:20:57,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,801 06:20:57 INFO - 2015-12-09 06:20:57,006 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:20:57 INFO - 2015-12-09 06:20:57,006 DEBUG : BROWSER_OUTPUT: __startTimestamp1449670857002__endTimestamp 06:20:57 INFO - 2015-12-09 06:20:57,006 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,009 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:20:57 INFO - 2015-12-09 06:20:57,009 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:20:57 INFO - 2015-12-09 06:20:57,009 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,009 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:4.01 (3.5%) stddev-sans-first:4.21 06:20:57 INFO - 2015-12-09 06:20:57,009 DEBUG : BROWSER_OUTPUT: Values: 117.0 111.0 113.0 115.0 114.0 126.0 115.0 115.0 115.0 114.0 06:20:57 INFO - 2015-12-09 06:20:57,009 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.80 Median:159.00 stddev:15.08 (9.5%) stddev-sans-first:15.62 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: Values: 160.0 132.0 158.0 171.0 132.0 151.0 160.0 134.0 169.0 141.0 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.33 (2.0%) stddev-sans-first:3.43 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 165.0 162.0 162.0 166.0 173.0 163.0 164.0 163.0 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:21.15 (29.0%) stddev-sans-first:22.23 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 73.0 72.0 140.0 72.0 74.0 79.0 74.0 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:17.88 (18.8%) stddev-sans-first:18.41 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 132.0 95.0 94.0 95.0 129.0 95.0 97.0 135.0 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,010 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:2.01 (1.4%) stddev-sans-first:2.12 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 148.0 154.0 149.0 148.0 148.0 147.0 149.0 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 95.0 96.0 95.0 96.0 97.0 96.0 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.60 Median:76.00 stddev:1.84 (2.4%) stddev-sans-first:1.48 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: Values: 79.0 75.0 74.0 76.0 76.0 76.0 77.0 75.0 76.0 72.0 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 69.0 69.0 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.00 stddev:3.86 (4.4%) stddev-sans-first:3.81 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 88.0 96.0 94.0 86.0 86.0 86.0 87.0 87.0 06:20:57 INFO - 2015-12-09 06:20:57,011 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:4.62 (3.7%) stddev-sans-first:4.90 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: Values: 123.0 127.0 129.0 119.0 119.0 118.0 121.0 132.0 124.0 124.0 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.50 stddev:8.24 (5.4%) stddev-sans-first:7.79 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: Values: 139.0 154.0 150.0 152.0 139.0 152.0 162.0 153.0 157.0 138.0 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.65 (2.3%) stddev-sans-first:1.64 06:20:57 INFO - 2015-12-09 06:20:57,012 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 75.0 74.0 71.0 71.0 71.0 73.0 72.0 70.0 06:20:57 INFO - 2015-12-09 06:20:57,013 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:20:57 INFO - 2015-12-09 06:20:57,013 DEBUG : BROWSER_OUTPUT: 06:20:57 INFO - 2015-12-09 06:20:57,973 INFO : Browser exited with error code: 0 06:20:58 INFO - 2015-12-09 06:20:58,027 INFO : Completed test kraken (00:01:01) 06:20:58 INFO - 2015-12-09 06:20:58,027 INFO : Starting test v8_7 06:20:58 INFO - 2015-12-09 06:20:58,027 DEBUG : operating with platform_type : linux_ 06:20:58 INFO - 2015-12-09 06:20:58,027 INFO : Initialising browser for v8_7 test... 06:20:58 INFO - 2015-12-09 06:20:58,033 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL6IcIQ/profile http://localhost:34374/getInfo.html 06:21:02 INFO - 2015-12-09 06:21:02,639 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:21:02 INFO - 2015-12-09 06:21:02,640 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:21:02 INFO - 2015-12-09 06:21:02,640 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:21:02 INFO - 2015-12-09 06:21:02,640 DEBUG : BROWSER_OUTPUT: __metrics 06:21:02 INFO - 2015-12-09 06:21:02,777 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:21:03 INFO - 2015-12-09 06:21:03,705 INFO : Browser initialized. 06:21:03 INFO - 2015-12-09 06:21:03,705 INFO : Running cycle 1/1 for v8_7 test... 06:21:03 INFO - 2015-12-09 06:21:03,705 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL6IcIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:21:15 INFO - 2015-12-09 06:21:15,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 143138816 06:21:15 INFO - 2015-12-09 06:21:15,765 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34374/tests/v8_7/run.html (next: http://localhost:34374/tests/v8_7/run.html) 06:21:37 INFO - 2015-12-09 06:21:37,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 138653696 06:21:37 INFO - 2015-12-09 06:21:37,488 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: |0;Richards;167.53224995811695 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.2881230313137 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 06:21:37 INFO - 2015-12-09 06:21:37,489 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 06:21:37 INFO - 2015-12-09 06:21:37,490 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1088.139281828074 06:21:37 INFO - 2015-12-09 06:21:37,490 DEBUG : BROWSER_OUTPUT: |5;Earley;719.626168224299 06:21:37 INFO - 2015-12-09 06:21:37,490 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 06:21:37 INFO - 2015-12-09 06:21:37,490 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 06:21:37 INFO - 2015-12-09 06:21:37,490 DEBUG : BROWSER_OUTPUT: |8;Splay;604.9606775559589 06:21:37 INFO - 2015-12-09 06:21:37,490 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 06:21:37 INFO - 2015-12-09 06:21:37,490 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: __startTimestamp1449670897481__endTimestamp 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: Values: 167.5 06:21:37 INFO - 2015-12-09 06:21:37,491 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,492 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.29 Median:185.29 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,492 DEBUG : BROWSER_OUTPUT: Values: 185.3 06:21:37 INFO - 2015-12-09 06:21:37,492 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,492 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,492 DEBUG : BROWSER_OUTPUT: Values: 279.3 06:21:37 INFO - 2015-12-09 06:21:37,492 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,492 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: Values: 5202.1 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1088.14 Median:1088.14 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: Values: 1088.1 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:719.63 Median:719.63 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: Values: 719.6 06:21:37 INFO - 2015-12-09 06:21:37,493 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,494 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,494 DEBUG : BROWSER_OUTPUT: Values: 12292.7 06:21:37 INFO - 2015-12-09 06:21:37,494 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,494 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,494 DEBUG : BROWSER_OUTPUT: Values: 25871.8 06:21:37 INFO - 2015-12-09 06:21:37,494 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,494 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.96 Median:604.96 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,495 DEBUG : BROWSER_OUTPUT: Values: 605.0 06:21:37 INFO - 2015-12-09 06:21:37,495 DEBUG : BROWSER_OUTPUT: 06:21:37 INFO - 2015-12-09 06:21:37,495 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:21:37 INFO - 2015-12-09 06:21:37,495 DEBUG : BROWSER_OUTPUT: Values: 4830.9 06:21:37 INFO - 2015-12-09 06:21:37,495 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:21:37 INFO - 2015-12-09 06:21:37,495 DEBUG : BROWSER_OUTPUT: 06:21:38 INFO - 2015-12-09 06:21:38,409 INFO : Browser exited with error code: 0 06:21:38 INFO - 2015-12-09 06:21:38,421 INFO : Completed test v8_7 (00:00:40) 06:21:38 INFO - 2015-12-09 06:21:38,484 INFO : Completed test suite (00:20:15) 06:21:38 INFO - 2015-12-09 06:21:38,484 DEBUG : Working with test: dromaeo_css 06:21:38 INFO - 2015-12-09 06:21:38,485 DEBUG : Generating results file: dromaeo_css 06:21:38 INFO - 2015-12-09 06:21:38,486 DEBUG : Working with test: kraken 06:21:38 INFO - 2015-12-09 06:21:38,486 DEBUG : Generating results file: kraken 06:21:38 INFO - 2015-12-09 06:21:38,486 INFO : javascript benchmark 06:21:38 INFO - 2015-12-09 06:21:38,486 DEBUG : Working with test: v8_7 06:21:38 INFO - 2015-12-09 06:21:38,486 DEBUG : Generating results file: v8_7 06:21:38 INFO - 2015-12-09 06:21:38,487 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:38 INFO - 2015-12-09 06:21:38,563 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 06:21:38 INFO - 2015-12-09 06:21:38,563 DEBUG : process_Request line: dromaeo_css 6300.15 graph.html#tests=[[72,132,43]] 06:21:38 INFO - 2015-12-09 06:21:38,563 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:38 INFO - 2015-12-09 06:21:38,599 DEBUG : process_Request line: kraken 1548.90 graph.html#tests=[[232,132,43]] 06:21:38 INFO - 2015-12-09 06:21:38,599 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:38 INFO - 2015-12-09 06:21:38,639 DEBUG : process_Request line: v8_7 21275.33 graph.html#tests=[[230,132,43]] 06:21:38 INFO - 2015-12-09 06:21:38,640 INFO : javascript benchmark 06:21:38 INFO - 2015-12-09 06:21:38,644 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2652.5358062339087, 2719.428919926815, 2744.4922689302466, 2744.7941404394664, 2755.407587368716, 4635.629149668027, 4734.313524538939, 4759.976200118999, 4796.83211087612, 4805.447373552042, 4647.395838540985, 4669.0428462165255, 4672.719636821793, 4682.391289132408, 4830.782614782334, 4304.139172165564, 4384.4519435070615, 4438.4451943507065, 4447.088346888896, 4488.596026357627, 224.59809996151455, 4389.868303950887, 4444.333349997494, 4458.732476051431, 4489.955100449003, 4170.061736109382, 4263.658907287409, 4343.630791382736, 4378.759168245745, 4460.353248778942, 4433.955660443419, 4446.244138496463, 4446.333050042519, 4456.086502267028, 4499.0776890737325, 4234.661227101825, 4433.46798384196, 4437.955620443787, 4444.955550444486, 4463.375127482155, 4490.753008584559, 4497.100579884036, 4533.320001999694, 4539.137563862855, 4578.313253012075, 4884.975575122137, 4907.116718990616, 4924.630652701062, 5130.666506677091, 5133.922991155136, 5124.590032797404, 5156.561692256163, 5160.845174644766, 5165.147750621143, 5185.222216667492, 4764.071006153767, 4773.355596994431, 4780.952190478086, 4784.378030856001, 4836.782344794493, 4875.414950205927, 4921.630877684116, 4974.900501990012, 4980.875478113004, 4982.800687972513, 4844.539768721966, 4923.803047878045, 5017.046761115376, 5028.84913452597, 5073.974630126826, 5039.193729003342, 5068.974655126701, 5081.136206844845, 5090.490950904954, 5103.974480127576, 4762.9523704763205, 4868.9269660955115, 4968.478309777493, 5037.546620804145, 5059.696418214919, 4949.084419382426, 4994.775235114428, 5010.0, 5010.924836127461, 5040.621953353513, 4235.555266697014, 4246.087091275391, 4258.339957306623, 4290.506591741927, 4291.098869237433, 3524.788512689247, 3541.557305336833, 3656.323580137683, 3713.461548075568, 3745.85016599333, 4343.9348409773875, 4351.369051487517, 4390.604845563915, 4391.560843915583, 4440.711353761995, 5107.182850743938, 5121.28302037715, 5122.052420302256, 5135.306733590992, 5169.095408303607, 4163.687723420756, 4259.190753756776, 4266.210751011073, 4372.4315838941375, 4383.298672212431, 4456.955430445719, 4480.708753930984, 4498.325251212279, 4505.662075344297, 4534.614557762628, 4793.448753393334, 4806.639502037431, 4823.807047718193, 4824.517548245218, 4859.246816743411, 4878.317035615088, 4992.326035985096, 5067.39191297032, 5148.9742551287, 5191.974040129775, 4758.381410416624, 4788.353572267839, 4796.568308852081, 4821.662483626113, 4859.781309841136, 4796.616270698406, 5021.046001259749, 5036.244563315532, 5038.874028149326, 5081.92377114351, 4915.508449155056, 4972.9254061188385, 5015.1975683890405, 5085.618578606545, 5123.0, 4901.411830580353, 4904.117258893433, 4904.754762261944, 4942.851714448572, 4981.701097934136, 4710.8351207707565, 4792.832250871203, 4891.095147397743, 4931.802727890844, 4960.255961605788, 4828.348172996601, 4868.756562171948, 4876.561109500162, 4911.140550403737, 4968.0312339093525, 4960.578350840075, 4969.726665033313, 4970.7514624267915, 4978.079055374767, 4991.176455884738, 4524.185646583646, 4661.6736828423045, 4687.882802929954, 4873.342098816614, 4918.114739346809], "unit": "ms", "name": "dojo.html", "value": 4604.880485035495}, {"lowerIsBetter": false, "replicates": [515.049733242168, 521.1427202252295, 523.0297797585479, 525.9579233661308, 548.7722595123024, 35942.2811543769, 36244.27511449773, 36277.0, 36365.0, 36507.81746091272, 40198.39702404459, 41301.58698413015, 41306.38040429396, 41328.38007429883, 41345.58654413455, 7710.614469276527, 7875.724349647763, 7886.723964661238, 7898.328642065431, 7928.960355198216, 7762.611869406535, 7834.216578342177, 7843.607819609026, 7875.960620196891, 7890.487118337319, 7959.164287749761, 8060.314873235782, 8062.798430039266, 8085.070216925041, 8092.069412017634, 7950.960245198766, 8051.0741264754715, 8068.798280042987, 8073.515589064646, 8086.706127019707, 7783.844323113506, 7965.243301886369, 7985.560794156319, 7990.520568765893, 8001.439899207058, 37914.810425947966, 38152.80923595392, 38380.23239535194, 38443.0, 38456.61543384558, 2491.700995880488, 2959.0974752700417, 2987.5369317755567, 2992.7456166225898, 3088.5984821972997, 26380.86809565959, 30956.9877957932, 31379.37241255162, 32310.676893231237, 32420.027399178063, 3429.605595356541, 3446.844891979867, 3499.2826470573727, 3542.2738338640515, 3574.28514297139, 177811.0, 178051.0, 178199.0, 178235.0, 178534.0, 51262.0, 52128.73935630373, 52293.0, 57453.71273143691, 58232.708836455546, 50914.0, 51163.74418127885, 51337.0, 51493.227601586004, 51516.48483515192, 13690.247036413093, 13970.231637259845, 14026.08830426019, 14084.2957852107, 14087.43650253999, 9392.577334019985, 9404.905950940403, 9417.576209070608, 9440.622375104918, 9585.424874507551, 19012.904935475235, 19196.808031919503, 19364.225430982602, 19415.514612134528, 19437.22251109968, 7466.440016998747, 7533.209013053551, 7570.886436703344, 7599.810004749926, 7677.30904218623, 850.4089657687971, 892.4020905993, 899.3794281945437, 936.4615346175976, 1053.984190237147, 26729.599056014176, 27271.51103733586, 27322.180334589993, 27334.726652733614, 27461.725382745917, 913.2511340700562, 969.8690676758688, 985.103555764251, 1060.4644654449453, 1078.44460103047, 14417.495387661382, 14587.197704126163, 14610.707785844435, 14774.778378324334, 14784.260786960609, 322201.0, 326161.0, 326943.0, 327551.0, 327630.0, 46904.0, 47675.0, 47745.0, 47928.52071479241, 48254.0, 1173.7476442564719, 1207.830070803834, 1210.4855436439655, 1213.447881214063, 1216.397883047897, 25438.618420724073, 25517.744822551536, 25565.744342557082, 25574.488510230065, 25735.227943161735, 41721.37417938794, 42056.78971605122, 42137.0, 42183.578164219194, 42190.367144492244, 300503.0, 301721.0, 302293.0, 303253.0, 303578.0, 38335.04162395962, 42309.15381692287, 43022.92442688958, 43232.13535729331, 43333.0, 44483.0, 45455.54544454646, 45491.31763023491, 45845.77077114593, 46048.76975615101, 32994.67005330012, 33086.338273234884, 33524.49713254254, 33646.66353336435, 33957.830210848784, 33130.337393252485, 33560.328793423505, 33599.0, 33747.15632109217, 33757.493637595944, 32095.0, 33634.0, 33684.83157584196, 33802.49296260607, 33811.83094084514, 28008.859955700093, 33942.49086263659, 35595.82202088973, 35953.0, 36065.0, 23905.880470597534, 24122.0, 24196.87901560481, 24402.11345939922, 24625.261242162764], "unit": "ms", "name": "ext.html", "value": 17309.55037975658}, {"lowerIsBetter": false, "replicates": [269.40730393135095, 269.4140244967196, 270.8496784284722, 272.6319468717233, 275.8730983747476, 12351.258924464539, 14837.258137093142, 15423.460178893754, 15430.151341676203, 16017.599560011005, 15779.0, 15873.52379428616, 16553.66892662146, 16562.58593535159, 16619.00285982842, 4184.665226781858, 4260.7656578888145, 4296.398504209413, 4324.654027677778, 4332.263515202408, 3740.756850804689, 4340.696151269412, 4393.538678438766, 4397.098594788077, 4889.731064791435, 4842.273658951168, 4845.6123510119105, 4848.418189817226, 4851.708897466146, 4863.711116554116, 4815.638827087965, 4843.321934929113, 5043.571296439807, 5065.265536497206, 5069.543741063322, 4459.219636563588, 4490.034642551867, 4497.797599108048, 4504.932426013613, 4511.210538155809, 17979.460616181535, 18174.0, 18599.907000465046, 18787.0, 18930.148143333583, 1872.372755127034, 1883.783364913039, 1890.1022014543119, 1890.6029733755927, 1891.0639233579466, 8876.156765107304, 8902.821943561157, 9008.59461324242, 9041.909580904172, 10122.089011988883, 1750.553608829753, 1770.3272756352633, 1803.5851754096632, 1803.8917664940013, 1821.5081927879398, 55721.72139139319, 58000.0, 58700.706496467246, 58845.0, 58961.70519147377, 9158.587863546156, 9347.392419492711, 9383.24934005278, 9407.435553866653, 9430.151286384258, 11381.0, 11581.42092895352, 11692.883071169179, 11699.88300116988, 11738.530458781725, 6869.107016087876, 7080.716771329192, 7105.43156547475, 7110.182329032227, 7166.068411106627, 6746.460283177432, 6758.0, 6762.357576030269, 6867.759628412981, 6892.965535172292, 4038.212548553063, 4061.817218225187, 4064.532578753422, 4075.144219713893, 4151.481064866892, 1684.0, 1716.8025677047049, 1725.965480690379, 1737.973930391045, 1740.7649967254258, 877.8982377116678, 885.1458342699326, 915.5834095486538, 940.7177846645978, 961.8316794560924, 15773.0, 15885.285162167731, 15940.521784346489, 16242.350305987864, 16490.34038638465, 837.3092198935902, 849.3290300662408, 850.753281548344, 864.4942708515463, 883.2977782662798, 8576.614052367659, 9157.221636160868, 9274.907250927405, 9392.718218453458, 9420.057994200663, 471225.0, 475580.0, 481551.0, 492207.0, 492737.0, 74676.0, 77575.61212193903, 78125.60937195277, 78314.60842695751, 78371.60814195893, 1054.514923135351, 1073.7208325835338, 1079.3092420850662, 1081.7511972246427, 1097.8353247012851, 14606.12363258208, 14720.705585888436, 15024.24878756036, 15080.245987700791, 15493.535193944199, 30537.0, 34363.31273374568, 34453.82773086219, 35584.46623300601, 36427.81786091052, 40405.393919090646, 41053.178936421704, 42146.0, 42362.5763742371, 42731.572684274004, 8554.529500877512, 8586.441881277697, 8749.16882896124, 8799.648014079365, 8830.337724670548, 10140.391576505139, 13217.603471895858, 16405.0, 16448.424305149263, 16991.23539440753, 13404.195748255135, 13666.453341866214, 14054.156750594997, 14168.291585420482, 14499.130052196902, 13717.17696938147, 13834.792478112635, 13947.58157255284, 14100.435982560582, 14103.365348559135, 14339.283035847957, 14382.424703011762, 14399.856001439852, 14845.183514906352, 14859.851401485847, 8574.442661227, 8853.114688531095, 8869.290456763572, 8878.11218878107, 8883.156100170474, 9145.131212535065, 9192.816143677222, 11256.0, 14187.432502699776, 14213.928930355281], "unit": "ms", "name": "jquery.html", "value": 8136.926451593551}, {"lowerIsBetter": false, "replicates": [1400.1878910232067, 1648.6620242850215, 1684.528332067021, 1708.4799920117828, 1735.1757914990378, 5753.280839895013, 5940.34656187819, 6370.108184854124, 6557.442617377523, 6591.209054913405, 6494.0, 6658.36745509177, 6698.330166983299, 6706.161729783777, 6757.763478278262, 2025.817676409123, 2054.6301665700166, 2059.2174973510046, 2060.3509894383224, 2060.556980249246, 2022.7168196452508, 2057.0, 2062.0514563300826, 2063.9587208255825, 2065.5765568058514, 1979.8614097013215, 2012.6377252094617, 2043.111246607723, 2043.7036629688687, 2053.5482193917387, 2035.8065983731522, 2058.176729308281, 2058.289889987959, 2061.29915828619, 2064.6386882295687, 1967.744193254882, 1978.485593745622, 2001.9599608007904, 2005.0576229172266, 2013.577148798754, 6804.421624161952, 6901.792946211622, 6939.861202775916, 6974.0236366908675, 7046.6828992695455, 4059.188162367509, 4143.81352839123, 4145.875623731293, 4150.315197992328, 4157.792110394468, 2722.42829005909, 2725.441284536665, 2759.8344099354103, 2763.019128209477, 2764.557670772687, 856.546030603781, 861.0528418739336, 868.1882439918633, 870.2646263906988, 889.1153302464026, 9210.769730756785, 9253.861192082124, 9303.953480232623, 9314.254859611283, 9316.254699624014, 3694.6305369463375, 3741.663250307485, 3744.2885851688093, 3792.943105853414, 3795.1081495848453, 8078.7172448964, 8096.797580060428, 8111.3916456266015, 8111.513309201348, 8133.8373232536205, 4204.87385378433, 4208.032152604918, 4229.830806767694, 4234.597713217239, 4247.426597409372, 3216.694414030663, 3313.055779102944, 3735.477033215352, 3849.1147036181833, 3859.208862183246, 3333.6998570557503, 3343.7659363844296, 3345.2974875275977, 3370.7134893533835, 3396.0321308427474, 1016.339379403379, 1019.6533178719122, 1021.9744506387251, 1054.0882136951482, 1071.507106730897, 935.1677007463363, 1045.1743122932799, 1170.3563040327786, 1206.6078524479403, 1217.9634610961684, 6603.603783772989, 6642.302558231413, 6642.501812364092, 6661.666916654148, 6673.532852700361, 406.92065047316083, 409.08161178154637, 410.02823308758434, 415.97088203826047, 419.1156659448561, 5301.390340110859, 5310.176922577007, 5316.867078323073, 5319.867003324948, 5328.6802791832615, 7882.330001949784, 8052.235037671412, 8100.149484304181, 8100.878486822585, 8158.592070396457, 7985.2014798519685, 8003.159668234752, 8055.959720201361, 8056.0, 8089.150639182919, 6502.934970650327, 6545.803625891231, 6626.503012274099, 6646.401823835878, 6653.900191497131, 6568.27748947625, 6583.242927063449, 6630.3038180992235, 6653.101831252912, 6675.33246675348, 7258.346748792634, 7458.067741532309, 7498.58757768328, 7528.171901090986, 7540.509866858637, 7527.962360188164, 7725.806854828675, 7759.844803104019, 7823.882641760264, 7828.530288182727, 5155.871103222449, 5285.471452854684, 5775.826725198251, 6123.632582045091, 6184.783532576338, 6514.739410423719, 6518.73925043012, 6544.051112588552, 6647.534672573067, 6658.3674550917585, 5999.640021598718, 6204.13142160107, 6232.594881332699, 6235.501159907106, 6294.0, 6015.518758499397, 6061.181740465157, 6105.664188469676, 6129.295131059986, 6159.907601386072, 6237.376262373727, 6253.249610046823, 6305.243370795534, 6308.810735677937, 6313.43179113882, 5774.931637647049, 5810.6513609183585, 5831.533477321889, 5846.649201047951, 5862.179294898632, 5759.884802303846, 5763.077907534775, 6022.909656355246, 6029.397060293935, 6038.184845046038], "unit": "ms", "name": "mootools.html", "value": 3904.8200641861354}, {"lowerIsBetter": false, "replicates": [253.99238022859316, 254.16253444899056, 254.55198850023953, 260.1908065915004, 261.2879902266325, 5520.641158324706, 5573.721313934302, 5577.86055348616, 5612.859678508029, 5736.598438109324, 5535.086710692731, 5573.219749235111, 5599.076152434844, 5608.915866261999, 5609.046462101443, 4028.536718277406, 4098.323776576861, 4115.218108559379, 4117.938230926538, 4120.052387950758, 4074.124063326384, 4091.6317531422164, 4095.344744840826, 4100.917981640366, 4111.0339070318605, 4061.2689715851134, 4062.53280872699, 4065.4308396824467, 4065.857694980676, 4076.103257283393, 4064.796760161995, 4069.369247766586, 4073.022474606073, 4120.876373708794, 4122.505299364096, 3390.9660903390895, 3404.8297585120645, 3454.3954807908767, 3461.0828130545424, 3501.527293815328, 5296.0, 5313.203019547061, 5315.973420132913, 5325.520703136697, 5362.195670649434, 4688.343631891538, 4695.483496815347, 4696.53034696531, 4700.670953033289, 4707.5763181313505, 5811.593188476808, 5822.0684690449325, 5823.88352232953, 5829.766809327622, 5835.095560188178, 3691.0, 3773.8490460381554, 3784.829682664287, 3787.1857550626473, 3813.9809300953593, 6117.174181485487, 6189.412005859436, 6192.721327540272, 6195.163652906845, 6199.721012554446, 3860.7104467165077, 3864.072622570619, 3865.7873816940337, 3871.5741268460447, 3890.0, 3921.3725803871243, 3930.4300876372768, 3931.8820435386983, 3935.1145992151537, 3946.664533514626, 4532.841350552715, 4581.312803079565, 4651.116287905287, 4655.4878963314, 4663.766811659403, 5882.49998750111, 5887.911681324784, 5888.911666325009, 5891.646501209942, 5897.3807750185615, 1381.8134551835374, 1391.679913619873, 1392.102094149268, 1393.0736060519641, 1393.4008376398247, 891.5631340643038, 904.2449554621833, 911.3074063711626, 919.0074719303136, 921.083521895718, 5022.748862556858, 5053.343065401547, 5063.1898896176435, 5063.594912406998, 5067.290579318898, 6059.909101363483, 6062.878742425215, 6070.726817293233, 6100.542459315569, 6141.57009009374, 5013.097642424399, 5037.19404895215, 5057.595392368602, 5057.873553161126, 5073.289739436482, 3224.27453822888, 3259.8533066012087, 3315.370079684852, 3323.3851737428654, 3324.750643701732, 5710.600257981901, 5728.942710572841, 5740.6268592541355, 5741.167530708024, 5755.769769209269, 6300.684965751694, 6307.621542707452, 6308.211473565804, 6312.621242725451, 6319.146915166394, 5603.075492543685, 5745.2818397700285, 5747.48272655463, 5748.798792042342, 5755.309362876398, 6146.139540464249, 6147.907781383372, 6151.108089327112, 6151.569390142647, 6159.19930409044, 5982.49148822355, 5986.042233242834, 5987.820365389045, 5995.880082398415, 6000.159977603226, 5736.483716465538, 5739.569532285179, 5745.023346031268, 5746.741396637245, 5755.597108202385, 3805.5243094613174, 3918.941215881707, 3923.1761330120994, 3926.8821935341984, 3949.2891279569953, 6053.4551890330085, 6127.938720612737, 6134.35589263121, 6136.6011209271255, 6179.907301390393, 5900.468957793819, 5916.31962324321, 5948.851278718067, 5953.255843019622, 5974.103884417372, 5873.236479257669, 5915.733791979285, 5923.170756094237, 5926.674032928058, 5938.406159384027, 5708.058170401837, 5784.4504772046585, 5784.566157538117, 5804.883902322014, 5841.240638716939, 5959.642421454727, 5977.880442391215, 5983.431574000463, 5985.730642121202, 5996.820095397145, 5788.0, 5809.767609295581, 5818.127280907897, 5832.445917637818, 5833.737481813244], "unit": "ms", "name": "prototype.html", "value": 4275.847212144663}, {"lowerIsBetter": false, "replicates": [779.2947382618732, 781.3827076609479, 792.675003248668, 792.6789650191672, 795.5584650518966, 11624.070074394049, 11789.7642047159, 11854.525818967253, 11881.940590297057, 11917.225380350272, 10845.674629761119, 12092.153549251534, 12182.878171218308, 12227.877721222785, 12284.324362160078, 793.9761807145795, 807.8465091632571, 810.623060276971, 811.7118422959853, 813.048732982412, 790.9129995700468, 798.5767543202112, 799.5522507395877, 799.8680217764062, 800.8998875140608, 837.1377481194379, 838.681301105579, 838.739990602912, 839.6935118681668, 841.9789505262356, 837.2632083766247, 841.5161282262724, 842.2714352085463, 842.6081871929582, 843.0684094076049, 618.4681174190238, 622.3341025103141, 622.8567429491243, 623.6164758673428, 624.0825985800866, 11888.881111188864, 11924.880751192464, 11992.580259690869, 11996.280223186637, 12045.217060891015, 11087.889121108767, 11134.888651113466, 11246.156538259664, 11358.204925655207, 11529.250598711056, 9276.768080797967, 9387.62449502019, 9452.149306562442, 9543.570539325747, 9767.658131965418, 3257.4136655402017, 3269.182704323919, 3302.025902358786, 3312.5362449257123, 3391.2030672791875, 35425.1143721409, 36200.27599447996, 38565.61434385648, 39408.60591394078, 41534.584654153674, 8621.008584012794, 9132.360734748636, 9353.438793672402, 9362.251019918527, 9437.811243775086, 15990.600234993986, 16151.192440377934, 16181.4336498222, 16187.10970896612, 16191.514254572381, 6424.614523128627, 6495.188101487314, 6566.606003639797, 6567.9671601641685, 6786.4570834333135, 3641.253543023674, 3661.377565813818, 3662.7436079474182, 3670.5778835434267, 3731.757435766721, 2637.709851916288, 2672.1983404978428, 2679.4641071785722, 2681.1554360376417, 2683.637708909272, 452.5158080853521, 470.44487504744046, 477.8853075261912, 479.80328065493677, 481.0475258987225, 503.88410665547127, 533.9973300133552, 588.9352171261157, 612.8927437698385, 624.6377101281246, 7631.0, 7653.349465295512, 7732.4200684948855, 7769.300762931251, 7792.883106753403, 442.33649525711434, 535.143769968048, 583.0670926517623, 590.5954421221477, 601.8074216250758, 3612.945805812915, 3647.2158485925124, 3674.191677830873, 3676.0993556578273, 3720.572134204547, 48160.75919620379, 48369.516304837205, 48740.26889596659, 48905.510944890804, 49336.75331623391, 44672.55327446684, 44688.77655611701, 45605.08789824185, 45705.085898281846, 45728.542714573094, 38398.424023639665, 39581.40627890584, 40203.195936081116, 41248.1750364997, 41847.0, 7613.276738709814, 7712.383009359126, 7964.283214510722, 7988.6405111768945, 8172.305354044973, 32149.517757234127, 32654.0, 32822.67177328292, 32893.17767055843, 34170.48744268788, 38301.0, 38689.2262154761, 39514.20971580495, 39954.60045399625, 40027.79986100051, 9972.850407243752, 10219.233557483367, 10468.63359782404, 10475.895241047492, 10479.371237725762, 11407.429628518375, 11530.135239857213, 11622.302661840316, 11717.121215909012, 11951.521939122338, 10524.736881578021, 10599.993000664925, 10649.89350106489, 11106.666799996014, 11108.055815255793, 10545.209109316986, 10604.734881627712, 10873.836892446778, 11200.663980080612, 11216.102711783202, 10576.682699519026, 10656.57373705043, 11005.944970275097, 11123.165762568002, 11194.776104477702, 9512.38169518979, 9574.04259574037, 9637.518124093907, 9671.806563868824, 9683.128518433376, 8830.381873268809, 9331.0, 9429.3399462037, 9455.858162127712, 9480.95259523698], "unit": "ms", "name": "yui.html", "value": 5773.892300462126}], "name": "dromaeo_css", "value": 6300.145765862326}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 113.0, 115.0, 114.0, 126.0, 115.0, 115.0, 115.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [160.0, 132.0, 158.0, 171.0, 132.0, 151.0, 160.0, 134.0, 169.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 165.0, 162.0, 162.0, 166.0, 173.0, 163.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 73.0, 72.0, 140.0, 72.0, 74.0, 79.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 132.0, 95.0, 94.0, 95.0, 129.0, 95.0, 97.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 154.0, 149.0, 148.0, 148.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 74.0, 76.0, 76.0, 76.0, 77.0, 75.0, 76.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 75.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 88.0, 96.0, 94.0, 86.0, 86.0, 86.0, 87.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [123.0, 127.0, 129.0, 119.0, 119.0, 118.0, 121.0, 132.0, 124.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [139.0, 154.0, 150.0, 152.0, 139.0, 152.0, 162.0, 153.0, 157.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 75.0, 74.0, 71.0, 71.0, 71.0, 73.0, 72.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1548.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [185.2881230313137], "unit": "score", "name": "DeltaBlue", "value": 356.8388459999999}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1088.139281828074], "unit": "score", "name": "RayTrace", "value": 680.0498910000001}, {"lowerIsBetter": false, "replicates": [719.626168224299], "unit": "score", "name": "Earley", "value": 926.1239090909096}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [604.9606775559589], "unit": "score", "name": "Splay", "value": 134.70462300000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21275.329386126035}]} 06:21:38 INFO - RETURN: dromaeo_css: 6300.15 06:21:38 INFO - RETURN: kraken: 1548.90 06:21:38 INFO - RETURN: v8_7: 21275.33 06:21:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21275.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1548.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6300.15"}}} 06:21:38 INFO - Return code: 0 06:21:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:21:38 INFO - # TBPL SUCCESS # 06:21:38 INFO - Running post-action listener: _resource_record_post_action 06:21:38 INFO - Running post-run listener: _resource_record_post_run 06:21:39 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518991872; Read time: 16; Write time: 451388 06:21:39 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 243056640; Read time: 0; Write time: 291736 06:21:39 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275935232; Read time: 16; Write time: 159652 06:21:39 INFO - Running post-run listener: _upload_blobber_files 06:21:39 INFO - Blob upload gear active. 06:21:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:21:39 INFO - Copying logs to upload dir... 06:21:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.955738 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-09 06:21:36.131460) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:36.134913) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010054 build_url: 'https://queue.taskcluster.net/v1/task/sovgcGqfTQuCI5EqRXA0sA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:36.191698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:36.192350) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449668887.683415-1235466546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 06:21:36.243140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 06:21:36.243512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 06:21:36.243861) ========= ========= Total master_lag: 0.31 =========