builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1449173313.5 results: success (0) buildid: 20151203113724 builduid: 5d9bb32907c844feb64f6f8e0d70f897 revision: ca30d9070e53f75b90b9710d2533bb5bf0a74240 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.499085) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.499625) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.500024) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.555221) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.556027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.642142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.642500) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.698046) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.698376) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.698764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.699089) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 12:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-03 12:08:33 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.876570) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.876884) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017844 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.932569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:33.933015) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca30d9070e53f75b90b9710d2533bb5bf0a74240 --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 ca30d9070e53f75b90b9710d2533bb5bf0a74240 --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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 12:08:34,128 truncating revision to first 12 chars 2015-12-03 12:08:34,128 Setting DEBUG logging. 2015-12-03 12:08:34,128 attempt 1/10 2015-12-03 12:08:34,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca30d9070e53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 12:08:34,441 unpacking tar archive at: fx-team-ca30d9070e53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:34.536593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:34.537114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:34.547339) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:34.547629) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 12:08:34.548043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-12-03 12:08:34.548412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:08:34 INFO - MultiFileLogger online at 20151203 12:08:34 in /builds/slave/test 12:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 12:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:34 INFO - {'append_to_log': False, 12:08:34 INFO - 'base_work_dir': '/builds/slave/test', 12:08:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:34 INFO - 'branch': 'Fx-Team-Non-PGO', 12:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:34 INFO - 'config_files': ('talos/linux_config.py',), 12:08:34 INFO - 'default_actions': ('clobber', 12:08:34 INFO - 'read-buildbot-config', 12:08:34 INFO - 'download-and-extract', 12:08:34 INFO - 'populate-webroot', 12:08:34 INFO - 'create-virtualenv', 12:08:34 INFO - 'install', 12:08:34 INFO - 'run-tests'), 12:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:34 INFO - 'download_minidump_stackwalk': True, 12:08:34 INFO - 'download_symbols': 'ondemand', 12:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 12:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 12:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:34 INFO - 'installer_path': 'installer.exe', 12:08:34 INFO - 'log_level': 'info', 12:08:34 INFO - 'log_name': 'talos', 12:08:34 INFO - 'log_to_console': True, 12:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:08:34 INFO - 'opt_config_files': (), 12:08:34 INFO - 'pip_index': False, 12:08:34 INFO - 'sps_profile': False, 12:08:34 INFO - 'sps_profile_interval': 0, 12:08:34 INFO - 'suite': 'dromaeojs', 12:08:34 INFO - 'system_bits': '64', 12:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:34 INFO - 'title': 'talos-linux64-ix-030', 12:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:34 INFO - 'use_talos_json': True, 12:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:34 INFO - 'work_dir': 'build'} 12:08:34 INFO - ##### 12:08:34 INFO - ##### Running clobber step. 12:08:34 INFO - ##### 12:08:34 INFO - Running pre-action listener: _resource_record_pre_action 12:08:34 INFO - Running main action method: clobber 12:08:34 INFO - rmtree: /builds/slave/test/build 12:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:35 INFO - Running post-action listener: _resource_record_post_action 12:08:35 INFO - ##### 12:08:35 INFO - ##### Running read-buildbot-config step. 12:08:35 INFO - ##### 12:08:35 INFO - Running pre-action listener: _resource_record_pre_action 12:08:35 INFO - Running main action method: read_buildbot_config 12:08:35 INFO - Using buildbot properties: 12:08:35 INFO - { 12:08:35 INFO - "properties": { 12:08:35 INFO - "buildnumber": 982, 12:08:35 INFO - "product": "firefox", 12:08:35 INFO - "script_repo_revision": "production", 12:08:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:08:35 INFO - "repository": "", 12:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:08:35 INFO - "buildid": "20151203113724", 12:08:35 INFO - "slavename": "talos-linux64-ix-030", 12:08:35 INFO - "pgo_build": "False", 12:08:35 INFO - "basedir": "/builds/slave/test", 12:08:35 INFO - "project": "", 12:08:35 INFO - "platform": "ubuntu64_hw", 12:08:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:08:35 INFO - "slavebuilddir": "test", 12:08:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:08:35 INFO - "branch": "fx-team", 12:08:35 INFO - "repo_path": "integration/fx-team", 12:08:35 INFO - "stage_platform": "linux64", 12:08:35 INFO - "builduid": "5d9bb32907c844feb64f6f8e0d70f897", 12:08:35 INFO - "revision": "ca30d9070e53f75b90b9710d2533bb5bf0a74240" 12:08:35 INFO - }, 12:08:35 INFO - "sourcestamp": { 12:08:35 INFO - "repository": "", 12:08:35 INFO - "hasPatch": false, 12:08:35 INFO - "project": "", 12:08:35 INFO - "branch": "fx-team-linux64-talos", 12:08:35 INFO - "changes": [ 12:08:35 INFO - { 12:08:35 INFO - "category": null, 12:08:35 INFO - "files": [ 12:08:35 INFO - { 12:08:35 INFO - "url": null, 12:08:35 INFO - "name": "https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:08:35 INFO - } 12:08:35 INFO - ], 12:08:35 INFO - "repository": "", 12:08:35 INFO - "rev": "ca30d9070e53f75b90b9710d2533bb5bf0a74240", 12:08:35 INFO - "who": "bgrinstead@mozilla.com", 12:08:35 INFO - "when": 1449173297, 12:08:35 INFO - "number": 6740518, 12:08:35 INFO - "comments": "Bug 1207868 - Fix lexical scope autocomplete for global 'let' and 'const';r=past", 12:08:35 INFO - "project": "", 12:08:35 INFO - "at": "Thu 03 Dec 2015 12:08:17", 12:08:35 INFO - "branch": "fx-team-linux64-talos", 12:08:35 INFO - "revlink": "", 12:08:35 INFO - "properties": [ 12:08:35 INFO - [ 12:08:35 INFO - "buildid", 12:08:35 INFO - "20151203113724", 12:08:35 INFO - "Change" 12:08:35 INFO - ], 12:08:35 INFO - [ 12:08:35 INFO - "builduid", 12:08:35 INFO - "5d9bb32907c844feb64f6f8e0d70f897", 12:08:35 INFO - "Change" 12:08:35 INFO - ], 12:08:35 INFO - [ 12:08:35 INFO - "pgo_build", 12:08:35 INFO - "False", 12:08:35 INFO - "Change" 12:08:35 INFO - ] 12:08:35 INFO - ], 12:08:35 INFO - "revision": "ca30d9070e53f75b90b9710d2533bb5bf0a74240" 12:08:35 INFO - } 12:08:35 INFO - ], 12:08:35 INFO - "revision": "ca30d9070e53f75b90b9710d2533bb5bf0a74240" 12:08:35 INFO - } 12:08:35 INFO - } 12:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:08:35 INFO - Running post-action listener: _resource_record_post_action 12:08:35 INFO - ##### 12:08:35 INFO - ##### Running download-and-extract step. 12:08:35 INFO - ##### 12:08:35 INFO - Running pre-action listener: _resource_record_pre_action 12:08:35 INFO - Running main action method: download_and_extract 12:08:35 INFO - mkdir: /builds/slave/test/build/tests 12:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:35 INFO - https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/test_packages.json 12:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/test_packages.json 12:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:08:40 INFO - Downloaded 1302 bytes. 12:08:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:08:40 INFO - Using the following test package requirements: 12:08:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:08:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:08:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:08:40 INFO - u'jsshell-linux-x86_64.zip'], 12:08:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:08:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:08:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:08:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:08:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:08:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:08:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:08:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:08:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:08: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')]} 12:08:40 INFO - https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:08:44 INFO - Downloaded 21788775 bytes. 12:08:44 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 12:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:08:44 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 12:08:45 INFO - Return code: 0 12:08:45 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 12:08:45 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')]} 12:08:45 INFO - https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:08:59 INFO - Downloaded 21788775 bytes. 12:08:59 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 12:08:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:08:59 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 12:09:00 INFO - Return code: 0 12:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:00 INFO - https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:09:02 INFO - Downloaded 11132001 bytes. 12:09:02 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 12:09:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:09:02 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 12:09:02 INFO - Return code: 0 12:09:02 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')]} 12:09:02 INFO - https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jmK2pB4wTLmuMY0oRCziFw/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 12:09:04 INFO - Downloaded 57687816 bytes. 12:09:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:09:04 INFO - mkdir: /builds/slave/test/properties 12:09:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:09:04 INFO - Writing to file /builds/slave/test/properties/build_url 12:09:04 INFO - Contents: 12:09:04 INFO - build_url:https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:09:04 INFO - Running post-action listener: _resource_record_post_action 12:09:04 INFO - Running post-action listener: set_extra_try_arguments 12:09:04 INFO - ##### 12:09:04 INFO - ##### Running populate-webroot step. 12:09:04 INFO - ##### 12:09:04 INFO - Running pre-action listener: _resource_record_pre_action 12:09:04 INFO - Running main action method: populate_webroot 12:09:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:09:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:09:04 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:09:04 INFO - '../fennec_ids.txt'], 12:09:04 INFO - 'tests': ['tcheck2']}, 12:09:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:09:04 INFO - '--tppagecycles', 12:09:04 INFO - '7'], 12:09:04 INFO - 'tests': ['tsvgm']}}, 12:09:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:09:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:09:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:09:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:09:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'tests': ['damp', 'tps']}, 12:09:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['damp', 'tps']}, 12:09:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:09:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:09:04 INFO - 'other': {'tests': ['a11yr', 12:09:04 INFO - 'ts_paint', 12:09:04 INFO - 'tpaint', 12:09:04 INFO - 'sessionrestore', 12:09:04 INFO - 'sessionrestore_no_auto_restore']}, 12:09:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['a11yr', 12:09:04 INFO - 'ts_paint', 12:09:04 INFO - 'tpaint', 12:09:04 INFO - 'sessionrestore', 12:09:04 INFO - 'sessionrestore_no_auto_restore']}, 12:09:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['a11yr', 12:09:04 INFO - 'ts_paint', 12:09:04 INFO - 'tpaint', 12:09:04 INFO - 'sessionrestore', 12:09:04 INFO - 'sessionrestore_no_auto_restore']}, 12:09:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['a11yr', 12:09:04 INFO - 'ts_paint', 12:09:04 INFO - 'tpaint', 12:09:04 INFO - 'sessionrestore', 12:09:04 INFO - 'sessionrestore_no_auto_restore']}, 12:09:04 INFO - 'other_l64': {'tests': ['a11yr', 12:09:04 INFO - 'ts_paint', 12:09:04 INFO - 'tpaint', 12:09:04 INFO - 'sessionrestore', 12:09:04 INFO - 'sessionrestore_no_auto_restore']}, 12:09:04 INFO - 'other_nol64': {'tests': ['a11yr', 12:09:04 INFO - 'ts_paint', 12:09:04 INFO - 'tpaint', 12:09:04 INFO - 'sessionrestore', 12:09:04 INFO - 'sessionrestore_no_auto_restore']}, 12:09:04 INFO - 'svgr': {'tests': ['tsvgx', 12:09:04 INFO - 'tsvgr_opacity', 12:09:04 INFO - 'tart', 12:09:04 INFO - 'tscrollx', 12:09:04 INFO - 'cart']}, 12:09:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['tsvgx', 12:09:04 INFO - 'tsvgr_opacity', 12:09:04 INFO - 'tart', 12:09:04 INFO - 'tscrollx', 12:09:04 INFO - 'cart']}, 12:09:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'tests': ['tp5o']}, 12:09:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'talos_options': ['--e10s'], 12:09:04 INFO - 'tests': ['tp5o']}, 12:09:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'talos_options': ['--xperf_path', 12:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:04 INFO - 'tests': ['tp5n']}, 12:09:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:04 INFO - 'talos_options': ['--e10s', 12:09:04 INFO - '--xperf_path', 12:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:04 INFO - 'tests': ['tp5n']}}, 12:09:04 INFO - 'talos.zip': {'path': '', 12:09:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:09:04 INFO - Running post-action listener: _resource_record_post_action 12:09:04 INFO - ##### 12:09:04 INFO - ##### Running create-virtualenv step. 12:09:04 INFO - ##### 12:09:04 INFO - Running pre-action listener: _resource_record_pre_action 12:09:04 INFO - Running main action method: create_virtualenv 12:09:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:09:04 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 12:09:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:09:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:09:04 INFO - Using real prefix '/usr' 12:09:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:09:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:09:06 INFO - Installing pip.................done. 12:09:06 INFO - Return code: 0 12:09:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:09:06 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')]} 12:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 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')]} 12:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:06 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 12:09:06 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 12:09:06 INFO - Using env: {'DISPLAY': ':0', 12:09:06 INFO - 'HOME': '/home/cltbld', 12:09:06 INFO - 'LANG': 'en_US.UTF-8', 12:09:06 INFO - 'LANGUAGE': 'en_US:en', 12:09:06 INFO - 'LOGNAME': 'cltbld', 12:09:06 INFO - 'MAIL': '/var/mail/cltbld', 12:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:06 INFO - 'MOZ_NO_REMOTE': '1', 12:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:06 INFO - 'NO_EM_RESTART': '1', 12:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:06 INFO - 'PWD': '/builds/slave/test', 12:09:06 INFO - 'SHELL': '/bin/bash', 12:09:06 INFO - 'SHLVL': '1', 12:09:06 INFO - 'TERM': 'linux', 12:09:06 INFO - 'TMOUT': '86400', 12:09:06 INFO - 'USER': 'cltbld', 12:09:06 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:06 INFO - '_': '/tools/buildbot/bin/python'} 12:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:06 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 12:09:06 INFO - Cleaning up... 12:09:07 INFO - Return code: 0 12:09:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:09:07 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')]} 12:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:07 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')]} 12:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:07 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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:07 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 12:09:07 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 12:09:07 INFO - Using env: {'DISPLAY': ':0', 12:09:07 INFO - 'HOME': '/home/cltbld', 12:09:07 INFO - 'LANG': 'en_US.UTF-8', 12:09:07 INFO - 'LANGUAGE': 'en_US:en', 12:09:07 INFO - 'LOGNAME': 'cltbld', 12:09:07 INFO - 'MAIL': '/var/mail/cltbld', 12:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:07 INFO - 'MOZ_NO_REMOTE': '1', 12:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:07 INFO - 'NO_EM_RESTART': '1', 12:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:07 INFO - 'PWD': '/builds/slave/test', 12:09:07 INFO - 'SHELL': '/bin/bash', 12:09:07 INFO - 'SHLVL': '1', 12:09:07 INFO - 'TERM': 'linux', 12:09:07 INFO - 'TMOUT': '86400', 12:09:07 INFO - 'USER': 'cltbld', 12:09:07 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:07 INFO - '_': '/tools/buildbot/bin/python'} 12:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:07 INFO - Downloading/unpacking psutil>=0.7.1 12:09:07 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 12:09:07 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 12:09:07 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 12:09:07 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 12:09:07 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 12:09:07 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 12:09:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:09:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:09 INFO - Installing collected packages: psutil 12:09:09 INFO - Running setup.py install for psutil 12:09:09 INFO - building 'psutil._psutil_linux' extension 12:09:09 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 12:09:09 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 12:09:09 INFO - building 'psutil._psutil_posix' extension 12:09:09 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 12:09:09 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 12:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:09 INFO - Successfully installed psutil 12:09:09 INFO - Cleaning up... 12:09:09 INFO - Return code: 0 12:09:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:09:09 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')]} 12:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:09 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')]} 12:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:09 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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:09 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 12:09:09 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 12:09:09 INFO - Using env: {'DISPLAY': ':0', 12:09:09 INFO - 'HOME': '/home/cltbld', 12:09:09 INFO - 'LANG': 'en_US.UTF-8', 12:09:09 INFO - 'LANGUAGE': 'en_US:en', 12:09:09 INFO - 'LOGNAME': 'cltbld', 12:09:09 INFO - 'MAIL': '/var/mail/cltbld', 12:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:09 INFO - 'MOZ_NO_REMOTE': '1', 12:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:09 INFO - 'NO_EM_RESTART': '1', 12:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:09 INFO - 'PWD': '/builds/slave/test', 12:09:09 INFO - 'SHELL': '/bin/bash', 12:09:09 INFO - 'SHLVL': '1', 12:09:09 INFO - 'TERM': 'linux', 12:09:09 INFO - 'TMOUT': '86400', 12:09:09 INFO - 'USER': 'cltbld', 12:09:09 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:09 INFO - '_': '/tools/buildbot/bin/python'} 12:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:09:11 INFO - Installing collected packages: mozsystemmonitor 12:09:11 INFO - Running setup.py install for mozsystemmonitor 12:09:11 INFO - Successfully installed mozsystemmonitor 12:09:11 INFO - Cleaning up... 12:09:11 INFO - Return code: 0 12:09:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:11 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 12:09:11 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 12:09:11 INFO - Using env: {'DISPLAY': ':0', 12:09:11 INFO - 'HOME': '/home/cltbld', 12:09:11 INFO - 'LANG': 'en_US.UTF-8', 12:09:11 INFO - 'LANGUAGE': 'en_US:en', 12:09:11 INFO - 'LOGNAME': 'cltbld', 12:09:11 INFO - 'MAIL': '/var/mail/cltbld', 12:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:11 INFO - 'MOZ_NO_REMOTE': '1', 12:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:11 INFO - 'NO_EM_RESTART': '1', 12:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:11 INFO - 'PWD': '/builds/slave/test', 12:09:11 INFO - 'SHELL': '/bin/bash', 12:09:11 INFO - 'SHLVL': '1', 12:09:11 INFO - 'TERM': 'linux', 12:09:11 INFO - 'TMOUT': '86400', 12:09:11 INFO - 'USER': 'cltbld', 12:09:11 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:11 INFO - '_': '/tools/buildbot/bin/python'} 12:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:11 INFO - Downloading/unpacking blobuploader==1.2.4 12:09:11 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 12:09:11 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 12:09:11 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 12:09:11 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 12:09:11 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 12:09:11 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 12:09:13 INFO - Downloading blobuploader-1.2.4.tar.gz 12:09:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:09:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:09:13 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 12:09:13 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 12:09:13 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 12:09:13 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 12:09:13 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 12:09:13 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 12:09:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:09:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:09:13 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 12:09:13 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 12:09:13 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 12:09:13 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 12:09:13 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 12:09:13 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 12:09:14 INFO - Downloading docopt-0.6.1.tar.gz 12:09:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:09:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:09:14 INFO - Running setup.py install for blobuploader 12:09:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:09:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:09:14 INFO - Running setup.py install for requests 12:09:14 INFO - Running setup.py install for docopt 12:09:14 INFO - Successfully installed blobuploader requests docopt 12:09:14 INFO - Cleaning up... 12:09:14 INFO - Return code: 0 12:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:14 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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:14 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 12:09:14 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 12:09:14 INFO - Using env: {'DISPLAY': ':0', 12:09:14 INFO - 'HOME': '/home/cltbld', 12:09:14 INFO - 'LANG': 'en_US.UTF-8', 12:09:14 INFO - 'LANGUAGE': 'en_US:en', 12:09:14 INFO - 'LOGNAME': 'cltbld', 12:09:14 INFO - 'MAIL': '/var/mail/cltbld', 12:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:14 INFO - 'MOZ_NO_REMOTE': '1', 12:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:14 INFO - 'NO_EM_RESTART': '1', 12:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:14 INFO - 'PWD': '/builds/slave/test', 12:09:14 INFO - 'SHELL': '/bin/bash', 12:09:14 INFO - 'SHLVL': '1', 12:09:14 INFO - 'TERM': 'linux', 12:09:14 INFO - 'TMOUT': '86400', 12:09:14 INFO - 'USER': 'cltbld', 12:09:14 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:14 INFO - '_': '/tools/buildbot/bin/python'} 12:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:15 INFO - Running setup.py (path:/tmp/pip-xUc7TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:15 INFO - Running setup.py (path:/tmp/pip-uxNGwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:15 INFO - Running setup.py (path:/tmp/pip-ytTi89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:15 INFO - Running setup.py (path:/tmp/pip-dsxlGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:15 INFO - Running setup.py (path:/tmp/pip-uIq87g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:15 INFO - Running setup.py (path:/tmp/pip-_3Nret-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:15 INFO - Running setup.py (path:/tmp/pip-Vbjuq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:15 INFO - Running setup.py (path:/tmp/pip-HmZY_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:15 INFO - Running setup.py (path:/tmp/pip-StlJDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:15 INFO - Running setup.py (path:/tmp/pip-USonEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:15 INFO - Running setup.py (path:/tmp/pip-KAK8H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:15 INFO - Running setup.py (path:/tmp/pip-MGXOx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:15 INFO - Running setup.py (path:/tmp/pip-JQWugx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:15 INFO - Running setup.py (path:/tmp/pip-T29U6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:16 INFO - Running setup.py (path:/tmp/pip-26N9Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:16 INFO - Running setup.py (path:/tmp/pip-u2grjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:16 INFO - Running setup.py (path:/tmp/pip-K6Bhwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:09:16 INFO - Running setup.py install for manifestparser 12:09:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:09:16 INFO - Running setup.py install for mozcrash 12:09:16 INFO - Running setup.py install for mozdebug 12:09:16 INFO - Running setup.py install for mozdevice 12:09:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:09:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:09:16 INFO - Running setup.py install for mozfile 12:09:16 INFO - Running setup.py install for mozhttpd 12:09:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:09:16 INFO - Running setup.py install for mozinfo 12:09:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:09:16 INFO - Running setup.py install for mozInstall 12:09:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Running setup.py install for mozleak 12:09:17 INFO - Running setup.py install for mozlog 12:09:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Running setup.py install for moznetwork 12:09:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Running setup.py install for mozprocess 12:09:17 INFO - Running setup.py install for mozprofile 12:09:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Running setup.py install for mozrunner 12:09:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:09:17 INFO - Running setup.py install for mozscreenshot 12:09:17 INFO - Running setup.py install for moztest 12:09:17 INFO - Running setup.py install for mozversion 12:09:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:09:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:09:18 INFO - Cleaning up... 12:09:18 INFO - Return code: 0 12:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:18 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 12:09:18 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 12:09:18 INFO - Using env: {'DISPLAY': ':0', 12:09:18 INFO - 'HOME': '/home/cltbld', 12:09:18 INFO - 'LANG': 'en_US.UTF-8', 12:09:18 INFO - 'LANGUAGE': 'en_US:en', 12:09:18 INFO - 'LOGNAME': 'cltbld', 12:09:18 INFO - 'MAIL': '/var/mail/cltbld', 12:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:18 INFO - 'MOZ_NO_REMOTE': '1', 12:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:18 INFO - 'NO_EM_RESTART': '1', 12:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:18 INFO - 'PWD': '/builds/slave/test', 12:09:18 INFO - 'SHELL': '/bin/bash', 12:09:18 INFO - 'SHLVL': '1', 12:09:18 INFO - 'TERM': 'linux', 12:09:18 INFO - 'TMOUT': '86400', 12:09:18 INFO - 'USER': 'cltbld', 12:09:18 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:18 INFO - '_': '/tools/buildbot/bin/python'} 12:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:18 INFO - Running setup.py (path:/tmp/pip-DsSBwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:18 INFO - Running setup.py (path:/tmp/pip-uAPgQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:18 INFO - Running setup.py (path:/tmp/pip-mc40Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:18 INFO - Running setup.py (path:/tmp/pip-e0iSpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:18 INFO - Running setup.py (path:/tmp/pip-AmvNZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:18 INFO - Running setup.py (path:/tmp/pip-hU6Jy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:18 INFO - Running setup.py (path:/tmp/pip-o0nuOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:18 INFO - Running setup.py (path:/tmp/pip-4GoBSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:18 INFO - Running setup.py (path:/tmp/pip-U9PW_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:18 INFO - Running setup.py (path:/tmp/pip-53ftCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:18 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)) 12:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:18 INFO - Running setup.py (path:/tmp/pip-Fk195n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:19 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)) 12:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:19 INFO - Running setup.py (path:/tmp/pip-e3szUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:19 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)) 12:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:19 INFO - Running setup.py (path:/tmp/pip-X_aZrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:19 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)) 12:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:19 INFO - Running setup.py (path:/tmp/pip-JhPKcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:19 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)) 12:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:19 INFO - Running setup.py (path:/tmp/pip-k8MVN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:19 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)) 12:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:19 INFO - Running setup.py (path:/tmp/pip-GtMohj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:19 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)) 12:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:19 INFO - Running setup.py (path:/tmp/pip-5jQASy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:19 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)) 12:09:19 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)) 12:09:19 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)) 12:09:19 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)) 12:09:19 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)) 12:09:19 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)) 12:09:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:19 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 12:09:19 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 12:09:19 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 12:09:19 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 12:09:19 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 12:09:19 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 12:09:21 INFO - Downloading blessings-1.5.1.tar.gz 12:09:21 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 12:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:09:21 INFO - Installing collected packages: blessings 12:09:21 INFO - Running setup.py install for blessings 12:09:21 INFO - Successfully installed blessings 12:09:21 INFO - Cleaning up... 12:09:21 INFO - Return code: 0 12:09:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:21 INFO - Reading from file tmpfile_stdout 12:09:21 INFO - Current package versions: 12:09:21 INFO - argparse == 1.2.1 12:09:21 INFO - blessings == 1.5.1 12:09:21 INFO - blobuploader == 1.2.4 12:09:21 INFO - docopt == 0.6.1 12:09:21 INFO - manifestparser == 1.1 12:09:21 INFO - mozInstall == 1.12 12:09:21 INFO - mozcrash == 0.16 12:09:21 INFO - mozdebug == 0.1 12:09:21 INFO - mozdevice == 0.47 12:09:21 INFO - mozfile == 1.2 12:09:21 INFO - mozhttpd == 0.7 12:09:21 INFO - mozinfo == 0.9 12:09:21 INFO - mozleak == 0.1 12:09:21 INFO - mozlog == 3.1 12:09:21 INFO - moznetwork == 0.27 12:09:21 INFO - mozprocess == 0.22 12:09:21 INFO - mozprofile == 0.27 12:09:21 INFO - mozrunner == 6.11 12:09:21 INFO - mozscreenshot == 0.1 12:09:21 INFO - mozsystemmonitor == 0.0 12:09:21 INFO - moztest == 0.7 12:09:21 INFO - mozversion == 1.4 12:09:21 INFO - psutil == 3.1.1 12:09:21 INFO - requests == 1.2.3 12:09:21 INFO - wsgiref == 0.1.2 12:09:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:21 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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:21 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 12:09:21 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 12:09:21 INFO - Using env: {'DISPLAY': ':0', 12:09:21 INFO - 'HOME': '/home/cltbld', 12:09:21 INFO - 'LANG': 'en_US.UTF-8', 12:09:21 INFO - 'LANGUAGE': 'en_US:en', 12:09:21 INFO - 'LOGNAME': 'cltbld', 12:09:21 INFO - 'MAIL': '/var/mail/cltbld', 12:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:21 INFO - 'MOZ_NO_REMOTE': '1', 12:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:21 INFO - 'NO_EM_RESTART': '1', 12:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:21 INFO - 'PWD': '/builds/slave/test', 12:09:21 INFO - 'SHELL': '/bin/bash', 12:09:21 INFO - 'SHLVL': '1', 12:09:21 INFO - 'TERM': 'linux', 12:09:21 INFO - 'TMOUT': '86400', 12:09:21 INFO - 'USER': 'cltbld', 12:09:21 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:21 INFO - '_': '/tools/buildbot/bin/python'} 12:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 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)) 12:09:21 INFO - Cleaning up... 12:09:21 INFO - Return code: 0 12:09:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:21 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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:21 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 12:09:21 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 12:09:21 INFO - Using env: {'DISPLAY': ':0', 12:09:21 INFO - 'HOME': '/home/cltbld', 12:09:21 INFO - 'LANG': 'en_US.UTF-8', 12:09:21 INFO - 'LANGUAGE': 'en_US:en', 12:09:21 INFO - 'LOGNAME': 'cltbld', 12:09:21 INFO - 'MAIL': '/var/mail/cltbld', 12:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:21 INFO - 'MOZ_NO_REMOTE': '1', 12:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:21 INFO - 'NO_EM_RESTART': '1', 12:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:21 INFO - 'PWD': '/builds/slave/test', 12:09:21 INFO - 'SHELL': '/bin/bash', 12:09:21 INFO - 'SHLVL': '1', 12:09:21 INFO - 'TERM': 'linux', 12:09:21 INFO - 'TMOUT': '86400', 12:09:21 INFO - 'USER': 'cltbld', 12:09:21 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:21 INFO - '_': '/tools/buildbot/bin/python'} 12:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:22 INFO - Downloading/unpacking jsonschema 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:09:23 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 12:09:23 INFO - Downloading/unpacking functools32 (from jsonschema) 12:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:09:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:09:23 INFO - warning: no files found matching '*.txt' 12:09:23 INFO - no previously-included directories found matching 'build' 12:09:23 INFO - no previously-included directories found matching 'dist' 12:09:23 INFO - no previously-included directories found matching '.git*' 12:09:23 INFO - Installing collected packages: jsonschema, functools32 12:09:24 INFO - Running setup.py install for functools32 12:09:24 INFO - warning: no files found matching '*.txt' 12:09:24 INFO - no previously-included directories found matching 'build' 12:09:24 INFO - no previously-included directories found matching 'dist' 12:09:24 INFO - no previously-included directories found matching '.git*' 12:09:24 INFO - Successfully installed jsonschema functools32 12:09:24 INFO - Cleaning up... 12:09:24 INFO - Return code: 0 12:09:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f6c51725f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', '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 12:09:24 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 12:09:24 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 12:09:24 INFO - Using env: {'DISPLAY': ':0', 12:09:24 INFO - 'HOME': '/home/cltbld', 12:09:24 INFO - 'LANG': 'en_US.UTF-8', 12:09:24 INFO - 'LANGUAGE': 'en_US:en', 12:09:24 INFO - 'LOGNAME': 'cltbld', 12:09:24 INFO - 'MAIL': '/var/mail/cltbld', 12:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:24 INFO - 'MOZ_NO_REMOTE': '1', 12:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:24 INFO - 'NO_EM_RESTART': '1', 12:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:24 INFO - 'PWD': '/builds/slave/test', 12:09:24 INFO - 'SHELL': '/bin/bash', 12:09:24 INFO - 'SHLVL': '1', 12:09:24 INFO - 'TERM': 'linux', 12:09:24 INFO - 'TMOUT': '86400', 12:09:24 INFO - 'USER': 'cltbld', 12:09:24 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:24 INFO - '_': '/tools/buildbot/bin/python'} 12:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:24 INFO - Downloading/unpacking flake8 12:09:24 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 12:09:24 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 12:09:24 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 12:09:24 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 12:09:24 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 12:09:24 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 12:09:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:09:26 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 12:09:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:09:26 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 12:09:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:26 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 12:09:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:09:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:09:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:09:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:09:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:09:26 INFO - no previously-included directories found matching 'docs/_build' 12:09:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:09:26 INFO - Running setup.py install for pep8 12:09:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:09:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:09:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:09:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:09:26 INFO - no previously-included directories found matching 'docs/_build' 12:09:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:09:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:09:26 INFO - Cleaning up... 12:09:26 INFO - Return code: 0 12:09:26 INFO - Running post-action listener: _resource_record_post_action 12:09:26 INFO - Running post-action listener: _start_resource_monitoring 12:09:26 INFO - Starting resource monitoring. 12:09:26 INFO - ##### 12:09:26 INFO - ##### Running install step. 12:09:26 INFO - ##### 12:09:26 INFO - Running pre-action listener: _resource_record_pre_action 12:09:26 INFO - Running main action method: install 12:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:27 INFO - Reading from file tmpfile_stdout 12:09:27 INFO - Detecting whether we're running mozinstall >=1.0... 12:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:09:27 INFO - Reading from file tmpfile_stdout 12:09:27 INFO - Output received: 12:09:27 INFO - Usage: mozinstall [options] installer 12:09:27 INFO - Options: 12:09:27 INFO - -h, --help show this help message and exit 12:09:27 INFO - -d DEST, --destination=DEST 12:09:27 INFO - Directory to install application into. [default: 12:09:27 INFO - "/builds/slave/test"] 12:09:27 INFO - --app=APP Application being installed. [default: firefox] 12:09:27 INFO - mkdir: /builds/slave/test/build/application 12:09:27 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'] 12:09:27 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 12:09:41 INFO - Reading from file tmpfile_stdout 12:09:41 INFO - Output received: 12:09:41 INFO - /builds/slave/test/build/application/firefox/firefox 12:09:41 INFO - Running post-action listener: _resource_record_post_action 12:09:41 INFO - ##### 12:09:41 INFO - ##### Running run-tests step. 12:09:41 INFO - ##### 12:09:41 INFO - Running pre-action listener: _resource_record_pre_action 12:09:41 INFO - Running main action method: run_tests 12:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:09:41 INFO - Python 2.7.3 12:09:41 INFO - Return code: 0 12:09:41 INFO - grabbing minidump binary from tooltool 12:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:41 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 0x232c0b0>, '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 0x232cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:09:41 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 12:09:41 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 12:09:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:09:41 INFO - Return code: 0 12:09:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:09:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:09:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:09:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:09:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:09:42 INFO - Return code: 0 12:09:42 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 12:09:42 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 12:09:42 INFO - Using env: {'DISPLAY': ':0', 12:09:42 INFO - 'HOME': '/home/cltbld', 12:09:42 INFO - 'LANG': 'en_US.UTF-8', 12:09:42 INFO - 'LANGUAGE': 'en_US:en', 12:09:42 INFO - 'LOGNAME': 'cltbld', 12:09:42 INFO - 'MAIL': '/var/mail/cltbld', 12:09:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:09:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:42 INFO - 'MOZ_NO_REMOTE': '1', 12:09:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:42 INFO - 'NO_EM_RESTART': '1', 12:09:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:42 INFO - 'PWD': '/builds/slave/test', 12:09:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:09:42 INFO - 'SHELL': '/bin/bash', 12:09:42 INFO - 'SHLVL': '1', 12:09:42 INFO - 'TERM': 'linux', 12:09:42 INFO - 'TMOUT': '86400', 12:09:42 INFO - 'USER': 'cltbld', 12:09:42 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396', 12:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:42 INFO - '_': '/tools/buildbot/bin/python'} 12:09:42 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 12:09:42 INFO - mozversion INFO | application_buildid: 20151203113724 12:09:42 INFO - mozversion INFO | application_changeset: ca30d9070e53f75b90b9710d2533bb5bf0a74240 12:09:42 INFO - mozversion INFO | application_display_name: Nightly 12:09:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:09:42 INFO - mozversion INFO | application_name: Firefox 12:09:42 INFO - mozversion INFO | application_remotingname: firefox 12:09:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:09:42 INFO - mozversion INFO | application_vendor: Mozilla 12:09:42 INFO - mozversion INFO | application_version: 45.0a1 12:09:42 INFO - mozversion INFO | platform_buildid: 20151203113724 12:09:42 INFO - mozversion INFO | platform_changeset: ca30d9070e53f75b90b9710d2533bb5bf0a74240 12:09:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:09:42 INFO - mozversion INFO | platform_version: 45.0a1 12:09:42 INFO - 2015-12-03 12:09:42,959 DEBUG : using testdate: 1449173382 12:09:42 INFO - 2015-12-03 12:09:42,959 DEBUG : actual date: 1449173382 12:09:43 INFO - 2015-12-03 12:09:43,006 INFO : starting webserver on 'localhost:47847' 12:09:43 INFO - 2015-12-03 12:09:43,007 INFO : Starting test suite talos-linux64-ix-030 12:09:43 INFO - 2015-12-03 12:09:43,007 INFO : Starting test dromaeo_css 12:09:43 INFO - 2015-12-03 12:09:43,008 DEBUG : operating with platform_type : linux_ 12:09:43 INFO - 2015-12-03 12:09:43,008 INFO : Initialising browser for dromaeo_css test... 12:09:43 INFO - 2015-12-03 12:09:43,025 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfj0dAx/profile http://localhost:47847/getInfo.html 12:09:47 INFO - 2015-12-03 12:09:47,355 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:09:47 INFO - 2015-12-03 12:09:47,355 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:09:47 INFO - 2015-12-03 12:09:47,355 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:09:47 INFO - 2015-12-03 12:09:47,355 DEBUG : BROWSER_OUTPUT: __metrics 12:09:47 INFO - 2015-12-03 12:09:47,464 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] 12:09:47 INFO - 2015-12-03 12:09:47,525 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:48 INFO - 2015-12-03 12:09:48,594 INFO : Browser initialized. 12:09:48 INFO - 2015-12-03 12:09:48,595 INFO : Running cycle 1/1 for dromaeo_css test... 12:09:48 INFO - 2015-12-03 12:09:48,595 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfj0dAx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:10:00 INFO - 2015-12-03 12:10:00,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 142417920 12:10:00 INFO - 2015-12-03 12:10:00,608 DEBUG : BROWSER_OUTPUT: 12:10:51 INFO - 2015-12-03 12:10:51,978 DEBUG : BROWSER_OUTPUT: 1449173451977 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] 12:13:04 INFO - 2015-12-03 12:13:04,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47847/tests/dromaeo/cssquery-ext.html) 12:13:05 INFO - 2015-12-03 12:13:05,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 259719168 12:13:05 INFO - 2015-12-03 12:13:05,251 DEBUG : BROWSER_OUTPUT: 12:16:07 INFO - 2015-12-03 12:16:07,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/dromaeo/cssquery-ext.html (next: http://localhost:47847/tests/dromaeo/cssquery-jquery.html) 12:16:08 INFO - 2015-12-03 12:16:08,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 230215680 12:16:08 INFO - 2015-12-03 12:16:08,426 DEBUG : BROWSER_OUTPUT: 12:19:10 INFO - 2015-12-03 12:19:10,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47847/tests/dromaeo/cssquery-mootools.html) 12:19:11 INFO - 2015-12-03 12:19:11,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 218079232 12:19:11 INFO - 2015-12-03 12:19:11,077 DEBUG : BROWSER_OUTPUT: 12:22:13 INFO - 2015-12-03 12:22:13,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47847/tests/dromaeo/cssquery-prototype.html) 12:22:13 INFO - 2015-12-03 12:22:13,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 200065024 12:22:13 INFO - 2015-12-03 12:22:13,670 DEBUG : BROWSER_OUTPUT: 12:25:16 INFO - 2015-12-03 12:25:16,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47847/tests/dromaeo/cssquery-yui.html) 12:25:16 INFO - 2015-12-03 12:25:16,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 212897792 12:25:16 INFO - 2015-12-03 12:25:16,943 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/dromaeo/cssquery-yui.html (next: http://localhost:47847/tests/dromaeo/cssquery-dojo.html) 12:28:19 INFO - 2015-12-03 12:28:19,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 253075456 12:28:19 INFO - 2015-12-03 12:28:19,585 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,585 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:28:19 INFO - 2015-12-03 12:28:19,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:28:19 INFO - 2015-12-03 12:28:19,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:28:19 INFO - 2015-12-03 12:28:19,586 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:28:19 INFO - 2015-12-03 12:28:19,589 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2615.3200167956334;2696.069855899715;2699.838009719418;2706.472237913605;2722.646056012718;4503.909921801562;4630.467496237934;4695.46002209746;4713.434387873455;4734.384530011098;4575.611073058785;4591;4598.678092533516;4646.6515011374195;4659.440867095945;4359.367891655708;4360.760158191299;4374.715643483163;4390.824367025315;4410.580994805488;4203.663706903456;4410.823567057314;4419.911601767963;4477.910441791162;4498.100379924012;4193.433886425354;4260.510041345254;4274.636655884223;4293.0340673348555;4310.935335969963;4333.328334108187;4335.934960975588;4341.066670665822;4357.237483440385;4392.934105988413;4167.124903770212;4278.272693642057;4320.11437655283;4350.8042138103865;4393.275109606911;4506.459224893034;4651.372064771246;4729.69256998294;4748.501407352247;4784;4978.676386034932;4988.65079444439;5002.624803139743;5008.824691135793;5054.469280725508;4846.321514987904;4967.751612419364;5032.4212715537815;5063.518965698289;5072.315237442972;4613.1696294666945;4661.04448588042;4717.292406139107;4734.124187025412;4783.306420568998;5210;5229.607779416559;5233.816816411408;5241.397239317527;5280.339957505312;4750.192467280571;4863.829765958175;5004.099262132779;5023.673461225008;5024.974875125674;4981.028699403581;5006.274090256892;5051.520105589963;5055.216441451581;5075.593952483866;4969.378827646544;4990.950090499121;4993.226049962262;4997.9750101249265;5042.168042272984;4761.523847615211;4871.732054737024;4958.776855041532;4964.05682920244;5022.4977502249485;4122.237386083584;4148.79256037197;4176.686748493875;4199.958000420018;4207.789610519461;3671.3942199536777;3715.888523344304;3721.8697345592773;3723.627637236309;3759.3045286622064;4174.3947127666315;4341.45731783527;4360.149770794728;4363.2364336241035;4407.052483715952;4885.560299573055;4942.728149951788;4945.109880221523;4989.875253118701;5001.949980500149;4278.2085314216965;4298.312270036779;4337.284348082531;4337.587929146726;4365.4979677337515;4233.830646774095;4471.306947423154;4486.641068714495;4489.663275254369;4513.796879140446;4680.508546602694;4739.7630118493935;4752.025834703946;4765.880852978565;4798.016406636701;4973.45292017885;5058.165402708659;5070.188769796815;5074.3657042869645;5101.617378696538;4634.351190833353;4786.210275304536;4801.255805350176;4802.687825291345;4842.225243960949;4886.902261954812;4919.409670839379;4926.088673595396;4942.135126352946;5007.624428167975;5081.060003899142;5102.311187989574;5112.437631860418;5122.462141475092;5160.277561141368;4725.1967165581245;4943.233798761198;4951.8266860659705;4955.058538877602;4965.553100220997;4778.211595086772;4806.086843499724;4810.134175848241;4862.781174847069;4878.292647566154;4731.195696731633;4764.3568118304975;4771.5467030632035;4775.880602984953;4826.179549476527;4779.426468823764;4885.1206782779445;4901.362822833009;4904.975475122602;4949.109160351171;4621.353010578455;4657.254839225843;4712.52874712526;4725.456572494207;4748.525147485224 12:28:19 INFO - 2015-12-03 12:28:19,589 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.9413111623277;569.7379205565439;570.7260514952825;571.7798647520704;575.4619430832172;25959.480810383782;26242.34394140143;26303.947842086316;26325.157238993277;35705.46441803375;39413.802930985374;39967.600323996754;40023;40024;40026;7875.133735289128;8048.557329346883;8051.275385215329;8051.718189863356;8052.838943221162;7198;7373.778786636382;7375.373093287077;7847.372210223169;10190.64332748354;10156.390616562992;10260.846087308697;10277.897221027806;10289.63986260481;10299.845502317434;10121.696349109501;10165.644202452879;10219.591216351337;10222.284440089234;10233.692989210336;7195.064641596611;7383.2985866342615;10220.948895255477;10484.947575262151;10497.79004419915;36974.81512592447;37404.25191496155;37405.25189496222;37434.25131497382;37449.43825842615;2914.2422970027733;2929.5312749960117;3084.013115802944;3423.3666771647327;3479.0954351868445;28057.859710701316;28271.71728282732;28273.717262827315;28349.57475637867;28366.716332836615;3205.3268813549184;3225.225945773021;3306.0908250231137;3332.0836769888233;3343.782654127474;208814;209956;211417;211445;212728.9363553188;45165.774171128935;47708.284375734394;53505.7324713374;53820.192697109575;53829;57943.4205657938;60279.69860150671;60395.39604603986;60464.395356045876;60522.092168617506;13089.738205235843;13309.800352994713;13310.733785324239;13311.334433278298;13330.066895317235;9668.951655241679;9672.468014259142;9701.07839755222;9709.126178643955;9717.951410242904;18295.54261143482;18940.90529547371;19121.904390477957;19276.61446771085;19280.61438771217;7310.6710198040155;7584.62076896153;7617.5048621839405;7625.856121581807;7703.8844417333785;887.8623813308948;901.2519608724742;967.0426277984885;1010.0000999011073;1033.4109557552274;25279.494410111696;26600.625755955192;26722.331941701224;26803.195904122516;27012.189634311002;970.8009857979098;972.5137431284357;976.9853452198223;1050.5955207245113;1098.9560417583366;14015.229162396166;14073.929630351988;14081.71836563263;14209.289535523183;14288.785668214985;247275;252749;252777;253332;253473;38574.42138367927;45971;46471.5352846474;46480.7675961618;46481.30278045832;1107.5182295701395;1163.4996951310848;1195.742915273203;1197.8622458417394;1206.776746301937;24398;24666.50666986686;25241.99032038698;25260.49479010446;25309.240722778348;32927.67072329246;33185.83407083046;36646;37244.44133337948;37332.06669833167;241026;243170;244376;245431;245536;27351.179464616092;27712.72287277182;27724.722752772213;27765.58351624687;27777;35364.29271414609;35986.10034749152;36048;36498.635013650586;37029.259414811015;31057.844710777204;37199.62800371962;38833.805830971796;39208.471237588754;39449;33881.3223735519;34478.48282275818;34677.653223467445;34831;35058.82470587631;34418.82790586031;34704.479432809036;37915.62084379231;38909;38968.220635586564;29724.405511890072;31084.22289442782;31606;31629.73481060824;31634.525482117326;23330.291789815903;23550.646740299253;23675.52648947046;23750.406239844142;24061.157859474835 12:28:19 INFO - 2015-12-03 12:28:19,593 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.27729687928763;336.8955623756634;337.08145304046474;339.63319614816004;340.6763574604126;12500.312482813442;12844.293563853984;14981.250937453126;15293.770593441093;16881.746773798386;12097.75804483912;14083.436662533511;14213.92893035536;14411.711765764705;14424.423023079064;4514.390557274775;4868.853934381974;4998.375203099613;4998.700077995314;5776.797812076578;3634.5093412389388;3788.583255841855;5479.205515200293;5679.914801277963;5694.174344720013;5537.280153580049;5597;5610.102383618621;5633.126865335879;5640.407757185498;5447.073997420448;5559.360673522557;5599.692016939067;5607.57943154263;5611.382747897728;4945.752712364403;4957.454679985199;4986.351774269358;5080.974595127038;5141.691498510064;11475.655730328104;11513.712157196054;13836.930815345959;17148.742768858476;17493;1764.6206065695937;1854.45293638377;1867.2251015828551;1902.6860568006261;1917.8273955343946;8828.382013259074;8973.596188171548;9073.22877555402;9171.44971301724;9225.077492250788;1634.182908545727;1738.7391891216291;1741.9479496440363;1744.6772347115825;1745.7032304508264;53874;56700.43299566993;56841;57156.71421642907;57473.999999999585;9458.90541094594;9733.951330243304;9736.221102311798;9812.705618831304;9828.754281142885;12385.442655080544;12515.749685006249;12525.498980040878;12541;12552.497900084078;6819.420349270268;6838.418734407631;6869.381755641916;6894.13823272091;6899.827504312432;6470.611763294218;6509.967450162813;6518.674066296666;6568.934310656928;6599.439047681001;4061.2080644274674;4087.8364865405647;4120.361343991686;4152.563980781974;4160.396742472324;1591.355501022088;1663.9001659900446;1673.1383337581156;1721.5093698295925;1724.5171352021455;803.188779332878;854.3080105114877;865.2040123086775;888.9822203555892;980.8724865767405;15064.397424103132;15674.373025079098;15902.60243493922;16001.27994240262;16223.351065957466;730.2989130434736;821.4865708931918;890.3589415620743;911.3119594705954;914.9935071421517;8770.210681038738;8816.426932249384;9306.395084319498;9381.390209636489;9399.765005874771;460134;469310;472981;478395;478436;68648.3135168652;69387.30612693809;70555;71166.64416677883;71406.64296678483;1080.2654195147375;1082.5615625671774;1125.1224045244721;1150.1718762490993;1153.037213926381;14454.132752034911;14468.85531144675;14500.709985800015;14622.634434139232;14726.63183420423;32651.510227346134;32794.50808237926;33568.328633427685;34000.48999264964;34093.488597670555;39358.409623856234;40907.38638920478;42002.369964451165;44336.55663443324;45793.313100304185;8684.43551169172;8944.86582701273;9086.772830679021;9199.862002070107;9209.539523023956;16117.435889743803;16285.755713664068;16392.508224753277;16473.505794826175;16905;13459.932700336436;13548.72902541924;13666.11170273929;13972;13989.860101399263;13414;13427;13501.189928604315;13603.659908502366;14192.858071419154;10457.9477102614;12059;13642.045056845926;13783.793243101161;14310.212938288494;8367.707130250412;8675.522846243517;8685.261752750834;8705.21653051203;8739.300855931384;9181.081891811033;9257.629694812402;12556.309402982924;13570.79643805324;13671.726565468834 12:28:19 INFO - 2015-12-03 12:28:19,593 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1230.4708975140697;1433.2403825972237;1450.7533719267724;1612.250303608822;1684.6546457976117;5930.970345148274;7087.964560177198;7284.635768211595;7313.817154571138;7337.889931651016;7224.060872086621;7386.8522629547515;7403.703851845933;7406.407487401008;7413.481056326059;1785.669651114548;1813.9365122220725;2051.897405129745;2110.229766135361;2147.087487817679;2095.9476013099643;2099.055425058722;2106.3049193766096;2106.8314534837177;2107.1992642795717;2073.087841349809;2087.780783017784;2138.7112739780086;2143.614149453098;2144.335256070623;2080.355089922114;2096.381567437602;2103.7896210378995;2113.2497963222986;2136.647453170233;2126.617208902397;2133.0721136305756;2142.924997625076;2163.318554655294;2165.2854557995825;7274.199838017814;7307.415406767446;7311.268873112699;7323.304286092813;7325.743598974063;4184.581541845821;4235.343521754133;4262.42457268271;4266.040140968257;4266.743995360288;2274.704288442492;2687.6640419947507;2734.179746076169;2761.7514423701764;2775.4449110177843;752.9887051694175;857.7469646454311;877.7586163804941;881.9118088191194;910.508325504227;9595.712128636082;9710.028997100304;9753.414795112245;9760.609575616967;9769.218462523053;3965.0880297531153;3988.940165897514;4023.5171779386073;4028.899277518027;4078.163976384834;8526.74419767408;8531.701390451304;8534.231919127309;8540.44487108336;8561.400701950928;4171.0615111600255;4189.958100418957;4190.748555086705;4192.287311157111;4205.894852628709;3833.6933045356304;3835.8465661373234;3836.5779764225913;3843.9615603843604;3846.538415390171;3490.842912068963;3499.720022398202;3519.7008254298157;3525.7708248963736;3532.964670353315;1102.60857395625;1107.1364335818075;1108.8503052088026;1113.1595645287755;1113.1818113686434;1132.4564209179475;1139.4245905817675;1147.8048731715628;1150.0741902768184;1181.5214837990457;6594.142761440982;6674.06563081169;6687.465002799764;6706.362895525015;6714.9664251679405;439.48141193391467;445.2230857154286;448.1753573424914;450.09081655056605;458.827939522679;5250.422453530108;5265.921011184835;5280.973595132;5303.681779093266;5311.814086506954;7398.11222653285;7641.465097443237;8550.144985501525;8638.568071596395;8734.91265087341;8464.153584641486;8651.221390074797;8687.869681954775;8696.130386961253;8714.825703485894;6580.539362244597;6793.762218322335;6885.242623311432;6885.51801373899;6897.206821215524;6635.402813746786;6713.697883595348;6714.194296684429;6727.562708423937;6737.427318677771;7764.145943946274;7795.22047795216;7844.64699088531;7879.212078792075;7964.800879977815;7940.325072368682;8164.632591533514;8172.6730930762105;8193.836123277382;8202.794930126794;6259.561830671809;6343.492520598434;6346.07981842621;6361.268454127835;6376.330485298977;6270;6602.8679426410245;6605.669716514251;6618.0403841443685;6635.303293154149;6399.072134540373;6464.09502669636;6464.224293084671;6620.337966203341;6697.631630260383;6483.837904052436;6497.642629655415;6514.967425162844;6604.669766511752;6641.867162656817;6488.870222595616;6493.512986525935;6497.415232629086;6530.216374035146;6533.705983230861;6054.3340232575265;6094.11635312886;6104.511639068775;6107.114468402146;6110.114033465034;5962.821115366546;6151.96924015395;6169.383061693795;6169.81490555284;6184.103305020657 12:28:19 INFO - 2015-12-03 12:28:19,596 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.8122564010314;306.4407456392085;307.12928846719547;307.9892203772868;312.4688030348407;5197.388809469063;5226.738663066846;5253.6322457428;5311.68129912205;5313.814016509423;4932.038252540756;5066;5120.615953803461;5227.581793456524;5263.710495922723;4119.382092686106;4121.649659778915;4124.422580838685;4131.235721391552;4137.27597670408;3913.2760439318677;4132.359484279941;4136.937945930814;4137.565555616662;4144.5026596808275;3956.8812935611977;3989.800509974504;4065.166640838621;4068.247374235776;4073.348264277716;4102.917941641151;4102.917941641165;4107.466029416157;4110.424540564323;4125.360569111807;3627.2564124354444;3631.4915911772373;3634.545681789776;3639.1629925117372;3645.434957581579;5073.46728593496;5090.083784918713;5090.9745451272875;5093.719845408501;5097.668651537675;4497.437820272466;4590.540945905416;4592.1045396147765;4607.562281583244;4725.456572494173;5468.507834294933;5527.419620939783;5533.584981126432;5537.197106419547;5537.556995440355;3845.115623406632;3847.8076096195077;3850.6726928211137;3854.6338097880657;3855.074782052315;5763.855903602402;5840.036393994986;5841.269841269841;5842.386549412293;5847.44449277318;3879.7866117363815;3984.7409918355215;3988.12261302513;3989.2420440116284;4003.279409706281;4033;4033.8184781684895;4040.131371755028;4043.433919251307;4046.190761847642;4635.3742244797195;4640.373549570832;4645.883852903705;4648.372469716613;4651.186042442559;5560.026995275811;5560.304961879765;5560.944390556043;5561.694106824082;5564.387917329091;1404.9719005620034;1428.3429622373617;1429.2925002123807;1430.041871945799;1479.1642721862113;993.2352088891513;1013.6958912326272;1017.765913839821;1027.753339198602;1031.2832581356035;4740.099381117577;4795.784189711471;4804.375431193923;4806.879828004258;4814.061258054716;5658.207850900877;5666.206731057655;5669.43305669438;5670.376258611549;5681.971590142023;4690.038542098861;4723.055388922161;4792.880177995578;4812.687175333592;4816.20532612115;3041.9087427377212;3081.060276615609;3082.1370016395445;3098.597182366278;3106.5495503151915;5432.076546987022;5437.102878025161;5441.401445840955;5442.619016668795;5448.37343705471;5775.5668324875805;5897.174395584621;5901.29184497863;5910.940890591039;5911.793087242012;5444.754986025639;5445.945540544544;5447.101228297287;5451.155070963928;5453.400125986138;5774.220480235114;5774.624649397776;5782;5785.971070144791;5787.594868359174;5659.094544872965;5661;5661.915071273852;5671.6597004179885;5674.2623458950075;5327.573794096541;5431.619786615057;5443.265159203457;5446.945530544644;5448.0465918463315;4108.753474791522;4109.3425051991535;4109.3425051991535;4113.053997580633;4115.8971025723395;5769;5773.566982476415;5774.162746401832;5778.422157784356;5782.566307527037;5446.645968012067;5533.170024496358;5558.471945165203;5562.582806289463;5564.415736347625;5550.333959924835;5568.721563921868;5576.749046292845;5579.051561234681;5579.860503487283;5429.864253393696;5453.618246722692;5454.372747134131;5458.6724796512335;5460.863478413072;5592.944070559405;5596.244506991667;5604.915926261191;5606.215129881902;5609.074502707008;5329.173978033411;5463.890722185454;5481.643693159932;5481.75332110048;5484.725763711878 12:28:19 INFO - 2015-12-03 12:28:19,598 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.4991805572212;744.9068866391701;745.3143108340327;746.0562388578447;764.9863930292364;11958.461869215884;12099.455524501396;12124.211926224789;12160.939195304034;12166.391680415976;10220.795584088333;10296.17630589553;10843.295185812916;10958.397288149168;10960.177986650993;761.8590560746266;776.2509178642608;778.9454738168331;779.0690125300268;779.2947382618739;772.5982489105662;780.5433821214597;780.7306479264673;780.8477346917354;781.1992707474827;798.0343784021342;806.2018601584418;806.8870358149863;807.4872455990459;807.56391548564;799.8200404908907;800.4876878797575;801.1867954026668;801.8155824160447;802.4864086984277;594.8066878264538;597.3578403216516;597.8654802669408;598.1327075740194;599.3856297295264;9863.852042219372;9965.80068398628;9966.501674916226;9991.950040249825;9993.500324983794;8695.521746303952;9356.719298421058;9453.054694530561;9642.614295428175;9936.602535898555;7954.9602251988945;8250;8397.202265784741;8504.107068757754;8532.957335213347;3072.6620071792086;3115.9221019474694;3125.624925008991;3130.6086739157604;3133.482975309071;34521.48217776736;36543.4518482223;38393.80803095967;38395.23209535793;39300.41049384262;9548.18840398574;9611.134997850228;9658.468784216935;9669.564869580885;9755;16711.665766684597;16876.15619219059;16888.831111688727;16889.32442702278;16910.323587056628;6009.519238461;6072.605280656743;6135.417135372222;6167.969160154171;6333.68331583419;3466.757326987087;3565.3404120237838;3570.7143428525656;3580.749347545699;3615.258871931248;2690.179495253927;2691.085031089439;2705.3101459127797;2707.3367025078983;2708.4718479896624;465.52981488695985;467.5277969251081;469.2328043648659;476.2879495154697;476.8211920529801;439.4089949018565;441.9513853476115;452.9139463501924;455.3556717245127;464.88842677757094;7010.193827709879;7071.7878463646175;7194.20863704992;7367.668454919542;7470.551766894004;573.6644063222977;579.1602176843594;593.9101748291846;597.1699337920294;609.9756009759649;3263.592050993626;3273.623533293654;3282.573265475473;3310.8841190558696;3373.8313084345687;52755;53857.730711346194;53887;53911.113111040926;54109.45890541123;39305.803470982464;39923.60076399199;46126.07747845024;47067.293990590166;49596.50403495991;42997.78501107537;43205.35191972123;43324.566754332685;43471.56528434739;43636.56363436325;7589.354904833151;7866.7639970800965;7922.683092676229;7953.6023198840985;8037.276645101969;27850.303742406602;31418.21454463657;32328.191795204366;34326;34394.48408273828;41948;42435.787821060694;42511;42807;42844;9794.314397992071;9945;10067.798644027225;10080.092791648787;10143.391396516232;11527.308361498337;11592;11740.119491038036;11793.174477786815;11845.703857403634;10187.439690817077;10315.071643552117;10444.268901176845;10468.743750749958;10809.891901080888;10139.594416223268;10324.328918620266;10503.894961050597;11042;11415.143864210051;10467.685969420929;10570.365778053341;10771.13830893511;10782.460876956278;11077.778444431227;9056.550951847672;9110.353719603183;9128.771780705536;9351.39215950961;9530.85703714431;9061.501617411106;9091.409058411182;9356;9398.20115290208;9498.14516693501 12:28:19 INFO - 2015-12-03 12:28:19,598 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:28:19 INFO - 2015-12-03 12:28:19,598 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:28:19 INFO - 2015-12-03 12:28:19,598 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 12:28:19 INFO - 2015-12-03 12:28:19,598 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:28:19 INFO - 2015-12-03 12:28:19,598 DEBUG : BROWSER_OUTPUT: __startTimestamp1449174499584__endTimestamp 12:28:19 INFO - 2015-12-03 12:28:19,598 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4630.85 Median:4748.53 stddev:480.41 (10.1%) stddev-sans-first:455.12 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: Values: 2615.3 2696.1 2699.8 2706.5 2722.6 4503.9 4630.5 4695.5 4713.4 4734.4 4575.6 4591.0 4598.7 4646.7 4659.4 4359.4 4360.8 4374.7 4390.8 4410.6 4203.7 4410.8 4419.9 4477.9 4498.1 4193.4 4260.5 4274.6 4293.0 4310.9 4333.3 4335.9 4341.1 4357.2 4392.9 4167.1 4278.3 4320.1 4350.8 4393.3 4506.5 4651.4 4729.7 4748.5 4784.0 4978.7 4988.7 5002.6 5008.8 5054.5 4846.3 4967.8 5032.4 5063.5 5072.3 4613.2 4661.0 4717.3 4734.1 4783.3 5210.0 5229.6 5233.8 5241.4 5280.3 4750.2 4863.8 5004.1 5023.7 5025.0 4981.0 5006.3 5051.5 5055.2 5075.6 4969.4 4991.0 4993.2 4998.0 5042.2 4761.5 4871.7 4958.8 4964.1 5022.5 4122.2 4148.8 4176.7 4200.0 4207.8 3671.4 3715.9 3721.9 3723.6 3759.3 4174.4 4341.5 4360.1 4363.2 4407.1 4885.6 4942.7 4945.1 4989.9 5001.9 4278.2 4298.3 4337.3 4337.6 4365.5 4233.8 4471.3 4486.6 4489.7 4513.8 4680.5 4739.8 4752.0 4765.9 4798.0 4973.5 5058.2 5070.2 5074.4 5101.6 4634.4 4786.2 4801.3 4802.7 4842.2 4886.9 4919.4 4926.1 4942.1 5007.6 5081.1 5102.3 5112.4 5122.5 5160.3 4725.2 4943.2 4951.8 4955.1 4965.6 4778.2 4806.1 4810.1 4862.8 4878.3 4731.2 4764.4 4771.5 4775.9 4826.2 4779.4 4885.1 4901.4 4905.0 4949.1 4621.4 4657.3 4712.5 4725.5 4748.5 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39709.98 Median:17419.93 stddev:61395.30 (352.4%) stddev-sans-first:61497.15 12:28:19 INFO - 2015-12-03 12:28:19,599 DEBUG : BROWSER_OUTPUT: Values: 558.9 569.7 570.7 571.8 575.5 25959.5 26242.3 26303.9 26325.2 35705.5 39413.8 39967.6 40023.0 40024.0 40026.0 7875.1 8048.6 8051.3 8051.7 8052.8 7198.0 7373.8 7375.4 7847.4 10190.6 10156.4 10260.8 10277.9 10289.6 10299.8 10121.7 10165.6 10219.6 10222.3 10233.7 7195.1 7383.3 10220.9 10484.9 10497.8 36974.8 37404.3 37405.3 37434.3 37449.4 2914.2 2929.5 3084.0 3423.4 3479.1 28057.9 28271.7 28273.7 28349.6 28366.7 3205.3 3225.2 3306.1 3332.1 3343.8 208814.0 209956.0 211417.0 211445.0 212728.9 45165.8 47708.3 53505.7 53820.2 53829.0 57943.4 60279.7 60395.4 60464.4 60522.1 13089.7 13309.8 13310.7 13311.3 13330.1 9669.0 9672.5 9701.1 9709.1 9718.0 18295.5 18940.9 19121.9 19276.6 19280.6 7310.7 7584.6 7617.5 7625.9 7703.9 887.9 901.3 967.0 1010.0 1033.4 25279.5 26600.6 26722.3 26803.2 27012.2 970.8 972.5 977.0 1050.6 1099.0 14015.2 14073.9 14081.7 14209.3 14288.8 247275.0 252749.0 252777.0 253332.0 253473.0 38574.4 45971.0 46471.5 46480.8 46481.3 1107.5 1163.5 1195.7 1197.9 1206.8 24398.0 24666.5 25242.0 25260.5 25309.2 32927.7 33185.8 36646.0 37244.4 37332.1 241026.0 243170.0 244376.0 245431.0 245536.0 27351.2 27712.7 27724.7 27765.6 27777.0 35364.3 35986.1 36048.0 36498.6 37029.3 31057.8 37199.6 38833.8 39208.5 39449.0 33881.3 34478.5 34677.7 34831.0 35058.8 34418.8 34704.5 37915.6 38909.0 38968.2 29724.4 31084.2 31606.0 31629.7 31634.5 23330.3 23550.6 23675.5 23750.4 24061.2 12:28:19 INFO - 2015-12-03 12:28:19,600 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,600 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25715.40 Median:4156.48 stddev:77095.64 (1854.8%) stddev-sans-first:77288.35 12:28:19 INFO - 2015-12-03 12:28:19,601 DEBUG : BROWSER_OUTPUT: Values: 332.3 336.9 337.1 339.6 340.7 12500.3 12844.3 14981.3 15293.8 16881.7 12097.8 14083.4 14213.9 14411.7 14424.4 4514.4 4868.9 4998.4 4998.7 5776.8 3634.5 3788.6 5479.2 5679.9 5694.2 5537.3 5597.0 5610.1 5633.1 5640.4 5447.1 5559.4 5599.7 5607.6 5611.4 4945.8 4957.5 4986.4 5081.0 5141.7 11475.7 11513.7 13836.9 17148.7 17493.0 1764.6 1854.5 1867.2 1902.7 1917.8 8828.4 8973.6 9073.2 9171.4 9225.1 1634.2 1738.7 1741.9 1744.7 1745.7 53874.0 56700.4 56841.0 57156.7 57474.0 9458.9 9734.0 9736.2 9812.7 9828.8 12385.4 12515.7 12525.5 12541.0 12552.5 6819.4 6838.4 6869.4 6894.1 6899.8 6470.6 6510.0 6518.7 6568.9 6599.4 4061.2 4087.8 4120.4 4152.6 4160.4 1591.4 1663.9 1673.1 1721.5 1724.5 803.2 854.3 865.2 889.0 980.9 15064.4 15674.4 15902.6 16001.3 16223.4 730.3 821.5 890.4 911.3 915.0 8770.2 8816.4 9306.4 9381.4 9399.8 460134.0 469310.0 472981.0 478395.0 478436.0 68648.3 69387.3 70555.0 71166.6 71406.6 1080.3 1082.6 1125.1 1150.2 1153.0 14454.1 14468.9 14500.7 14622.6 14726.6 32651.5 32794.5 33568.3 34000.5 34093.5 39358.4 40907.4 42002.4 44336.6 45793.3 8684.4 8944.9 9086.8 9199.9 9209.5 16117.4 16285.8 16392.5 16473.5 16905.0 13459.9 13548.7 13666.1 13972.0 13989.9 13414.0 13427.0 13501.2 13603.7 14192.9 10457.9 12059.0 13642.0 13783.8 14310.2 8367.7 8675.5 8685.3 8705.2 8739.3 9181.1 9257.6 12556.3 13570.8 13671.7 12:28:19 INFO - 2015-12-03 12:28:19,601 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,601 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5023.82 Median:6221.83 stddev:2634.24 (42.3%) stddev-sans-first:2626.19 12:28:19 INFO - 2015-12-03 12:28:19,601 DEBUG : BROWSER_OUTPUT: Values: 1230.5 1433.2 1450.8 1612.3 1684.7 5931.0 7088.0 7284.6 7313.8 7337.9 7224.1 7386.9 7403.7 7406.4 7413.5 1785.7 1813.9 2051.9 2110.2 2147.1 2095.9 2099.1 2106.3 2106.8 2107.2 2073.1 2087.8 2138.7 2143.6 2144.3 2080.4 2096.4 2103.8 2113.2 2136.6 2126.6 2133.1 2142.9 2163.3 2165.3 7274.2 7307.4 7311.3 7323.3 7325.7 4184.6 4235.3 4262.4 4266.0 4266.7 2274.7 2687.7 2734.2 2761.8 2775.4 753.0 857.7 877.8 881.9 910.5 9595.7 9710.0 9753.4 9760.6 9769.2 3965.1 3988.9 4023.5 4028.9 4078.2 8526.7 8531.7 8534.2 8540.4 8561.4 4171.1 4190.0 4190.7 4192.3 4205.9 3833.7 3835.8 3836.6 3844.0 3846.5 3490.8 3499.7 3519.7 3525.8 3533.0 1102.6 1107.1 1108.9 1113.2 1113.2 1132.5 1139.4 1147.8 1150.1 1181.5 6594.1 6674.1 6687.5 6706.4 6715.0 439.5 445.2 448.2 450.1 458.8 5250.4 5265.9 5281.0 5303.7 5311.8 7398.1 7641.5 8550.1 8638.6 8734.9 8464.2 8651.2 8687.9 8696.1 8714.8 6580.5 6793.8 6885.2 6885.5 6897.2 6635.4 6713.7 6714.2 6727.6 6737.4 7764.1 7795.2 7844.6 7879.2 7964.8 7940.3 8164.6 8172.7 8193.8 8202.8 6259.6 6343.5 6346.1 6361.3 6376.3 6270.0 6602.9 6605.7 6618.0 6635.3 6399.1 6464.1 6464.2 6620.3 6697.6 6483.8 6497.6 6515.0 6604.7 6641.9 6488.9 6493.5 6497.4 6530.2 6533.7 6054.3 6094.1 6104.5 6107.1 6110.1 5962.8 6152.0 6169.4 6169.8 6184.1 12:28:19 INFO - 2015-12-03 12:28:19,601 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,601 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4602.18 Median:5109.14 stddev:1342.01 (26.3%) stddev-sans-first:1306.40 12:28:19 INFO - 2015-12-03 12:28:19,601 DEBUG : BROWSER_OUTPUT: Values: 302.8 306.4 307.1 308.0 312.5 5197.4 5226.7 5253.6 5311.7 5313.8 4932.0 5066.0 5120.6 5227.6 5263.7 4119.4 4121.6 4124.4 4131.2 4137.3 3913.3 4132.4 4136.9 4137.6 4144.5 3956.9 3989.8 4065.2 4068.2 4073.3 4102.9 4102.9 4107.5 4110.4 4125.4 3627.3 3631.5 3634.5 3639.2 3645.4 5073.5 5090.1 5091.0 5093.7 5097.7 4497.4 4590.5 4592.1 4607.6 4725.5 5468.5 5527.4 5533.6 5537.2 5537.6 3845.1 3847.8 3850.7 3854.6 3855.1 5763.9 5840.0 5841.3 5842.4 5847.4 3879.8 3984.7 3988.1 3989.2 4003.3 4033.0 4033.8 4040.1 4043.4 4046.2 4635.4 4640.4 4645.9 4648.4 4651.2 5560.0 5560.3 5560.9 5561.7 5564.4 1405.0 1428.3 1429.3 1430.0 1479.2 993.2 1013.7 1017.8 1027.8 1031.3 4740.1 4795.8 4804.4 4806.9 4814.1 5658.2 5666.2 5669.4 5670.4 5682.0 4690.0 4723.1 4792.9 4812.7 4816.2 3041.9 3081.1 3082.1 3098.6 3106.5 5432.1 5437.1 5441.4 5442.6 5448.4 5775.6 5897.2 5901.3 5910.9 5911.8 5444.8 5445.9 5447.1 5451.2 5453.4 5774.2 5774.6 5782.0 5786.0 5787.6 5659.1 5661.0 5661.9 5671.7 5674.3 5327.6 5431.6 5443.3 5446.9 5448.0 4108.8 4109.3 4109.3 4113.1 4115.9 5769.0 5773.6 5774.2 5778.4 5782.6 5446.6 5533.2 5558.5 5562.6 5564.4 5550.3 5568.7 5576.7 5579.1 5579.9 5429.9 5453.6 5454.4 5458.7 5460.9 5592.9 5596.2 5604.9 5606.2 5609.1 5329.2 5463.9 5481.6 5481.8 5484.7 12:28:19 INFO - 2015-12-03 12:28:19,602 DEBUG : BROWSER_OUTPUT: 12:28:19 INFO - 2015-12-03 12:28:19,602 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12289.54 Median:476.55 stddev:14373.80 (3016.2%) stddev-sans-first:14387.94 12:28:19 INFO - 2015-12-03 12:28:19,603 DEBUG : BROWSER_OUTPUT: Values: 736.5 744.9 745.3 746.1 765.0 11958.5 12099.5 12124.2 12160.9 12166.4 10220.8 10296.2 10843.3 10958.4 10960.2 761.9 776.3 778.9 779.1 779.3 772.6 780.5 780.7 780.8 781.2 798.0 806.2 806.9 807.5 807.6 799.8 800.5 801.2 801.8 802.5 594.8 597.4 597.9 598.1 599.4 9863.9 9965.8 9966.5 9992.0 9993.5 8695.5 9356.7 9453.1 9642.6 9936.6 7955.0 8250.0 8397.2 8504.1 8533.0 3072.7 3115.9 3125.6 3130.6 3133.5 34521.5 36543.5 38393.8 38395.2 39300.4 9548.2 9611.1 9658.5 9669.6 9755.0 16711.7 16876.2 16888.8 16889.3 16910.3 6009.5 6072.6 6135.4 6168.0 6333.7 3466.8 3565.3 3570.7 3580.7 3615.3 2690.2 2691.1 2705.3 2707.3 2708.5 465.5 467.5 469.2 476.3 476.8 439.4 442.0 452.9 455.4 464.9 7010.2 7071.8 7194.2 7367.7 7470.6 573.7 579.2 593.9 597.2 610.0 3263.6 3273.6 3282.6 3310.9 3373.8 52755.0 53857.7 53887.0 53911.1 54109.5 39305.8 39923.6 46126.1 47067.3 49596.5 42997.8 43205.4 43324.6 43471.6 43636.6 7589.4 7866.8 7922.7 7953.6 8037.3 27850.3 31418.2 32328.2 34326.0 34394.5 41948.0 42435.8 42511.0 42807.0 42844.0 9794.3 9945.0 10067.8 10080.1 10143.4 11527.3 11592.0 11740.1 11793.2 11845.7 10187.4 10315.1 10444.3 10468.7 10809.9 10139.6 10324.3 10503.9 11042.0 11415.1 10467.7 10570.4 10771.1 10782.5 11077.8 9056.6 9110.4 9128.8 9351.4 9530.9 9061.5 9091.4 9356.0 9398.2 9498.1 12:28:19 INFO - 2015-12-03 12:28:19,603 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:28:19 INFO - 2015-12-03 12:28:19,603 DEBUG : BROWSER_OUTPUT: 12:28:20 INFO - 2015-12-03 12:28:20,361 INFO : Browser exited with error code: 0 12:28:20 INFO - 2015-12-03 12:28:20,382 INFO : Completed test dromaeo_css (00:18:37) 12:28:20 INFO - 2015-12-03 12:28:20,382 INFO : Starting test kraken 12:28:20 INFO - 2015-12-03 12:28:20,382 DEBUG : operating with platform_type : linux_ 12:28:20 INFO - 2015-12-03 12:28:20,383 INFO : Initialising browser for kraken test... 12:28:20 INFO - 2015-12-03 12:28:20,389 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIa9nnz/profile http://localhost:47847/getInfo.html 12:28:24 INFO - 2015-12-03 12:28:24,635 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:28:24 INFO - 2015-12-03 12:28:24,635 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:28:24 INFO - 2015-12-03 12:28:24,635 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:28:24 INFO - 2015-12-03 12:28:24,635 DEBUG : BROWSER_OUTPUT: __metrics 12:28:24 INFO - 2015-12-03 12:28:24,716 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] 12:28:24 INFO - 2015-12-03 12:28:24,776 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:28:25 INFO - 2015-12-03 12:28:25,908 INFO : Browser initialized. 12:28:25 INFO - 2015-12-03 12:28:25,909 INFO : Running cycle 1/1 for kraken test... 12:28:25 INFO - 2015-12-03 12:28:25,909 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIa9nnz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:28:37 INFO - 2015-12-03 12:28:37,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 143372288 12:28:37 INFO - 2015-12-03 12:28:37,862 DEBUG : BROWSER_OUTPUT: 12:28:40 INFO - 2015-12-03 12:28:40,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47847/tests/kraken/driver.html?testName=audio-beat-detection) 12:28:41 INFO - 2015-12-03 12:28:41,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 182362112 12:28:41 INFO - 2015-12-03 12:28:41,067 DEBUG : BROWSER_OUTPUT: 12:28:43 INFO - 2015-12-03 12:28:43,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47847/tests/kraken/driver.html?testName=audio-dft) 12:28:44 INFO - 2015-12-03 12:28:44,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 170790912 12:28:44 INFO - 2015-12-03 12:28:44,381 DEBUG : BROWSER_OUTPUT: 12:28:47 INFO - 2015-12-03 12:28:47,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47847/tests/kraken/driver.html?testName=audio-fft) 12:28:47 INFO - 2015-12-03 12:28:47,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 154009600 12:28:47 INFO - 2015-12-03 12:28:47,980 DEBUG : BROWSER_OUTPUT: 12:28:49 INFO - 2015-12-03 12:28:49,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47847/tests/kraken/driver.html?testName=audio-oscillator) 12:28:50 INFO - 2015-12-03 12:28:50,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 155963392 12:28:50 INFO - 2015-12-03 12:28:50,571 DEBUG : BROWSER_OUTPUT: 12:28:52 INFO - 2015-12-03 12:28:52,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:28:53 INFO - 2015-12-03 12:28:53,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 158330880 12:28:53 INFO - 2015-12-03 12:28:53,394 DEBUG : BROWSER_OUTPUT: 12:28:56 INFO - 2015-12-03 12:28:56,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47847/tests/kraken/driver.html?testName=imaging-darkroom) 12:28:56 INFO - 2015-12-03 12:28:56,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 157736960 12:28:56 INFO - 2015-12-03 12:28:56,925 DEBUG : BROWSER_OUTPUT: 12:29:00 INFO - 2015-12-03 12:29:00,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47847/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:00 INFO - 2015-12-03 12:29:00,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 158695424 12:29:00 INFO - 2015-12-03 12:29:00,932 DEBUG : BROWSER_OUTPUT: 12:29:03 INFO - 2015-12-03 12:29:03,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47847/tests/kraken/driver.html?testName=json-parse-financial) 12:29:04 INFO - 2015-12-03 12:29:04,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 157982720 12:29:04 INFO - 2015-12-03 12:29:04,373 DEBUG : BROWSER_OUTPUT: 12:29:06 INFO - 2015-12-03 12:29:06,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:06 INFO - 2015-12-03 12:29:06,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 166277120 12:29:06 INFO - 2015-12-03 12:29:06,717 DEBUG : BROWSER_OUTPUT: 12:29:08 INFO - 2015-12-03 12:29:08,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:09 INFO - 2015-12-03 12:29:09,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 166838272 12:29:09 INFO - 2015-12-03 12:29:09,197 DEBUG : BROWSER_OUTPUT: 12:29:11 INFO - 2015-12-03 12:29:11,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:11 INFO - 2015-12-03 12:29:11,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 178921472 12:29:11 INFO - 2015-12-03 12:29:11,915 DEBUG : BROWSER_OUTPUT: 12:29:14 INFO - 2015-12-03 12:29:14,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:15 INFO - 2015-12-03 12:29:15,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 184856576 12:29:15 INFO - 2015-12-03 12:29:15,008 DEBUG : BROWSER_OUTPUT: 12:29:17 INFO - 2015-12-03 12:29:17,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:29:18 INFO - 2015-12-03 12:29:18,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 183599104 12:29:18 INFO - 2015-12-03 12:29:18,155 DEBUG : BROWSER_OUTPUT: 12:29:19 INFO - 2015-12-03 12:29:19,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47847/tests/kraken/driver.html?testName=ai-astar) 12:29:20 INFO - 2015-12-03 12:29:20,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 242745344 12:29:20 INFO - 2015-12-03 12:29:20,185 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,189 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:29:20 INFO - 2015-12-03 12:29:20,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:29:20 INFO - 2015-12-03 12:29:20,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:29:20 INFO - 2015-12-03 12:29:20,189 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:29:20 INFO - 2015-12-03 12:29:20,189 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;111;111;112;101;114;110;104 12:29:20 INFO - 2015-12-03 12:29:20,189 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;137;156;169;141;153;157;129;172;129 12:29:20 INFO - 2015-12-03 12:29:20,190 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;160;162;160;159;161;163;161;161 12:29:20 INFO - 2015-12-03 12:29:20,190 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;88;94;72;71;71;97;90;71 12:29:20 INFO - 2015-12-03 12:29:20,190 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;94;95;94;137;94;95;139 12:29:20 INFO - 2015-12-03 12:29:20,190 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;110 12:29:20 INFO - 2015-12-03 12:29:20,190 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;146;147;147;147;146 12:29:20 INFO - 2015-12-03 12:29:20,190 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 12:29:20 INFO - 2015-12-03 12:29:20,190 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;71;69;71;70;79;70;68 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;68;67;69;68;69;69 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;86;84;83;83;82;86;84;84 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;121;117;117;122;121;119;129;128 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;139;144;144;145;134;148;148;133;133 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;71;69;69;67;68;67;69;70 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:29:20 INFO - 2015-12-03 12:29:20,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,972 12:29:20 INFO - 2015-12-03 12:29:20,192 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:29:20 INFO - 2015-12-03 12:29:20,192 DEBUG : BROWSER_OUTPUT: __startTimestamp1449174560187__endTimestamp 12:29:20 INFO - 2015-12-03 12:29:20,192 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,199 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:29:20 INFO - 2015-12-03 12:29:20,199 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:29:20 INFO - 2015-12-03 12:29:20,199 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:4.13 (3.7%) stddev-sans-first:4.33 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 111.0 111.0 112.0 101.0 114.0 110.0 104.0 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:154.50 stddev:15.20 (9.8%) stddev-sans-first:16.07 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: Values: 153.0 137.0 156.0 169.0 141.0 153.0 157.0 129.0 172.0 129.0 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 160.0 162.0 160.0 159.0 161.0 163.0 161.0 161.0 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:80.00 stddev:10.97 (13.7%) stddev-sans-first:11.27 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 88.0 94.0 72.0 71.0 71.0 97.0 90.0 71.0 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:94.50 stddev:19.95 (21.1%) stddev-sans-first:20.69 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 94.0 95.0 94.0 137.0 94.0 95.0 139.0 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:29:20 INFO - 2015-12-03 12:29:20,200 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:2.97 (4.2%) stddev-sans-first:3.14 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 71.0 69.0 71.0 70.0 79.0 70.0 68.0 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 68.0 67.0 69.0 68.0 69.0 69.0 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.51 (1.8%) stddev-sans-first:1.48 12:29:20 INFO - 2015-12-03 12:29:20,201 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 86.0 84.0 83.0 83.0 82.0 86.0 84.0 84.0 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:121.50 stddev:4.09 (3.4%) stddev-sans-first:4.33 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 121.0 117.0 117.0 122.0 121.0 119.0 129.0 128.0 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:144.00 stddev:6.02 (4.2%) stddev-sans-first:6.25 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: Values: 137.0 139.0 144.0 144.0 145.0 134.0 148.0 148.0 133.0 133.0 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.32 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 71.0 69.0 69.0 67.0 68.0 67.0 69.0 70.0 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:29:20 INFO - 2015-12-03 12:29:20,202 DEBUG : BROWSER_OUTPUT: 12:29:21 INFO - 2015-12-03 12:29:21,081 INFO : Browser exited with error code: 0 12:29:21 INFO - 2015-12-03 12:29:21,134 INFO : Completed test kraken (00:01:00) 12:29:21 INFO - 2015-12-03 12:29:21,134 INFO : Starting test v8_7 12:29:21 INFO - 2015-12-03 12:29:21,134 DEBUG : operating with platform_type : linux_ 12:29:21 INFO - 2015-12-03 12:29:21,134 INFO : Initialising browser for v8_7 test... 12:29:21 INFO - 2015-12-03 12:29:21,140 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpex0r3E/profile http://localhost:47847/getInfo.html 12:29:25 INFO - 2015-12-03 12:29:25,277 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:29:25 INFO - 2015-12-03 12:29:25,277 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:29:25 INFO - 2015-12-03 12:29:25,277 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:29:25 INFO - 2015-12-03 12:29:25,277 DEBUG : BROWSER_OUTPUT: __metrics 12:29:25 INFO - 2015-12-03 12:29:25,419 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] 12:29:25 INFO - 2015-12-03 12:29:25,495 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:29:26 INFO - 2015-12-03 12:29:26,560 INFO : Browser initialized. 12:29:26 INFO - 2015-12-03 12:29:26,560 INFO : Running cycle 1/1 for v8_7 test... 12:29:26 INFO - 2015-12-03 12:29:26,561 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpex0r3E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:29:38 INFO - 2015-12-03 12:29:38,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 143331328 12:29:38 INFO - 2015-12-03 12:29:38,558 DEBUG : BROWSER_OUTPUT: 12:29:59 INFO - 2015-12-03 12:29:59,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47847/tests/v8_7/run.html (next: http://localhost:47847/tests/v8_7/run.html) 12:30:00 INFO - 2015-12-03 12:30:00,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 445603840 12:30:00 INFO - 2015-12-03 12:30:00,207 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,208 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:30:00 INFO - 2015-12-03 12:30:00,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:30:00 INFO - 2015-12-03 12:30:00,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:30:00 INFO - 2015-12-03 12:30:00,209 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:30:00 INFO - 2015-12-03 12:30:00,209 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0709805216243 12:30:00 INFO - 2015-12-03 12:30:00,209 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.9427296392711 12:30:00 INFO - 2015-12-03 12:30:00,210 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 12:30:00 INFO - 2015-12-03 12:30:00,210 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 12:30:00 INFO - 2015-12-03 12:30:00,210 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2010.0401606425703 12:30:00 INFO - 2015-12-03 12:30:00,210 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 12:30:00 INFO - 2015-12-03 12:30:00,211 DEBUG : BROWSER_OUTPUT: |6;Boyer;11894.117647058823 12:30:00 INFO - 2015-12-03 12:30:00,211 DEBUG : BROWSER_OUTPUT: |7;RegExp;26842.105263157893 12:30:00 INFO - 2015-12-03 12:30:00,211 DEBUG : BROWSER_OUTPUT: |8;Splay;603.5003017501509 12:30:00 INFO - 2015-12-03 12:30:00,211 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 12:30:00 INFO - 2015-12-03 12:30:00,211 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:30:00 INFO - 2015-12-03 12:30:00,212 DEBUG : BROWSER_OUTPUT: __startTimestamp1449174600207__endTimestamp 12:30:00 INFO - 2015-12-03 12:30:00,212 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,213 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:30:00 INFO - 2015-12-03 12:30:00,214 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:30:00 INFO - 2015-12-03 12:30:00,214 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,214 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,215 DEBUG : BROWSER_OUTPUT: Values: 165.1 12:30:00 INFO - 2015-12-03 12:30:00,215 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,215 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.94 Median:185.94 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,215 DEBUG : BROWSER_OUTPUT: Values: 185.9 12:30:00 INFO - 2015-12-03 12:30:00,216 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,216 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,216 DEBUG : BROWSER_OUTPUT: Values: 278.4 12:30:00 INFO - 2015-12-03 12:30:00,216 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,216 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,217 DEBUG : BROWSER_OUTPUT: Values: 5191.7 12:30:00 INFO - 2015-12-03 12:30:00,217 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,217 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2010.04 Median:2010.04 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,217 DEBUG : BROWSER_OUTPUT: Values: 2010.0 12:30:00 INFO - 2015-12-03 12:30:00,217 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,217 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,217 DEBUG : BROWSER_OUTPUT: Values: 779.4 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11894.12 Median:11894.12 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: Values: 11894.1 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26842.11 Median:26842.11 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: Values: 26842.1 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.50 Median:603.50 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: Values: 603.5 12:30:00 INFO - 2015-12-03 12:30:00,218 DEBUG : BROWSER_OUTPUT: 12:30:00 INFO - 2015-12-03 12:30:00,219 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 12:30:00 INFO - 2015-12-03 12:30:00,219 DEBUG : BROWSER_OUTPUT: Values: 4845.4 12:30:00 INFO - 2015-12-03 12:30:00,219 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:30:00 INFO - 2015-12-03 12:30:00,219 DEBUG : BROWSER_OUTPUT: 12:30:01 INFO - 2015-12-03 12:30:01,121 INFO : Browser exited with error code: 0 12:30:01 INFO - 2015-12-03 12:30:01,133 INFO : Completed test v8_7 (00:00:39) 12:30:01 INFO - 2015-12-03 12:30:01,231 INFO : Completed test suite (00:20:18) 12:30:01 INFO - 2015-12-03 12:30:01,232 DEBUG : Working with test: dromaeo_css 12:30:01 INFO - 2015-12-03 12:30:01,232 DEBUG : Generating results file: dromaeo_css 12:30:01 INFO - 2015-12-03 12:30:01,233 DEBUG : Working with test: kraken 12:30:01 INFO - 2015-12-03 12:30:01,233 DEBUG : Generating results file: kraken 12:30:01 INFO - 2015-12-03 12:30:01,233 INFO : javascript benchmark 12:30:01 INFO - 2015-12-03 12:30:01,233 DEBUG : Working with test: v8_7 12:30:01 INFO - 2015-12-03 12:30:01,234 DEBUG : Generating results file: v8_7 12:30:01 INFO - 2015-12-03 12:30:01,234 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:30:01 INFO - 2015-12-03 12:30:01,296 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:30:01 INFO - 2015-12-03 12:30:01,296 DEBUG : process_Request line: dromaeo_css 6261.15 graph.html#tests=[[72,132,35]] 12:30:01 INFO - 2015-12-03 12:30:01,297 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:30:01 INFO - 2015-12-03 12:30:01,329 DEBUG : process_Request line: kraken 1511.60 graph.html#tests=[[232,132,35]] 12:30:01 INFO - 2015-12-03 12:30:01,329 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:30:01 INFO - 2015-12-03 12:30:01,358 DEBUG : process_Request line: v8_7 19870.25 graph.html#tests=[[230,132,35]] 12:30:01 INFO - 2015-12-03 12:30:01,360 INFO : javascript benchmark 12:30:01 INFO - 2015-12-03 12:30:01,363 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2615.3200167956334, 2696.069855899715, 2699.838009719418, 2706.472237913605, 2722.646056012718, 4503.909921801562, 4630.467496237934, 4695.46002209746, 4713.434387873455, 4734.384530011098, 4575.611073058785, 4591.0, 4598.678092533516, 4646.6515011374195, 4659.440867095945, 4359.367891655708, 4360.760158191299, 4374.715643483163, 4390.824367025315, 4410.580994805488, 4203.663706903456, 4410.823567057314, 4419.911601767963, 4477.910441791162, 4498.100379924012, 4193.433886425354, 4260.510041345254, 4274.636655884223, 4293.0340673348555, 4310.935335969963, 4333.328334108187, 4335.934960975588, 4341.066670665822, 4357.237483440385, 4392.934105988413, 4167.124903770212, 4278.272693642057, 4320.11437655283, 4350.8042138103865, 4393.275109606911, 4506.459224893034, 4651.372064771246, 4729.69256998294, 4748.501407352247, 4784.0, 4978.676386034932, 4988.65079444439, 5002.624803139743, 5008.824691135793, 5054.469280725508, 4846.321514987904, 4967.751612419364, 5032.4212715537815, 5063.518965698289, 5072.315237442972, 4613.1696294666945, 4661.04448588042, 4717.292406139107, 4734.124187025412, 4783.306420568998, 5210.0, 5229.607779416559, 5233.816816411408, 5241.397239317527, 5280.339957505312, 4750.192467280571, 4863.829765958175, 5004.099262132779, 5023.673461225008, 5024.974875125674, 4981.028699403581, 5006.274090256892, 5051.520105589963, 5055.216441451581, 5075.593952483866, 4969.378827646544, 4990.950090499121, 4993.226049962262, 4997.9750101249265, 5042.168042272984, 4761.523847615211, 4871.732054737024, 4958.776855041532, 4964.05682920244, 5022.4977502249485, 4122.237386083584, 4148.79256037197, 4176.686748493875, 4199.958000420018, 4207.789610519461, 3671.3942199536777, 3715.888523344304, 3721.8697345592773, 3723.627637236309, 3759.3045286622064, 4174.3947127666315, 4341.45731783527, 4360.149770794728, 4363.2364336241035, 4407.052483715952, 4885.560299573055, 4942.728149951788, 4945.109880221523, 4989.875253118701, 5001.949980500149, 4278.2085314216965, 4298.312270036779, 4337.284348082531, 4337.587929146726, 4365.4979677337515, 4233.830646774095, 4471.306947423154, 4486.641068714495, 4489.663275254369, 4513.796879140446, 4680.508546602694, 4739.7630118493935, 4752.025834703946, 4765.880852978565, 4798.016406636701, 4973.45292017885, 5058.165402708659, 5070.188769796815, 5074.3657042869645, 5101.617378696538, 4634.351190833353, 4786.210275304536, 4801.255805350176, 4802.687825291345, 4842.225243960949, 4886.902261954812, 4919.409670839379, 4926.088673595396, 4942.135126352946, 5007.624428167975, 5081.060003899142, 5102.311187989574, 5112.437631860418, 5122.462141475092, 5160.277561141368, 4725.1967165581245, 4943.233798761198, 4951.8266860659705, 4955.058538877602, 4965.553100220997, 4778.211595086772, 4806.086843499724, 4810.134175848241, 4862.781174847069, 4878.292647566154, 4731.195696731633, 4764.3568118304975, 4771.5467030632035, 4775.880602984953, 4826.179549476527, 4779.426468823764, 4885.1206782779445, 4901.362822833009, 4904.975475122602, 4949.109160351171, 4621.353010578455, 4657.254839225843, 4712.52874712526, 4725.456572494207, 4748.525147485224], "unit": "ms", "name": "dojo.html", "value": 4601.258471990592}, {"lowerIsBetter": false, "replicates": [558.9413111623277, 569.7379205565439, 570.7260514952825, 571.7798647520704, 575.4619430832172, 25959.480810383782, 26242.34394140143, 26303.947842086316, 26325.157238993277, 35705.46441803375, 39413.802930985374, 39967.600323996754, 40023.0, 40024.0, 40026.0, 7875.133735289128, 8048.557329346883, 8051.275385215329, 8051.718189863356, 8052.838943221162, 7198.0, 7373.778786636382, 7375.373093287077, 7847.372210223169, 10190.64332748354, 10156.390616562992, 10260.846087308697, 10277.897221027806, 10289.63986260481, 10299.845502317434, 10121.696349109501, 10165.644202452879, 10219.591216351337, 10222.284440089234, 10233.692989210336, 7195.064641596611, 7383.2985866342615, 10220.948895255477, 10484.947575262151, 10497.79004419915, 36974.81512592447, 37404.25191496155, 37405.25189496222, 37434.25131497382, 37449.43825842615, 2914.2422970027733, 2929.5312749960117, 3084.013115802944, 3423.3666771647327, 3479.0954351868445, 28057.859710701316, 28271.71728282732, 28273.717262827315, 28349.57475637867, 28366.716332836615, 3205.3268813549184, 3225.225945773021, 3306.0908250231137, 3332.0836769888233, 3343.782654127474, 208814.0, 209956.0, 211417.0, 211445.0, 212728.9363553188, 45165.774171128935, 47708.284375734394, 53505.7324713374, 53820.192697109575, 53829.0, 57943.4205657938, 60279.69860150671, 60395.39604603986, 60464.395356045876, 60522.092168617506, 13089.738205235843, 13309.800352994713, 13310.733785324239, 13311.334433278298, 13330.066895317235, 9668.951655241679, 9672.468014259142, 9701.07839755222, 9709.126178643955, 9717.951410242904, 18295.54261143482, 18940.90529547371, 19121.904390477957, 19276.61446771085, 19280.61438771217, 7310.6710198040155, 7584.62076896153, 7617.5048621839405, 7625.856121581807, 7703.8844417333785, 887.8623813308948, 901.2519608724742, 967.0426277984885, 1010.0000999011073, 1033.4109557552274, 25279.494410111696, 26600.625755955192, 26722.331941701224, 26803.195904122516, 27012.189634311002, 970.8009857979098, 972.5137431284357, 976.9853452198223, 1050.5955207245113, 1098.9560417583366, 14015.229162396166, 14073.929630351988, 14081.71836563263, 14209.289535523183, 14288.785668214985, 247275.0, 252749.0, 252777.0, 253332.0, 253473.0, 38574.42138367927, 45971.0, 46471.5352846474, 46480.7675961618, 46481.30278045832, 1107.5182295701395, 1163.4996951310848, 1195.742915273203, 1197.8622458417394, 1206.776746301937, 24398.0, 24666.50666986686, 25241.99032038698, 25260.49479010446, 25309.240722778348, 32927.67072329246, 33185.83407083046, 36646.0, 37244.44133337948, 37332.06669833167, 241026.0, 243170.0, 244376.0, 245431.0, 245536.0, 27351.179464616092, 27712.72287277182, 27724.722752772213, 27765.58351624687, 27777.0, 35364.29271414609, 35986.10034749152, 36048.0, 36498.635013650586, 37029.259414811015, 31057.844710777204, 37199.62800371962, 38833.805830971796, 39208.471237588754, 39449.0, 33881.3223735519, 34478.48282275818, 34677.653223467445, 34831.0, 35058.82470587631, 34418.82790586031, 34704.479432809036, 37915.62084379231, 38909.0, 38968.220635586564, 29724.405511890072, 31084.22289442782, 31606.0, 31629.73481060824, 31634.525482117326, 23330.291789815903, 23550.646740299253, 23675.52648947046, 23750.406239844142, 24061.157859474835], "unit": "ms", "name": "ext.html", "value": 16974.28611864467}, {"lowerIsBetter": false, "replicates": [332.27729687928763, 336.8955623756634, 337.08145304046474, 339.63319614816004, 340.6763574604126, 12500.312482813442, 12844.293563853984, 14981.250937453126, 15293.770593441093, 16881.746773798386, 12097.75804483912, 14083.436662533511, 14213.92893035536, 14411.711765764705, 14424.423023079064, 4514.390557274775, 4868.853934381974, 4998.375203099613, 4998.700077995314, 5776.797812076578, 3634.5093412389388, 3788.583255841855, 5479.205515200293, 5679.914801277963, 5694.174344720013, 5537.280153580049, 5597.0, 5610.102383618621, 5633.126865335879, 5640.407757185498, 5447.073997420448, 5559.360673522557, 5599.692016939067, 5607.57943154263, 5611.382747897728, 4945.752712364403, 4957.454679985199, 4986.351774269358, 5080.974595127038, 5141.691498510064, 11475.655730328104, 11513.712157196054, 13836.930815345959, 17148.742768858476, 17493.0, 1764.6206065695937, 1854.45293638377, 1867.2251015828551, 1902.6860568006261, 1917.8273955343946, 8828.382013259074, 8973.596188171548, 9073.22877555402, 9171.44971301724, 9225.077492250788, 1634.182908545727, 1738.7391891216291, 1741.9479496440363, 1744.6772347115825, 1745.7032304508264, 53874.0, 56700.43299566993, 56841.0, 57156.71421642907, 57473.999999999585, 9458.90541094594, 9733.951330243304, 9736.221102311798, 9812.705618831304, 9828.754281142885, 12385.442655080544, 12515.749685006249, 12525.498980040878, 12541.0, 12552.497900084078, 6819.420349270268, 6838.418734407631, 6869.381755641916, 6894.13823272091, 6899.827504312432, 6470.611763294218, 6509.967450162813, 6518.674066296666, 6568.934310656928, 6599.439047681001, 4061.2080644274674, 4087.8364865405647, 4120.361343991686, 4152.563980781974, 4160.396742472324, 1591.355501022088, 1663.9001659900446, 1673.1383337581156, 1721.5093698295925, 1724.5171352021455, 803.188779332878, 854.3080105114877, 865.2040123086775, 888.9822203555892, 980.8724865767405, 15064.397424103132, 15674.373025079098, 15902.60243493922, 16001.27994240262, 16223.351065957466, 730.2989130434736, 821.4865708931918, 890.3589415620743, 911.3119594705954, 914.9935071421517, 8770.210681038738, 8816.426932249384, 9306.395084319498, 9381.390209636489, 9399.765005874771, 460134.0, 469310.0, 472981.0, 478395.0, 478436.0, 68648.3135168652, 69387.30612693809, 70555.0, 71166.64416677883, 71406.64296678483, 1080.2654195147375, 1082.5615625671774, 1125.1224045244721, 1150.1718762490993, 1153.037213926381, 14454.132752034911, 14468.85531144675, 14500.709985800015, 14622.634434139232, 14726.63183420423, 32651.510227346134, 32794.50808237926, 33568.328633427685, 34000.48999264964, 34093.488597670555, 39358.409623856234, 40907.38638920478, 42002.369964451165, 44336.55663443324, 45793.313100304185, 8684.43551169172, 8944.86582701273, 9086.772830679021, 9199.862002070107, 9209.539523023956, 16117.435889743803, 16285.755713664068, 16392.508224753277, 16473.505794826175, 16905.0, 13459.932700336436, 13548.72902541924, 13666.11170273929, 13972.0, 13989.860101399263, 13414.0, 13427.0, 13501.189928604315, 13603.659908502366, 14192.858071419154, 10457.9477102614, 12059.0, 13642.045056845926, 13783.793243101161, 14310.212938288494, 8367.707130250412, 8675.522846243517, 8685.261752750834, 8705.21653051203, 8739.300855931384, 9181.081891811033, 9257.629694812402, 12556.309402982924, 13570.79643805324, 13671.726565468834], "unit": "ms", "name": "jquery.html", "value": 8165.996529197406}, {"lowerIsBetter": false, "replicates": [1230.4708975140697, 1433.2403825972237, 1450.7533719267724, 1612.250303608822, 1684.6546457976117, 5930.970345148274, 7087.964560177198, 7284.635768211595, 7313.817154571138, 7337.889931651016, 7224.060872086621, 7386.8522629547515, 7403.703851845933, 7406.407487401008, 7413.481056326059, 1785.669651114548, 1813.9365122220725, 2051.897405129745, 2110.229766135361, 2147.087487817679, 2095.9476013099643, 2099.055425058722, 2106.3049193766096, 2106.8314534837177, 2107.1992642795717, 2073.087841349809, 2087.780783017784, 2138.7112739780086, 2143.614149453098, 2144.335256070623, 2080.355089922114, 2096.381567437602, 2103.7896210378995, 2113.2497963222986, 2136.647453170233, 2126.617208902397, 2133.0721136305756, 2142.924997625076, 2163.318554655294, 2165.2854557995825, 7274.199838017814, 7307.415406767446, 7311.268873112699, 7323.304286092813, 7325.743598974063, 4184.581541845821, 4235.343521754133, 4262.42457268271, 4266.040140968257, 4266.743995360288, 2274.704288442492, 2687.6640419947507, 2734.179746076169, 2761.7514423701764, 2775.4449110177843, 752.9887051694175, 857.7469646454311, 877.7586163804941, 881.9118088191194, 910.508325504227, 9595.712128636082, 9710.028997100304, 9753.414795112245, 9760.609575616967, 9769.218462523053, 3965.0880297531153, 3988.940165897514, 4023.5171779386073, 4028.899277518027, 4078.163976384834, 8526.74419767408, 8531.701390451304, 8534.231919127309, 8540.44487108336, 8561.400701950928, 4171.0615111600255, 4189.958100418957, 4190.748555086705, 4192.287311157111, 4205.894852628709, 3833.6933045356304, 3835.8465661373234, 3836.5779764225913, 3843.9615603843604, 3846.538415390171, 3490.842912068963, 3499.720022398202, 3519.7008254298157, 3525.7708248963736, 3532.964670353315, 1102.60857395625, 1107.1364335818075, 1108.8503052088026, 1113.1595645287755, 1113.1818113686434, 1132.4564209179475, 1139.4245905817675, 1147.8048731715628, 1150.0741902768184, 1181.5214837990457, 6594.142761440982, 6674.06563081169, 6687.465002799764, 6706.362895525015, 6714.9664251679405, 439.48141193391467, 445.2230857154286, 448.1753573424914, 450.09081655056605, 458.827939522679, 5250.422453530108, 5265.921011184835, 5280.973595132, 5303.681779093266, 5311.814086506954, 7398.11222653285, 7641.465097443237, 8550.144985501525, 8638.568071596395, 8734.91265087341, 8464.153584641486, 8651.221390074797, 8687.869681954775, 8696.130386961253, 8714.825703485894, 6580.539362244597, 6793.762218322335, 6885.242623311432, 6885.51801373899, 6897.206821215524, 6635.402813746786, 6713.697883595348, 6714.194296684429, 6727.562708423937, 6737.427318677771, 7764.145943946274, 7795.22047795216, 7844.64699088531, 7879.212078792075, 7964.800879977815, 7940.325072368682, 8164.632591533514, 8172.6730930762105, 8193.836123277382, 8202.794930126794, 6259.561830671809, 6343.492520598434, 6346.07981842621, 6361.268454127835, 6376.330485298977, 6270.0, 6602.8679426410245, 6605.669716514251, 6618.0403841443685, 6635.303293154149, 6399.072134540373, 6464.09502669636, 6464.224293084671, 6620.337966203341, 6697.631630260383, 6483.837904052436, 6497.642629655415, 6514.967425162844, 6604.669766511752, 6641.867162656817, 6488.870222595616, 6493.512986525935, 6497.415232629086, 6530.216374035146, 6533.705983230861, 6054.3340232575265, 6094.11635312886, 6104.511639068775, 6107.114468402146, 6110.114033465034, 5962.821115366546, 6151.96924015395, 6169.383061693795, 6169.81490555284, 6184.103305020657], "unit": "ms", "name": "mootools.html", "value": 4048.1490693831406}, {"lowerIsBetter": false, "replicates": [302.8122564010314, 306.4407456392085, 307.12928846719547, 307.9892203772868, 312.4688030348407, 5197.388809469063, 5226.738663066846, 5253.6322457428, 5311.68129912205, 5313.814016509423, 4932.038252540756, 5066.0, 5120.615953803461, 5227.581793456524, 5263.710495922723, 4119.382092686106, 4121.649659778915, 4124.422580838685, 4131.235721391552, 4137.27597670408, 3913.2760439318677, 4132.359484279941, 4136.937945930814, 4137.565555616662, 4144.5026596808275, 3956.8812935611977, 3989.800509974504, 4065.166640838621, 4068.247374235776, 4073.348264277716, 4102.917941641151, 4102.917941641165, 4107.466029416157, 4110.424540564323, 4125.360569111807, 3627.2564124354444, 3631.4915911772373, 3634.545681789776, 3639.1629925117372, 3645.434957581579, 5073.46728593496, 5090.083784918713, 5090.9745451272875, 5093.719845408501, 5097.668651537675, 4497.437820272466, 4590.540945905416, 4592.1045396147765, 4607.562281583244, 4725.456572494173, 5468.507834294933, 5527.419620939783, 5533.584981126432, 5537.197106419547, 5537.556995440355, 3845.115623406632, 3847.8076096195077, 3850.6726928211137, 3854.6338097880657, 3855.074782052315, 5763.855903602402, 5840.036393994986, 5841.269841269841, 5842.386549412293, 5847.44449277318, 3879.7866117363815, 3984.7409918355215, 3988.12261302513, 3989.2420440116284, 4003.279409706281, 4033.0, 4033.8184781684895, 4040.131371755028, 4043.433919251307, 4046.190761847642, 4635.3742244797195, 4640.373549570832, 4645.883852903705, 4648.372469716613, 4651.186042442559, 5560.026995275811, 5560.304961879765, 5560.944390556043, 5561.694106824082, 5564.387917329091, 1404.9719005620034, 1428.3429622373617, 1429.2925002123807, 1430.041871945799, 1479.1642721862113, 993.2352088891513, 1013.6958912326272, 1017.765913839821, 1027.753339198602, 1031.2832581356035, 4740.099381117577, 4795.784189711471, 4804.375431193923, 4806.879828004258, 4814.061258054716, 5658.207850900877, 5666.206731057655, 5669.43305669438, 5670.376258611549, 5681.971590142023, 4690.038542098861, 4723.055388922161, 4792.880177995578, 4812.687175333592, 4816.20532612115, 3041.9087427377212, 3081.060276615609, 3082.1370016395445, 3098.597182366278, 3106.5495503151915, 5432.076546987022, 5437.102878025161, 5441.401445840955, 5442.619016668795, 5448.37343705471, 5775.5668324875805, 5897.174395584621, 5901.29184497863, 5910.940890591039, 5911.793087242012, 5444.754986025639, 5445.945540544544, 5447.101228297287, 5451.155070963928, 5453.400125986138, 5774.220480235114, 5774.624649397776, 5782.0, 5785.971070144791, 5787.594868359174, 5659.094544872965, 5661.0, 5661.915071273852, 5671.6597004179885, 5674.2623458950075, 5327.573794096541, 5431.619786615057, 5443.265159203457, 5446.945530544644, 5448.0465918463315, 4108.753474791522, 4109.3425051991535, 4109.3425051991535, 4113.053997580633, 4115.8971025723395, 5769.0, 5773.566982476415, 5774.162746401832, 5778.422157784356, 5782.566307527037, 5446.645968012067, 5533.170024496358, 5558.471945165203, 5562.582806289463, 5564.415736347625, 5550.333959924835, 5568.721563921868, 5576.749046292845, 5579.051561234681, 5579.860503487283, 5429.864253393696, 5453.618246722692, 5454.372747134131, 5458.6724796512335, 5460.863478413072, 5592.944070559405, 5596.244506991667, 5604.915926261191, 5606.215129881902, 5609.074502707008, 5329.173978033411, 5463.890722185454, 5481.643693159932, 5481.75332110048, 5484.725763711878], "unit": "ms", "name": "prototype.html", "value": 4176.082737211291}, {"lowerIsBetter": false, "replicates": [736.4991805572212, 744.9068866391701, 745.3143108340327, 746.0562388578447, 764.9863930292364, 11958.461869215884, 12099.455524501396, 12124.211926224789, 12160.939195304034, 12166.391680415976, 10220.795584088333, 10296.17630589553, 10843.295185812916, 10958.397288149168, 10960.177986650993, 761.8590560746266, 776.2509178642608, 778.9454738168331, 779.0690125300268, 779.2947382618739, 772.5982489105662, 780.5433821214597, 780.7306479264673, 780.8477346917354, 781.1992707474827, 798.0343784021342, 806.2018601584418, 806.8870358149863, 807.4872455990459, 807.56391548564, 799.8200404908907, 800.4876878797575, 801.1867954026668, 801.8155824160447, 802.4864086984277, 594.8066878264538, 597.3578403216516, 597.8654802669408, 598.1327075740194, 599.3856297295264, 9863.852042219372, 9965.80068398628, 9966.501674916226, 9991.950040249825, 9993.500324983794, 8695.521746303952, 9356.719298421058, 9453.054694530561, 9642.614295428175, 9936.602535898555, 7954.9602251988945, 8250.0, 8397.202265784741, 8504.107068757754, 8532.957335213347, 3072.6620071792086, 3115.9221019474694, 3125.624925008991, 3130.6086739157604, 3133.482975309071, 34521.48217776736, 36543.4518482223, 38393.80803095967, 38395.23209535793, 39300.41049384262, 9548.18840398574, 9611.134997850228, 9658.468784216935, 9669.564869580885, 9755.0, 16711.665766684597, 16876.15619219059, 16888.831111688727, 16889.32442702278, 16910.323587056628, 6009.519238461, 6072.605280656743, 6135.417135372222, 6167.969160154171, 6333.68331583419, 3466.757326987087, 3565.3404120237838, 3570.7143428525656, 3580.749347545699, 3615.258871931248, 2690.179495253927, 2691.085031089439, 2705.3101459127797, 2707.3367025078983, 2708.4718479896624, 465.52981488695985, 467.5277969251081, 469.2328043648659, 476.2879495154697, 476.8211920529801, 439.4089949018565, 441.9513853476115, 452.9139463501924, 455.3556717245127, 464.88842677757094, 7010.193827709879, 7071.7878463646175, 7194.20863704992, 7367.668454919542, 7470.551766894004, 573.6644063222977, 579.1602176843594, 593.9101748291846, 597.1699337920294, 609.9756009759649, 3263.592050993626, 3273.623533293654, 3282.573265475473, 3310.8841190558696, 3373.8313084345687, 52755.0, 53857.730711346194, 53887.0, 53911.113111040926, 54109.45890541123, 39305.803470982464, 39923.60076399199, 46126.07747845024, 47067.293990590166, 49596.50403495991, 42997.78501107537, 43205.35191972123, 43324.566754332685, 43471.56528434739, 43636.56363436325, 7589.354904833151, 7866.7639970800965, 7922.683092676229, 7953.6023198840985, 8037.276645101969, 27850.303742406602, 31418.21454463657, 32328.191795204366, 34326.0, 34394.48408273828, 41948.0, 42435.787821060694, 42511.0, 42807.0, 42844.0, 9794.314397992071, 9945.0, 10067.798644027225, 10080.092791648787, 10143.391396516232, 11527.308361498337, 11592.0, 11740.119491038036, 11793.174477786815, 11845.703857403634, 10187.439690817077, 10315.071643552117, 10444.268901176845, 10468.743750749958, 10809.891901080888, 10139.594416223268, 10324.328918620266, 10503.894961050597, 11042.0, 11415.143864210051, 10467.685969420929, 10570.365778053341, 10771.13830893511, 10782.460876956278, 11077.778444431227, 9056.550951847672, 9110.353719603183, 9128.771780705536, 9351.39215950961, 9530.85703714431, 9061.501617411106, 9091.409058411182, 9356.0, 9398.20115290208, 9498.14516693501], "unit": "ms", "name": "yui.html", "value": 5586.968345781088}], "name": "dromaeo_css", "value": 6261.15111254036}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 111.0, 111.0, 112.0, 101.0, 114.0, 110.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [153.0, 137.0, 156.0, 169.0, 141.0, 153.0, 157.0, 129.0, 172.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 162.0, 160.0, 159.0, 161.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 88.0, 94.0, 72.0, 71.0, 71.0, 97.0, 90.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 94.0, 95.0, 94.0, 137.0, 94.0, 95.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 71.0, 69.0, 71.0, 70.0, 79.0, 70.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 86.0, 84.0, 83.0, 83.0, 82.0, 86.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 121.0, 117.0, 117.0, 122.0, 121.0, 119.0, 129.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 144.0, 144.0, 145.0, 134.0, 148.0, 148.0, 133.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 71.0, 69.0, 69.0, 67.0, 68.0, 67.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1511.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "Richards", "value": 213.85951599999999}, {"lowerIsBetter": false, "replicates": [185.9427296392711], "unit": "score", "name": "DeltaBlue", "value": 355.5826040000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [2010.0401606425703], "unit": "score", "name": "RayTrace", "value": 368.1463756243757}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [11894.117647058823], "unit": "score", "name": "Boyer", "value": 56.0329920870425}, {"lowerIsBetter": false, "replicates": [26842.105263157893], "unit": "score", "name": "RegExp", "value": 33.93865686274513}, {"lowerIsBetter": false, "replicates": [603.5003017501509], "unit": "score", "name": "Splay", "value": 135.030587}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19870.248731828808}]} 12:30:01 INFO - RETURN: dromaeo_css: 6261.15 12:30:01 INFO - RETURN: kraken: 1511.60 12:30:01 INFO - RETURN: v8_7: 19870.25 12:30:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19870.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1511.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6261.15"}}} 12:30:01 INFO - Return code: 0 12:30:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:30:01 INFO - # TBPL SUCCESS # 12:30:01 INFO - Running post-action listener: _resource_record_post_action 12:30:01 INFO - Running post-run listener: _resource_record_post_run 12:30:02 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505769984; Read time: 8; Write time: 466360 12:30:02 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231673856; Read time: 0; Write time: 323256 12:30:02 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274096128; Read time: 8; Write time: 143104 12:30:02 INFO - Running post-run listener: _upload_blobber_files 12:30:02 INFO - Blob upload gear active. 12:30:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:30:02 INFO - Copying logs to upload dir... 12:30:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1287.934364 ========= master_lag: 1.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-12-03 12:30:03.494109) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:30:03.498730) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009015 build_url: 'https://queue.taskcluster.net/v1/task/jmK2pB4wTLmuMY0oRCziFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 12:30:03.522703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:30:03.523019) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449171060.58296-437352396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 12:30:03.572167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 12:30:03.572480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 12:30:03.572783) ========= ========= Total master_lag: 1.25 =========