builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0180 starttime: 1468440016.19 results: success (0) buildid: 20160713120543 builduid: 229418782baf436c95a2bc65ed60fd80 revision: 3e3b1eb03a908d02dac0bcb25c93eb8b734b5124 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.192417) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.192958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.193307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.217847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.218264) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-13 13:00:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.0M=0.001s 2016-07-13 13:00:16 (11.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.383473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.623705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.624102) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020878 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:16.674904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 13:00:16.675428) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e3b1eb03a908d02dac0bcb25c93eb8b734b5124 --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 3e3b1eb03a908d02dac0bcb25c93eb8b734b5124 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-13 13:00:16,750 truncating revision to first 12 chars 2016-07-13 13:00:16,750 Setting DEBUG logging. 2016-07-13 13:00:16,751 attempt 1/10 2016-07-13 13:00:16,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e3b1eb03a90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 13:00:17,980 unpacking tar archive at: fx-team-3e3b1eb03a90/testing/mozharness/ program finished with exit code 0 elapsedTime=1.498039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 13:00:18.197061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:18.197408) ========= script_repo_revision: 3e3b1eb03a908d02dac0bcb25c93eb8b734b5124 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:18.197877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:18.198237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 13:00:18.217834) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-13 13:00:18.218277) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:00:18 INFO - MultiFileLogger online at 20160713 13:00:18 in /builds/slave/test 13:00:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:00:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:00:18 INFO - {'append_to_log': False, 13:00:18 INFO - 'base_work_dir': '/builds/slave/test', 13:00:18 INFO - 'blob_upload_branch': 'Fx-Team', 13:00:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:00:18 INFO - 'branch': 'Fx-Team', 13:00:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:00:18 INFO - 'config_files': ('talos/mac_config.py',), 13:00:18 INFO - 'default_actions': ('clobber', 13:00:18 INFO - 'read-buildbot-config', 13:00:18 INFO - 'download-and-extract', 13:00:18 INFO - 'populate-webroot', 13:00:18 INFO - 'create-virtualenv', 13:00:18 INFO - 'install', 13:00:18 INFO - 'run-tests'), 13:00:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:00:18 INFO - 'download_minidump_stackwalk': True, 13:00:18 INFO - 'download_symbols': 'ondemand', 13:00:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:00:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:00:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:00:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:00:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:00:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:00:18 INFO - 'installer_path': 'installer.exe', 13:00:18 INFO - 'log_level': 'info', 13:00:18 INFO - 'log_name': 'talos', 13:00:18 INFO - 'log_to_console': True, 13:00:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:00:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:00:18 INFO - 'opt_config_files': (), 13:00:18 INFO - 'pip_index': False, 13:00:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:00:18 INFO - 'cmd': ('bash', 13:00:18 INFO - '-c', 13:00:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:00:18 INFO - 'enabled': True, 13:00:18 INFO - 'halt_on_failure': False, 13:00:18 INFO - 'name': 'check_screen_resolution'},), 13:00:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:00:18 INFO - 'cmd': ('bash', 13:00:18 INFO - '-c', 13:00:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:00:18 INFO - 'enabled': True, 13:00:18 INFO - 'halt_on_failure': False, 13:00:18 INFO - 'name': 'check_screen_resolution'},), 13:00:18 INFO - 'run_cmd_checks_enabled': True, 13:00:18 INFO - 'sps_profile': False, 13:00:18 INFO - 'sps_profile_interval': 0, 13:00:18 INFO - 'suite': 'dromaeojs-e10s', 13:00:18 INFO - 'system_bits': '32', 13:00:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:00:18 INFO - 'title': 't-yosemite-r7-0180', 13:00:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:00:18 INFO - 'use_talos_json': True, 13:00:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:00:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:00:18 INFO - 'work_dir': 'build'} 13:00:18 INFO - ##### 13:00:18 INFO - ##### Running clobber step. 13:00:18 INFO - ##### 13:00:18 INFO - Running pre-action listener: _resource_record_pre_action 13:00:18 INFO - Running main action method: clobber 13:00:18 INFO - rmtree: /builds/slave/test/build 13:00:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:00:20 INFO - Running post-action listener: _resource_record_post_action 13:00:20 INFO - ##### 13:00:20 INFO - ##### Finished clobber step (success) 13:00:20 INFO - ##### 13:00:20 INFO - ##### 13:00:20 INFO - ##### Running read-buildbot-config step. 13:00:20 INFO - ##### 13:00:20 INFO - Running pre-action listener: _resource_record_pre_action 13:00:20 INFO - Running main action method: read_buildbot_config 13:00:20 INFO - Using buildbot properties: 13:00:20 INFO - { 13:00:20 INFO - "project": "", 13:00:20 INFO - "product": "firefox", 13:00:20 INFO - "script_repo_revision": "production", 13:00:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:00:20 INFO - "repository": "", 13:00:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:00:20 INFO - "buildid": "20160713120543", 13:00:20 INFO - "pgo_build": "False", 13:00:20 INFO - "basedir": "/builds/slave/test", 13:00:20 INFO - "buildnumber": 35, 13:00:20 INFO - "slavename": "t-yosemite-r7-0180", 13:00:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:00:20 INFO - "platform": "yosemite_r7", 13:00:20 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:00:20 INFO - "branch": "fx-team", 13:00:20 INFO - "repo_path": "integration/fx-team", 13:00:20 INFO - "revision": "3e3b1eb03a908d02dac0bcb25c93eb8b734b5124", 13:00:20 INFO - "stage_platform": "macosx64", 13:00:20 INFO - "builduid": "229418782baf436c95a2bc65ed60fd80", 13:00:20 INFO - "slavebuilddir": "test" 13:00:20 INFO - } 13:00:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 13:00:20 INFO - Running post-action listener: _resource_record_post_action 13:00:20 INFO - ##### 13:00:20 INFO - ##### Finished read-buildbot-config step (success) 13:00:20 INFO - ##### 13:00:20 INFO - ##### 13:00:20 INFO - ##### Running download-and-extract step. 13:00:20 INFO - ##### 13:00:20 INFO - Running pre-action listener: _resource_record_pre_action 13:00:20 INFO - Running main action method: download_and_extract 13:00:20 INFO - mkdir: /builds/slave/test/build/tests 13:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:20 INFO - https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 13:00:21 INFO - Downloaded 1199 bytes. 13:00:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:00:21 INFO - Using the following test package requirements: 13:00:21 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:00:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 13:00:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 13:00:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'jsshell-mac.zip'], 13:00:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 13:00:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:00:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 13:00:21 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 13:00:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 13:00:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:00:21 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 13:00:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:00: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')]} 13:00:21 INFO - https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:00:22 INFO - Downloaded 18827235 bytes. 13:00:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:00:25 INFO - Return code: 0 13:00:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:25 INFO - https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:00:27 INFO - Downloaded 18827235 bytes. 13:00:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:00:30 INFO - Return code: 0 13:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:30 INFO - https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:00:31 INFO - Downloaded 14403317 bytes. 13:00:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:00:32 INFO - Return code: 0 13:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:32 INFO - https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 13:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 13:00:34 INFO - Downloaded 112758648 bytes. 13:00:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:00:34 INFO - mkdir: /builds/slave/test/properties 13:00:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:00:34 INFO - Writing to file /builds/slave/test/properties/build_url 13:00:34 INFO - Contents: 13:00:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:00:35 INFO - Running post-action listener: _resource_record_post_action 13:00:35 INFO - Running post-action listener: set_extra_try_arguments 13:00:35 INFO - ##### 13:00:35 INFO - ##### Finished download-and-extract step (success) 13:00:35 INFO - ##### 13:00:35 INFO - ##### 13:00:35 INFO - ##### Running populate-webroot step. 13:00:35 INFO - ##### 13:00:35 INFO - Running pre-action listener: _resource_record_pre_action 13:00:35 INFO - Running main action method: populate_webroot 13:00:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:00:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:00:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:00:35 INFO - '--tppagecycles', 13:00:35 INFO - '7'], 13:00:35 INFO - 'tests': ['tsvgm']}}, 13:00:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:00:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:00:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:00:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:00:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['damp', 'tps']}, 13:00:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'tests': ['damp', 'tps']}, 13:00:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['dromaeo_dom']}, 13:00:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:00:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['basic_compositor_video']}, 13:00:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:00:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['a11yr', 13:00:35 INFO - 'ts_paint', 13:00:35 INFO - 'tpaint', 13:00:35 INFO - 'sessionrestore', 13:00:35 INFO - 'sessionrestore_no_auto_restore', 13:00:35 INFO - 'tabpaint']}, 13:00:35 INFO - 'other-e10s': {'tests': ['a11yr', 13:00:35 INFO - 'ts_paint', 13:00:35 INFO - 'tpaint', 13:00:35 INFO - 'sessionrestore', 13:00:35 INFO - 'sessionrestore_no_auto_restore', 13:00:35 INFO - 'tabpaint']}, 13:00:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:00:35 INFO - 'ts_paint', 13:00:35 INFO - 'tpaint', 13:00:35 INFO - 'sessionrestore', 13:00:35 INFO - 'sessionrestore_no_auto_restore', 13:00:35 INFO - 'tabpaint']}, 13:00:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:00:35 INFO - 'ts_paint', 13:00:35 INFO - 'tpaint', 13:00:35 INFO - 'sessionrestore', 13:00:35 INFO - 'sessionrestore_no_auto_restore', 13:00:35 INFO - 'tabpaint']}, 13:00:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['a11yr', 13:00:35 INFO - 'ts_paint', 13:00:35 INFO - 'tpaint', 13:00:35 INFO - 'sessionrestore', 13:00:35 INFO - 'sessionrestore_no_auto_restore', 13:00:35 INFO - 'tabpaint']}, 13:00:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['a11yr', 13:00:35 INFO - 'ts_paint', 13:00:35 INFO - 'tpaint', 13:00:35 INFO - 'sessionrestore', 13:00:35 INFO - 'sessionrestore_no_auto_restore', 13:00:35 INFO - 'tabpaint']}, 13:00:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['tsvgx', 13:00:35 INFO - 'tsvgr_opacity', 13:00:35 INFO - 'tart', 13:00:35 INFO - 'tscrollx', 13:00:35 INFO - 'cart']}, 13:00:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:00:35 INFO - 'tsvgr_opacity', 13:00:35 INFO - 'tart', 13:00:35 INFO - 'tscrollx', 13:00:35 INFO - 'cart']}, 13:00:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'talos_options': ['--disable-e10s'], 13:00:35 INFO - 'tests': ['tp5o']}, 13:00:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'tests': ['tp5o']}, 13:00:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'talos_options': ['--disable-e10s', 13:00:35 INFO - '--xperf_path', 13:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:35 INFO - 'tests': ['tp5n']}, 13:00:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:35 INFO - 'talos_options': ['--xperf_path', 13:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:35 INFO - 'tests': ['tp5n']}}, 13:00:35 INFO - 'talos.zip': {'path': '', 13:00:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:00:35 INFO - Running post-action listener: _resource_record_post_action 13:00:35 INFO - ##### 13:00:35 INFO - ##### Finished populate-webroot step (success) 13:00:35 INFO - ##### 13:00:35 INFO - ##### 13:00:35 INFO - ##### Running create-virtualenv step. 13:00:35 INFO - ##### 13:00:35 INFO - Running pre-action listener: _resource_record_pre_action 13:00:35 INFO - Running main action method: create_virtualenv 13:00:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:00:35 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 13:00:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:00:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:00:35 INFO - Using real prefix '/tools/python27' 13:00:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:00:36 INFO - Installing distribute.............................................................................................................................................................................................done. 13:00:39 INFO - Installing pip.................done. 13:00:39 INFO - Return code: 0 13:00:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:00:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:00:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:39 INFO - 'HOME': '/Users/cltbld', 13:00:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:39 INFO - 'LOGNAME': 'cltbld', 13:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:39 INFO - 'MOZ_NO_REMOTE': '1', 13:00:39 INFO - 'NO_EM_RESTART': '1', 13:00:39 INFO - 'PAGER': '/bin/cat', 13:00:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:39 INFO - 'PWD': '/builds/slave/test', 13:00:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:39 INFO - 'SHELL': '/bin/bash', 13:00:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:00:39 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:00:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:39 INFO - 'USER': 'cltbld', 13:00:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:39 INFO - 'XPC_FLAGS': '0x0', 13:00:39 INFO - 'XPC_SERVICE_NAME': '0', 13:00:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:39 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 13:00:39 INFO - Cleaning up... 13:00:39 INFO - Return code: 0 13:00:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 13:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 13:00:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:00:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:39 INFO - 'HOME': '/Users/cltbld', 13:00:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:39 INFO - 'LOGNAME': 'cltbld', 13:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:39 INFO - 'MOZ_NO_REMOTE': '1', 13:00:39 INFO - 'NO_EM_RESTART': '1', 13:00:39 INFO - 'PAGER': '/bin/cat', 13:00:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:39 INFO - 'PWD': '/builds/slave/test', 13:00:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:39 INFO - 'SHELL': '/bin/bash', 13:00:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:00:39 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:00:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:39 INFO - 'USER': 'cltbld', 13:00:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:39 INFO - 'XPC_FLAGS': '0x0', 13:00:39 INFO - 'XPC_SERVICE_NAME': '0', 13:00:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:39 INFO - Downloading/unpacking psutil>=3.1.1 13:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:42 INFO - Installing collected packages: psutil 13:00:42 INFO - Running setup.py install for psutil 13:00:42 INFO - building 'psutil._psutil_osx' extension 13:00:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:00:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:00:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:00:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:00:43 INFO - building 'psutil._psutil_posix' extension 13:00:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:00:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:00:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:00:43 INFO - ^ 13:00:43 INFO - 1 warning generated. 13:00:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:43 INFO - Successfully installed psutil 13:00:43 INFO - Cleaning up... 13:00:43 INFO - Return code: 0 13:00:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 13:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 13:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:43 INFO - 'HOME': '/Users/cltbld', 13:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:43 INFO - 'LOGNAME': 'cltbld', 13:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:43 INFO - 'MOZ_NO_REMOTE': '1', 13:00:43 INFO - 'NO_EM_RESTART': '1', 13:00:43 INFO - 'PAGER': '/bin/cat', 13:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:43 INFO - 'PWD': '/builds/slave/test', 13:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:43 INFO - 'SHELL': '/bin/bash', 13:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:00:43 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:43 INFO - 'USER': 'cltbld', 13:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:43 INFO - 'XPC_FLAGS': '0x0', 13:00:43 INFO - 'XPC_SERVICE_NAME': '0', 13:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:00:43 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 13:00:43 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 13:00:43 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 13:00:43 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 13:00:43 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 13:00:43 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 13:00:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:00:46 INFO - Installing collected packages: mozsystemmonitor 13:00:46 INFO - Running setup.py install for mozsystemmonitor 13:00:46 INFO - Successfully installed mozsystemmonitor 13:00:46 INFO - Cleaning up... 13:00:46 INFO - Return code: 0 13:00:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 13:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 13:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:46 INFO - 'HOME': '/Users/cltbld', 13:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:46 INFO - 'LOGNAME': 'cltbld', 13:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:46 INFO - 'MOZ_NO_REMOTE': '1', 13:00:46 INFO - 'NO_EM_RESTART': '1', 13:00:46 INFO - 'PAGER': '/bin/cat', 13:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:46 INFO - 'PWD': '/builds/slave/test', 13:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:46 INFO - 'SHELL': '/bin/bash', 13:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:00:46 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:46 INFO - 'USER': 'cltbld', 13:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:46 INFO - 'XPC_FLAGS': '0x0', 13:00:46 INFO - 'XPC_SERVICE_NAME': '0', 13:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:46 INFO - Downloading/unpacking jsonschema==2.5.1 13:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:49 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:49 INFO - warning: no files found matching '*.txt' 13:00:49 INFO - no previously-included directories found matching 'build' 13:00:49 INFO - no previously-included directories found matching 'dist' 13:00:49 INFO - no previously-included directories found matching '.git*' 13:00:49 INFO - Installing collected packages: jsonschema, functools32 13:00:49 INFO - Running setup.py install for functools32 13:00:49 INFO - warning: no files found matching '*.txt' 13:00:49 INFO - no previously-included directories found matching 'build' 13:00:49 INFO - no previously-included directories found matching 'dist' 13:00:49 INFO - no previously-included directories found matching '.git*' 13:00:49 INFO - Successfully installed jsonschema functools32 13:00:49 INFO - Cleaning up... 13:00:49 INFO - Return code: 0 13:00:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:49 INFO - 'HOME': '/Users/cltbld', 13:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:49 INFO - 'LOGNAME': 'cltbld', 13:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:49 INFO - 'MOZ_NO_REMOTE': '1', 13:00:49 INFO - 'NO_EM_RESTART': '1', 13:00:49 INFO - 'PAGER': '/bin/cat', 13:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:49 INFO - 'PWD': '/builds/slave/test', 13:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:49 INFO - 'SHELL': '/bin/bash', 13:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:00:49 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:49 INFO - 'USER': 'cltbld', 13:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:49 INFO - 'XPC_FLAGS': '0x0', 13:00:49 INFO - 'XPC_SERVICE_NAME': '0', 13:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:00:50 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 13:00:50 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 13:00:50 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 13:00:50 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 13:00:50 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 13:00:50 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 13:00:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:52 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 13:00:52 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 13:00:52 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 13:00:52 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 13:00:52 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 13:00:52 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 13:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:00:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:53 INFO - Downloading docopt-0.6.1.tar.gz 13:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:53 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:53 INFO - Running setup.py install for blobuploader 13:00:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:00:54 INFO - Running setup.py install for requests 13:00:54 INFO - Running setup.py install for docopt 13:00:54 INFO - Successfully installed blobuploader requests docopt 13:00:54 INFO - Cleaning up... 13:00:54 INFO - Return code: 0 13:00:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 13:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 13:00:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:00:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:54 INFO - 'HOME': '/Users/cltbld', 13:00:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:54 INFO - 'LOGNAME': 'cltbld', 13:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:54 INFO - 'MOZ_NO_REMOTE': '1', 13:00:54 INFO - 'NO_EM_RESTART': '1', 13:00:54 INFO - 'PAGER': '/bin/cat', 13:00:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:54 INFO - 'PWD': '/builds/slave/test', 13:00:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:54 INFO - 'SHELL': '/bin/bash', 13:00:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:00:54 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:00:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:54 INFO - 'USER': 'cltbld', 13:00:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:54 INFO - 'XPC_FLAGS': '0x0', 13:00:54 INFO - 'XPC_SERVICE_NAME': '0', 13:00:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mUeyiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-4qCcRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-OuGrVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-bOniLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mO4SHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-3WBKwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-AMLhoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-iZS4eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:55 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-q5pJEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-nBJhLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-lZe2vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-616afT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-649NL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_cX0K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-J40gRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-KXl9WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:56 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ZoZs8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:56 INFO - Running setup.py install for manifestparser 13:00:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Running setup.py install for mozcrash 13:00:57 INFO - Running setup.py install for mozdebug 13:00:57 INFO - Running setup.py install for mozdevice 13:00:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for mozfile 13:00:57 INFO - Running setup.py install for mozhttpd 13:00:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for mozinfo 13:00:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for mozInstall 13:00:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for mozleak 13:00:58 INFO - Running setup.py install for mozlog 13:00:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:58 INFO - Running setup.py install for moznetwork 13:00:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:58 INFO - Running setup.py install for mozprocess 13:00:58 INFO - Running setup.py install for mozprofile 13:00:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:58 INFO - Running setup.py install for mozrunner 13:00:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:58 INFO - Running setup.py install for mozscreenshot 13:00:59 INFO - Running setup.py install for moztest 13:00:59 INFO - Running setup.py install for mozversion 13:00:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:59 INFO - Cleaning up... 13:00:59 INFO - Return code: 0 13:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:00:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:00:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:00:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:00:59 INFO - 'HOME': '/Users/cltbld', 13:00:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:00:59 INFO - 'LOGNAME': 'cltbld', 13:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:59 INFO - 'MOZ_NO_REMOTE': '1', 13:00:59 INFO - 'NO_EM_RESTART': '1', 13:00:59 INFO - 'PAGER': '/bin/cat', 13:00:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:59 INFO - 'PWD': '/builds/slave/test', 13:00:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:00:59 INFO - 'SHELL': '/bin/bash', 13:00:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:00:59 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:00:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:00:59 INFO - 'USER': 'cltbld', 13:00:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:00:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:59 INFO - 'XPC_FLAGS': '0x0', 13:00:59 INFO - 'XPC_SERVICE_NAME': '0', 13:00:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mJq0uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:59 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)) 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-5hv7tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-lqGMG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:59 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)) 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ujqRxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-8iT1Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:01:00 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-75jCp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:01:00 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-duwEyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:01:00 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-fyjqdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:01:00 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-HuFVuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:01:00 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ydl6Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-b84UT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:01:00 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-jasFBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:01:00 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-4cVYcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 13:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:01:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-lQho9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:01:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-cOuqvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:01:01 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)) 13:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:01:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-85uOPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:01:01 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)) 13:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:01:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-rJMyN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:01:01 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)) 13:01:01 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:01:01 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)) 13:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:01:01 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:01:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:03 INFO - Downloading blessings-1.6.tar.gz 13:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:01:04 INFO - Installing collected packages: blessings 13:01:04 INFO - Running setup.py install for blessings 13:01:04 INFO - Successfully installed blessings 13:01:04 INFO - Cleaning up... 13:01:04 INFO - Return code: 0 13:01:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:01:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:01:04 INFO - Reading from file tmpfile_stdout 13:01:04 INFO - Current package versions: 13:01:04 INFO - blessings == 1.6 13:01:04 INFO - blobuploader == 1.2.4 13:01:04 INFO - docopt == 0.6.1 13:01:04 INFO - functools32 == 3.2.3-2 13:01:04 INFO - jsonschema == 2.5.1 13:01:04 INFO - manifestparser == 1.1 13:01:04 INFO - mozInstall == 1.12 13:01:04 INFO - mozcrash == 0.17 13:01:04 INFO - mozdebug == 0.1 13:01:04 INFO - mozdevice == 0.48 13:01:04 INFO - mozfile == 1.2 13:01:04 INFO - mozhttpd == 0.7 13:01:04 INFO - mozinfo == 0.9 13:01:04 INFO - mozleak == 0.1 13:01:04 INFO - mozlog == 3.2 13:01:04 INFO - moznetwork == 0.27 13:01:04 INFO - mozprocess == 0.23 13:01:04 INFO - mozprofile == 0.28 13:01:04 INFO - mozrunner == 6.12 13:01:04 INFO - mozscreenshot == 0.1 13:01:04 INFO - mozsystemmonitor == 0.3 13:01:04 INFO - moztest == 0.7 13:01:04 INFO - mozversion == 1.4 13:01:04 INFO - psutil == 3.1.1 13:01:04 INFO - requests == 1.2.3 13:01:04 INFO - wsgiref == 0.1.2 13:01:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:04 INFO - 'HOME': '/Users/cltbld', 13:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:04 INFO - 'LOGNAME': 'cltbld', 13:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:04 INFO - 'MOZ_NO_REMOTE': '1', 13:01:04 INFO - 'NO_EM_RESTART': '1', 13:01:04 INFO - 'PAGER': '/bin/cat', 13:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:04 INFO - 'PWD': '/builds/slave/test', 13:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:04 INFO - 'SHELL': '/bin/bash', 13:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:01:04 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:04 INFO - 'USER': 'cltbld', 13:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:04 INFO - 'XPC_FLAGS': '0x0', 13:01:04 INFO - 'XPC_SERVICE_NAME': '0', 13:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:01:04 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 2)) 13:01:04 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 3)) 13:01:04 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 4)) 13:01:04 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 5)) 13:01:04 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 6)) 13:01:04 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 7)) 13:01:04 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 8)) 13:01:04 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 9)) 13:01:04 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:01:04 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 4)) 13:01:04 INFO - Cleaning up... 13:01:04 INFO - Return code: 0 13:01:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10e5f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e68c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff25a4a61b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:04 INFO - 'HOME': '/Users/cltbld', 13:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:04 INFO - 'LOGNAME': 'cltbld', 13:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:04 INFO - 'MOZ_NO_REMOTE': '1', 13:01:04 INFO - 'NO_EM_RESTART': '1', 13:01:04 INFO - 'PAGER': '/bin/cat', 13:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:04 INFO - 'PWD': '/builds/slave/test', 13:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:04 INFO - 'SHELL': '/bin/bash', 13:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:01:04 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:04 INFO - 'USER': 'cltbld', 13:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:04 INFO - 'XPC_FLAGS': '0x0', 13:01:04 INFO - 'XPC_SERVICE_NAME': '0', 13:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:01:05 INFO - Cleaning up... 13:01:05 INFO - Return code: 0 13:01:05 INFO - Running post-action listener: _resource_record_post_action 13:01:05 INFO - Running post-action listener: _start_resource_monitoring 13:01:05 INFO - Starting resource monitoring. 13:01:05 INFO - ##### 13:01:05 INFO - ##### Finished create-virtualenv step (success) 13:01:05 INFO - ##### 13:01:05 INFO - ##### 13:01:05 INFO - ##### Running install step. 13:01:05 INFO - ##### 13:01:05 INFO - Running pre-action listener: _resource_record_pre_action 13:01:05 INFO - Running main action method: install 13:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:01:05 INFO - Reading from file tmpfile_stdout 13:01:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:01:05 INFO - Reading from file tmpfile_stdout 13:01:05 INFO - Output received: 13:01:05 INFO - Usage: mozinstall [options] installer 13:01:05 INFO - Options: 13:01:05 INFO - -h, --help show this help message and exit 13:01:05 INFO - -d DEST, --destination=DEST 13:01:05 INFO - Directory to install application into. [default: 13:01:05 INFO - "/builds/slave/test"] 13:01:05 INFO - --app=APP Application being installed. [default: firefox] 13:01:05 INFO - mkdir: /builds/slave/test/build/application 13:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:01:39 INFO - Reading from file tmpfile_stdout 13:01:39 INFO - Output received: 13:01:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:01:39 INFO - Running post-action listener: _resource_record_post_action 13:01:39 INFO - ##### 13:01:39 INFO - ##### Finished install step (success) 13:01:39 INFO - ##### 13:01:39 INFO - ##### 13:01:39 INFO - ##### Running run-tests step. 13:01:39 INFO - ##### 13:01:39 INFO - Running pre-action listener: _resource_record_pre_action 13:01:39 INFO - Running main action method: run_tests 13:01:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:01:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:01:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:01:39 INFO - 2016-07-13 13:01:39.665 screenresolution[1996:10741] starting screenresolution argv=screenresolution get 13:01:39 INFO - 2016-07-13 13:01:39.668 screenresolution[1996:10741] Display 0: 1600x1200x32@60 13:01:39 INFO - 2016-07-13 13:01:39.674 screenresolution[1997:10743] starting screenresolution argv=screenresolution list 13:01:39 INFO - Available Modes on Display 0 13:01:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:01:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:01:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:01:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:01:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:01:39 INFO - Intel Iris: 13:01:39 INFO - Chipset Model: Intel Iris 13:01:39 INFO - Type: GPU 13:01:39 INFO - Bus: Built-In 13:01:39 INFO - VRAM (Dynamic, Max): 1536 MB 13:01:39 INFO - Vendor: Intel (0x8086) 13:01:39 INFO - Device ID: 0x0a2e 13:01:39 INFO - Revision ID: 0x0009 13:01:39 INFO - Displays: 13:01:39 INFO - Display: 13:01:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:01:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:01:39 INFO - Display Serial Number: 1600x1200 60 13:01:39 INFO - Main Display: Yes 13:01:39 INFO - Mirror: Off 13:01:39 INFO - Online: Yes 13:01:39 INFO - Rotation: Supported 13:01:39 INFO - Return code: 0 13:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:01:39 INFO - Python 2.7.3 13:01:39 INFO - Return code: 0 13:01:39 INFO - grabbing minidump binary from tooltool 13:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:39 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e55bd30>, '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 0x10e2c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e553b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:01:39 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:01:39 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:01:39 INFO - Calling ['/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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:01:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:01:40 INFO - Return code: 0 13:01:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:01:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:01:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:01:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:01:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:01:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:01:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render', 13:01:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:40 INFO - 'HOME': '/Users/cltbld', 13:01:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:40 INFO - 'LOGNAME': 'cltbld', 13:01:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:01:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:40 INFO - 'MOZ_NO_REMOTE': '1', 13:01:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:01:40 INFO - 'NO_EM_RESTART': '1', 13:01:40 INFO - 'PAGER': '/bin/cat', 13:01:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:40 INFO - 'PWD': '/builds/slave/test', 13:01:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:01:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:40 INFO - 'SHELL': '/bin/bash', 13:01:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners', 13:01:40 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 13:01:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:40 INFO - 'USER': 'cltbld', 13:01:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:40 INFO - 'XPC_FLAGS': '0x0', 13:01:40 INFO - 'XPC_SERVICE_NAME': '0', 13:01:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:01:40 INFO - mozversion application_buildid: 20160713120543 13:01:40 INFO - mozversion application_changeset: 3e3b1eb03a908d02dac0bcb25c93eb8b734b5124 13:01:40 INFO - mozversion application_display_name: Nightly 13:01:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:01:40 INFO - mozversion application_name: Firefox 13:01:40 INFO - mozversion application_remotingname: firefox 13:01:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:01:40 INFO - mozversion application_vendor: Mozilla 13:01:40 INFO - mozversion application_version: 50.0a1 13:01:40 INFO - mozversion platform_buildid: 20160713120543 13:01:40 INFO - mozversion platform_changeset: 3e3b1eb03a908d02dac0bcb25c93eb8b734b5124 13:01:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:01:40 INFO - mozversion platform_version: 50.0a1 13:01:40 INFO - using testdate: 1468440100 13:01:40 INFO - actual date: 1468440100 13:01:40 INFO - starting webserver on 'localhost:49396' 13:01:40 INFO - SUITE-START | Running 2 tests 13:01:40 INFO - TEST-START | dromaeo_css 13:01:40 INFO - operating with platform_type : mac_ 13:01:40 INFO - Initialising browser for dromaeo_css test... 13:01:40 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp5NqhFo/profile http://localhost:49396/getInfo.html) 13:01:43 INFO - PROCESS | 2007 | __metrics Screen width/height:1600/1200 13:01:43 INFO - PROCESS | 2007 | colorDepth:24 13:01:43 INFO - PROCESS | 2007 | Browser inner width/height: 1024/689 13:01:43 INFO - PROCESS | 2007 | __metrics 13:01:43 ERROR - PROCESS | 2007 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:01:44 INFO - TEST-INFO | 2007: exit 0 13:01:44 INFO - Browser initialized. 13:01:44 INFO - Running cycle 1/1 for dromaeo_css test... 13:01:44 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp5NqhFo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:56 INFO - PROCESS | 2010 | RSS: Main: 254124032 13:01:56 INFO - PROCESS | 2010 | 13:02:45 INFO - PROCESS | 2010 | 1468440165874 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] 13:04:58 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49396/tests/dromaeo/cssquery-ext.html) 13:04:59 INFO - PROCESS | 2010 | RSS: Main: 268488704 13:04:59 INFO - PROCESS | 2010 | 13:08:01 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-ext.html (next: http://localhost:49396/tests/dromaeo/cssquery-jquery.html) 13:08:02 INFO - PROCESS | 2010 | RSS: Main: 277073920 13:08:02 INFO - PROCESS | 2010 | 13:11:04 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49396/tests/dromaeo/cssquery-mootools.html) 13:11:04 INFO - PROCESS | 2010 | RSS: Main: 281497600 13:11:04 INFO - PROCESS | 2010 | 13:14:06 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49396/tests/dromaeo/cssquery-prototype.html) 13:14:07 INFO - PROCESS | 2010 | RSS: Main: 280453120 13:14:07 INFO - PROCESS | 2010 | 13:17:10 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49396/tests/dromaeo/cssquery-yui.html) 13:17:10 INFO - PROCESS | 2010 | RSS: Main: 284229632 13:17:10 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49396/tests/dromaeo/cssquery-yui.html (next: http://localhost:49396/tests/dromaeo/cssquery-dojo.html) 13:20:13 INFO - PROCESS | 2010 | RSS: Main: 284401664 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | __start_tp_report 13:20:13 INFO - PROCESS | 2010 | _x_x_mozilla_page_load 13:20:13 INFO - PROCESS | 2010 | _x_x_mozilla_page_load_details 13:20:13 INFO - PROCESS | 2010 | |i|pagename|runs| 13:20:13 INFO - PROCESS | 2010 | |0;dojo.html;3418.06003349079;3444.689977901988;3445.793252404856;3448.5516882805246;3468.687818096371;4946.9257961130525;5823.941760582393;5847.298324201097;5873.292024545992;5928.911066334003;5652.152177173426;5825.271841019872;5863.736131874065;5866.853328666785;5935.910961335583;5281.392639846428;5298.779545035142;5302.549283310923;5409.323834520685;5434.809781657623;5394.05604019297;5425.37608175061;5444.101723215665;5447.346318441792;5471.206675032118;4774.546418090275;5261.736913154327;5269;5317.707526086064;5339.519443250107;5367.677939323614;5370.113931201347;5373.247745315659;5382.085045542267;5409.134538473864;5242.7378631068295;5309.150535914274;5343.812966546191;5358.517733404013;5385.676859388449;5520.91718624221;5896.174535565025;5969.403059694039;5979.970100149471;5985.191999080112;6212.627242365427;6239.126522286883;6243.625382477066;6252.155958945529;6282.2147231596055;6174.5060395168275;6189.412005859436;6314.71583778731;6316;6334.588251763621;4900.926486102711;5849.912251316234;5869.647821130746;5935.258092738408;5983.880322393571;5642.6614403135945;6315.810525684236;6341.143945567382;6389.137466441971;6402.935970640234;6143.723532441051;6159.5072394209255;6167.290761562478;6235.719392627343;6247.156633854463;6244;6291.559590828598;6304.716287767062;6308.936910630927;6338.334474880164;6180.690965451709;6199.752009919643;6205.968970155121;6254.21822272216;6286.245650521967;6045.78839740607;6175.567710260329;6236.314005459396;6249.7187626556915;6276.592021518587;4980.626453016038;5026.74866256693;5043.142665746832;5047.9495205048215;5081.644284900095;4483.148201841705;4484.730916145042;4489.753063581469;4525.0497395546645;4581.473130589959;5903.498202652822;5971.253593300838;5992.43071908168;6015.0676645120075;6079.908801367983;6299.937000630027;6316.463100636405;6317.273513545909;6338.7464501420345;6342.714577844008;6041.24484439445;6053;6061.515078793686;6069.484093851984;6070.119832624245;5419.485148910847;5507.201455788888;5551.72241387929;5571.526420254243;5588.6646801192055;6499.220093588705;6550.672466376662;6570.605763654196;6581.736730530725;6582.473402127723;6308.369163083655;6311.558190926591;6326.905096423466;6335.113084168128;6335.429811316819;6308.306086330592;6388.456981156468;6474.449671777952;6490.578112422678;6584.934150658623;6206.72069756871;6227.782027629011;6235.314115447388;6284.088807123033;6286.717097730704;5112.233165025276;6197.597156185014;6300.338464461165;6326.810195694136;6353.110564520878;6100.30868792748;6169.938300617116;6176.629402235881;6185.41238582334;6223.657698826608;6210.192674952227;6219.937800621936;6224.657643829632;6242.5942313749465;6255.655938923403;6051.213342265477;6084.11780291864;6166.506679465542;6180.969095154495;6224.875502490016;6150.446459818459;6158.384161583985;6208.937910620836;6230.501559875109;6241.906371404523;6136.723847426787;6140.078988151813;6155.815325540241;6156.076588511759;6170.382961703794 13:20:13 INFO - PROCESS | 2010 | |1;ext.html;477.2673945493666;489.98040078396843;526.2395838014069;532.2070115527864;563.4281204577352;27085.864570677142;36788.81605591971;38635.227295454075;38740.225195496074;40081.19837603246;40322.99192520181;40515.39226911599;41342;41353.58646413535;41382;9214.401063930856;9352.953235233814;9459.763505912373;9487.098725621056;9527.761805954837;8255.25702686758;9545.331826772128;9579.473128977903;9686.32195746298;9727.173190278834;9630.662926797564;9662.806743865154;9672.177864881494;9678.322517423783;9683.225341972626;9584;9623;9627.759306017335;9673.709788706316;9676.080772326617;9621;9723.319367644268;9733.367331123454;9736.75658108546;9769.462679552622;38921;39005.21989560221;39012.80493597514;39090.022749431206;39208.21583568313;2797.237394126496;3318.8120783649847;3414.393641339261;3481.669241422061;3495.4582039783872;30811.537826932614;31037.068887933397;31316.686833131833;31344.686553134405;31415.057548273588;3093.334932989418;3131.24850035992;3134.388794185135;3142.4500712375243;3142.4814905540557;420520;455259.7237013794;487794;504480;505465;62835;63212.68393658094;63408.36591634117;63429.68285158637;63576.68211658912;35674.64325356765;36190;36223.27553448916;65865.67067164634;66114.33885661178;13852.515161969484;16973.236204370834;17123;17154.828451715322;17173.57066073333;12855.29295888735;12890.548830790878;12910.289934053717;13054.34728263583;13068.281244531452;20127.49681257951;20271.4932126698;20307;20319.593608127754;20365.490862728253;6729.865402692017;8218.794530136674;8287.295579875778;8336.541490218096;8353.498790072616;856.9614367353485;928.150742071011;928.475411392561;937.3672770879629;1011.6813203840767;30730.539041914388;30926.845365773475;31524.211894702818;31533.8423307882;31673;1131.3155540897803;1140.8688000879838;1146.4955419615342;1164.3537836500823;1178.7465694875643;15948.68102637964;16193.919030404773;16221.918890405708;16222.918885405497;16271.430499932445;606149;719977;722035;724603;731197;58792.412075878696;58801;59274.55440841868;59432.405675943555;59446.108308375406;1180.6635108993896;1405.4588983241322;1406.866347696967;1421.9075760075561;1423.5302350224608;28457.573136403385;30165.396692066475;30205.640746166915;30353;30679.386412272077;41703.58296416997;51638.483615163364;52085.47914520806;52323;52391.47608523866;504561;505881;511865;515704;515991;26998.595021074307;27122.72877271202;27233.685136763597;27429.31426714348;27433.039843605377;41412.96467588334;47198.29202561895;48976.0204795895;49583.504164957885;49782.00435991332;35878.820605896806;40204;40749;41343.173136537705;41440.171196576506;36130.63869361273;40209.79370618886;40716;40889.38665919954;41466;38580;38660.420093698056;38777.806110969264;39243.41134883036;39465.210695786496;33962.320753585285;34877.128071798405;34877.47683784796;35121;36049.63950360463;22933;23094.653580195976;25505.903034419563;26217.213483595522;26467.338316542242 13:20:13 INFO - PROCESS | 2010 | |2;jquery.html;373.1306056887453;375.81209395302346;382.9387298032315;384.5923321279446;397.00550121944525;19954.501137471554;21793.67309490359;22239.22162724305;22413.887930560366;22466;20302.59394812103;21346;21378.251761188363;21399.144034238612;21616.783832161673;5354.785808567653;5991.820245392645;6097.756089756426;6107.969460152693;6149.969250153766;3908.609139086097;5848.941510584882;5988.1317209004665;6175.320714721377;6185.4433101020895;6072.2713274406915;6181.289151747539;6185.35053819347;6198.411150940653;6206.441420272175;7184.245654206312;7443.404527637776;7563.7352692655495;7615.46691731579;7625.923740762577;7112.786616401516;7254.5647261164495;7298.708051677927;7399.334059934632;7431.108267007994;23060.884695576413;30049.849750751324;30257.697423025707;30874.228144296347;31014.689853101405;2412.843165194274;2418.9274321770376;2499.9750002499923;2706.282835048694;3051.908442746721;17330.74003889943;17352.305907763675;17918.283268669238;17951.461456156205;18361.7245741314;1838.4668446150733;1906.7044608085769;1931.6812725900209;1990.8705934114237;2097.7587577428485;124388;128154.71845281521;128547.35726321403;157753.2112339431;163021;21457.283417326576;22239.110435582395;22246.443838904157;22309.107635694716;22437.43906402353;36300.81849590735;36307.636923630955;36371.4544281836;36445.817770911504;36728;10795.83806242907;11221.775564488664;11235.887641123647;11241.796088114848;11242.831357529643;9161;9185.35702500832;9200.125988031126;9256.305777066747;9323.25413966881;10102.747431314276;10169.745756356002;10229.641962531276;10283.691489255334;10306.072453479223;1603.7834892289625;1702.9829701703072;1724.9137543122793;1747.161362545985;3379.6620337966497;916.5234078279258;964.3924327673661;983.4952522640372;988.7874107067015;1072.7371793910543;19282.614347712966;19829.900850495655;21203.787962120183;21685.783142168693;21786;794.6225542867091;887.3123329419751;949.5774380400655;970.6651205334149;987.5161171026145;10053.346532475365;10788.406637635006;11273.661790146309;11389.145814063979;11496.252743571642;565651;581495;588192;610127;610747;79772.20227797648;82725;93743.53128234314;134386;136254;914.1087439746194;980.9754756131153;1002.6791426743519;1049.9317544359592;1080.2384319055047;17571.648567028842;18303.90176589409;19820.40538783839;19982;20134.395968120978;57419;57803;57916.420835791105;59006;59158.704206478695;69778.95331570132;78409.21590784247;82676.58661706652;84206;89515.10484895328;8010.279074883289;8149.633266502903;8238.299744521782;8342.29090527312;8365.121662225622;9161.083891610786;10330;12276.815847762113;12887.904528114841;13337.133086349357;10960.08198565232;11094.278871873303;11175.273607215506;11249.718757030812;11437.542498300307;9582.856257156009;10536.683899483029;11111.277766945122;11204.83192752093;11363;11031.83452248233;11251.099912007183;11392.658220253406;11451.141164412536;11687.474063667325;8223.588820559067;8334.20825021622;8336.62485188156;8352.164783521599;8461.40770146084;7710;10216.489175541343;11160.497777599865;11260.042896353902;11527.481263343001 13:20:13 INFO - PROCESS | 2010 | |3;mootools.html;1575.4800915697822;1607.7025750236207;1835.0916296433259;1904.495308743184;1919.7600299962505;8221.794455138624;8652.394332396734;8770.517621530822;9225.584848681818;9269.629214831399;8684.523630982732;8825.940887093559;8840.60217290222;8939.910600893989;8952;2354.3643216331625;2403.387136280246;2407.723111842134;2408.8072954163626;2418.2745176447083;2392.28231530541;2394.9281521554294;2411.5297516984197;2417.9758202418016;2435.305937807725;2387.9880600597057;2395.940101497459;2405.278416475059;2408.084927727461;2411.577973854577;2371.4071482129466;2382.118616112041;2394.209910729464;2396.197273913241;2403.182917807945;2371.2530552875787;2377.465070359173;2405.8315917885757;2417.178159425786;2559.0659409315467;9081.772955676095;9124.726258212264;9137.497437640926;9147.725568232963;9157.130072643089;4687.695299805502;5372.462753724596;5436.429174936614;5504.22940788286;5516.172574113875;3581.623929487392;3668.7248456365614;3705.981470092659;3733.6826369758605;3746.400575907842;1053.4679986606714;1074.484247561175;1078.741102135482;1091.650671785029;1095.2497539185604;10948.288361256493;11070.557177712883;11962.282263064244;12096.758064838741;12207.206531575419;4777.593904518086;4793.089313030513;4893.828715994923;4972.726500042532;4981.701097934136;8434.32525397979;10102.242331825142;10491.318064325795;10493.685189444328;10510;5397.487238712394;5448.809291674773;5489.149181876815;5502.477264659851;5503.697296648643;4480.103979204172;4822.445418776815;4987.251912213124;5018.648694591417;5028.497150284942;4101.947057536663;4111.444954931046;4123.97938010308;4137.213929353413;4148.502179738451;1305.8694130586866;1312.665270356053;1332.8933685305153;1342.7717288061053;1345.6232254968625;857.6226460357423;920.8075542172902;921.1019256225127;925.9629614815332;947.4362754161263;5725.914111288334;5818.44724751148;5841.561882858802;5903.616264942851;5965.433283838029;428.8156092880029;434.1942870737984;441.52756550491307;449.4628918442495;454.2096751652102;3436.879709210216;3692.667659910567;3904.39481880309;3931.7837518936735;3939.5075615548058;10650.467476626138;11112.16658750597;11182.66452006441;11186.216964812385;11188.992990630883;10856.402897840695;10899;11072.944635276934;11132.944335278271;11165.609203677832;8290.626921788535;8395.24442800151;8402.537860417735;8473.983122025273;8539.82920341602;5801.361850196559;5815.156802263564;5821.79623713168;5830.271216097988;5918.496927761188;10166.847497287694;10230.48847557634;10292.588296468057;10317.690469285933;10344.379337239488;9742.220622350053;10310.587576496857;10320.380777153396;10397.168226541708;10452.738681532719;7626.847463050819;7655.349295309961;7845.293923546908;7851.2148785121035;7876.291133797757;8376.49741015541;8520.957395212985;8555.82888342242;8593.398462107592;8609.397342185986;7377.815554610963;7651.273129052731;7794.103678076867;7805.414593905366;7906.090799557895;7553.395728341609;7578.962105189659;7661.310482056641;7763.4953728007495;7769.106552746506;7130.821729456805;7206.351428371472;7220.566765993847;7229.566226026455;7255.927440725525;4154.979225103976;4884.731339776346;4902.3872015998;5027.120253955616;5040.218766091261;5012.924806127838;5039.319691841554;5042.520960508746;5083.949160508348;5170.37955445349 13:20:13 INFO - PROCESS | 2010 | |4;prototype.html;270.97832173426127;282.2815933449371;289.6509705804506;311.5949265954259;312.9297801518805;4629.791659375328;4908.582770464511;5004.324416203812;5573.860653483665;5614.214010038598;5422.1595652673805;5472.480114389136;5473.507384335409;5498.477644623755;5523.28197334347;4044.575319591452;4168.687348448863;4239.576042395751;4268.274393353137;4275.080857615612;3413.982930085346;3489.5114683944266;4110.6094920982605;4238.258304796648;4301.537477257732;3489.842957066938;3493.615702272748;3830.885073447787;3985.3224951758125;4211.263028969934;3500.317438099559;3900.3564411872007;4192.203481338551;4196.265653510623;4218.915621687549;3579.0336609115393;3587.8385472653795;3595.1551385424405;3615.8011309377976;3619.855205791765;4424.256960684396;5403.243545903577;5418.512333889929;5488.286522752017;5494.36814766303;4422.385829172361;4699.224627936386;4815.927761083586;4820.662553621248;4841.8063277468855;5007.7981284491825;5579.6652200867675;5807.941920580824;5833.854153646151;5888.38171991939;3409.2670075933793;3885.2229554089013;3905.2775236581324;3918.2555314490155;3921.5882332355263;5884.941150588525;6038.0715353054175;6158.6612736299485;6169.475594574466;6181.732744787308;3993.8602148924647;4005.939910901339;4006.939895901564;4010.0926828049433;4010.939835902464;3715.7956312403076;4066.552679205285;4083;4087.6116768906904;4093.672506199497;3751.7748935063983;4136.627703506639;4579.748113853703;4609.032103258353;4803.735794531264;5146.562542183881;5862.824115276549;5907.3797251288;5912.645241285537;5923.7926672566255;1324.973500529984;1356.2540602668494;1393.4008376398247;1395.864327578806;1405.6134562995053;847.0555330806106;862.4092496639822;862.4609618988133;867.8394497018072;902.2105657549644;4306.82772689089;4964.280179373971;5222.3472065991755;5471.425500322488;5497.230387745719;4511.458624964959;5294.364676238876;6045.274567051982;6083.7870674526175;6119.296280927751;4963.70217786934;5156.458571849977;5364.409914909357;5392.548768787979;5412.103285634337;3137.5607414961923;3166;3173.6826317368077;3184.601924759405;3186.952195717066;5273.44628813969;5664.8867022659315;6179.783707570304;6261.436470717657;6281.057841323838;5093.439721630618;5520.365158006881;5742.196092547047;5902;6175.2898416681755;5434.483724046209;6215;6262.5616206866;6270.717817698123;6302.936970630235;5316.734163291897;5615.2700148980375;5951.583389162717;5965.642061476326;6159.476444502267;5145.716985565829;6039.577229593886;6062.818115456544;6069.2716873975405;6075.605085669417;5960.748242868873;6051.33435322123;6071.362506936708;6335.746570137143;6405.3594640535575;4031.23406552754;4052.4731784867777;4055.371417430303;4072.5927407259037;4082.755034697928;6122.326544080237;6226.968865155645;6230.470410015199;6237.220347456568;6248.375162483715;5229.790808367623;5770.086106516183;5954.702264886825;5995.790147344822;6019.939800602113;5882.411758824083;5953.404659534012;6000;6016.47308130595;6067.423594758491;5252.527272545489;5860.589758717019;5901.29184497863;5901.557383196363;5916.792912248051;5676.864627074684;5966.850828729316;5975.671338076274;6021.578489505692;6033.306169790355;5053.372246431762;5318.8936221276135;5535.225068490495;5824.854378640398;5838.532917366516 13:20:13 INFO - PROCESS | 2010 | |5;yui.html;725.1696807155806;762.3215338348868;769.4152444142453;796.2356138107417;851.9606080581689;15443.15062671554;15943;16133.43532976346;16143.11212883294;16190.352385904564;14719.779203311959;14773.926130369333;14805.55583332499;14855.777163342558;14901.850981490183;699.464909344352;871.4684042733943;871.5293741379647;895.8835351404308;906.5784410249232;869.821686554258;873.9038705742363;889.9733008009738;898.3127907151035;901.5086777706133;949.7910459698855;951.3198063384679;952.3857112162651;954.0697819625879;960.1550635440802;924.1959495239184;948.5541795356172;948.7485816258697;948.9383190092622;949.2975198353168;692.9133858267717;701.9859602807966;704.0565642039692;706.4136766483806;706.9611171385571;15377.92354535183;15383.461578844799;15444.227788610637;15459.072455652697;15512.767308490382;12165.391730413445;14852.554423367315;14887.404503819942;14956.925215373962;14957;10138.645147419806;11869.347185904771;12001.51993920242;12026.398680065962;12090.879091209063;3633.255182687543;3883.417487376888;3908.609139086097;3962.0094976255937;4076.12498250805;100009;106875;108205;111457.44271278592;113026;11382.146339024606;11433.371164586028;11476.598319058792;11478.368689721978;11588.362640054878;23975.52048959046;24012.39969000789;24016.87991560031;24018.75981240165;24057.879710601333;8061.959690201512;8156.551389673625;8337.458065225863;8436.704715335056;8472.661093556311;4593.540645935446;4605.792739326738;4647.256438969816;4650.279206722963;4771.117343291502;3554.7511674183074;3603.045193023851;3654.945175822365;3662.1760103976394;3667.688246499024;628.4187126907683;680.1973671068088;684.9315068493211;690.082190686386;696.373264062348;544.413317797554;557.31299768943;673.5520878615764;682.1200651159949;696.9756058537927;8944.955275223712;9443.480608566457;9561.330706850455;9634.855477167848;9855.605775769032;641.3202005873788;654.8853950558633;677.1501765284536;698.4307789151825;718.9676464559108;4686.461056978423;4689.437267527918;4723.763811809465;4762.499937506581;4791.784369703371;95572.52213738886;122530;138269.3086534581;148026.55920322408;160443;134509.32745336212;138396.30801845927;139412;142038.73883783503;144416.27791861183;118624;119412.41762746958;119568;119601;119863.40068299777;7334.4132469403385;8410.663573456994;8507.447015943944;8908.955455222682;9057.71577683634;63915.68042159759;65648;65666.35834103994;66496.66751666211;68616.31383686299;62122.689386552775;64275;68398.31601683919;80664.59667701623;99244.50377748066;12182.903538681561;12349.629511114681;12379.257244565355;12412.255264684149;12667.429965651383;10452.216083793897;13554;13605;13679.521216757366;14193.219372934587;12214.633560993185;12609.30648814324;13766.380512876744;14773.039752416058;15230.314635841636;14256.857431425553;14535.183102112236;14694.485693000694;14810.925945370635;15273.312700928707;12317.753644926872;13897.305134743425;14067.929660351632;14089;14786.778198326818;11478.713032174262;11761.88238117608;11774.470148843151;11808.468618911998;12072.20346432784;10650.946745266225;11437.256578322382;11779.705507362041;11867.703307417383;11998.76002479963 13:20:13 INFO - PROCESS | 2010 | __end_tp_report 13:20:13 INFO - PROCESS | 2010 | __start_cc_report 13:20:13 INFO - PROCESS | 2010 | _x_x_mozilla_cycle_collect,440 13:20:13 INFO - PROCESS | 2010 | __end_cc_report 13:20:13 INFO - PROCESS | 2010 | __startTimestamp1468441213869__endTimestamp 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | ------- Summary: start ------- 13:20:13 INFO - PROCESS | 2010 | Number of tests: 6 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | [#0] dojo.html Cycles:165 Average:5843.63 Median:6140.08 stddev:645.02 (10.5%) stddev-sans-first:618.30 13:20:13 INFO - PROCESS | 2010 | Values: 3418.1 3444.7 3445.8 3448.6 3468.7 4946.9 5823.9 5847.3 5873.3 5928.9 5652.2 5825.3 5863.7 5866.9 5935.9 5281.4 5298.8 5302.5 5409.3 5434.8 5394.1 5425.4 5444.1 5447.3 5471.2 4774.5 5261.7 5269.0 5317.7 5339.5 5367.7 5370.1 5373.2 5382.1 5409.1 5242.7 5309.2 5343.8 5358.5 5385.7 5520.9 5896.2 5969.4 5980.0 5985.2 6212.6 6239.1 6243.6 6252.2 6282.2 6174.5 6189.4 6314.7 6316.0 6334.6 4900.9 5849.9 5869.6 5935.3 5983.9 5642.7 6315.8 6341.1 6389.1 6402.9 6143.7 6159.5 6167.3 6235.7 6247.2 6244.0 6291.6 6304.7 6308.9 6338.3 6180.7 6199.8 6206.0 6254.2 6286.2 6045.8 6175.6 6236.3 6249.7 6276.6 4980.6 5026.7 5043.1 5047.9 5081.6 4483.1 4484.7 4489.8 4525.0 4581.5 5903.5 5971.3 5992.4 6015.1 6079.9 6299.9 6316.5 6317.3 6338.7 6342.7 6041.2 6053.0 6061.5 6069.5 6070.1 5419.5 5507.2 5551.7 5571.5 5588.7 6499.2 6550.7 6570.6 6581.7 6582.5 6308.4 6311.6 6326.9 6335.1 6335.4 6308.3 6388.5 6474.4 6490.6 6584.9 6206.7 6227.8 6235.3 6284.1 6286.7 5112.2 6197.6 6300.3 6326.8 6353.1 6100.3 6169.9 6176.6 6185.4 6223.7 6210.2 6219.9 6224.7 6242.6 6255.7 6051.2 6084.1 6166.5 6181.0 6224.9 6150.4 6158.4 6208.9 6230.5 6241.9 6136.7 6140.1 6155.8 6156.1 6170.4 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | [#1] ext.html Cycles:180 Average:69465.31 Median:40142.60 stddev:153009.19 (381.2%) stddev-sans-first:153350.75 13:20:13 INFO - PROCESS | 2010 | Values: 477.3 490.0 526.2 532.2 563.4 27085.9 36788.8 38635.2 38740.2 40081.2 40323.0 40515.4 41342.0 41353.6 41382.0 9214.4 9353.0 9459.8 9487.1 9527.8 8255.3 9545.3 9579.5 9686.3 9727.2 9630.7 9662.8 9672.2 9678.3 9683.2 9584.0 9623.0 9627.8 9673.7 9676.1 9621.0 9723.3 9733.4 9736.8 9769.5 38921.0 39005.2 39012.8 39090.0 39208.2 2797.2 3318.8 3414.4 3481.7 3495.5 30811.5 31037.1 31316.7 31344.7 31415.1 3093.3 3131.2 3134.4 3142.5 3142.5 420520.0 455259.7 487794.0 504480.0 505465.0 62835.0 63212.7 63408.4 63429.7 63576.7 35674.6 36190.0 36223.3 65865.7 66114.3 13852.5 16973.2 17123.0 17154.8 17173.6 12855.3 12890.5 12910.3 13054.3 13068.3 20127.5 20271.5 20307.0 20319.6 20365.5 6729.9 8218.8 8287.3 8336.5 8353.5 857.0 928.2 928.5 937.4 1011.7 30730.5 30926.8 31524.2 31533.8 31673.0 1131.3 1140.9 1146.5 1164.4 1178.7 15948.7 16193.9 16221.9 16222.9 16271.4 606149.0 719977.0 722035.0 724603.0 731197.0 58792.4 58801.0 59274.6 59432.4 59446.1 1180.7 1405.5 1406.9 1421.9 1423.5 28457.6 30165.4 30205.6 30353.0 30679.4 41703.6 51638.5 52085.5 52323.0 52391.5 504561.0 505881.0 511865.0 515704.0 515991.0 26998.6 27122.7 27233.7 27429.3 27433.0 41413.0 47198.3 48976.0 49583.5 49782.0 35878.8 40204.0 40749.0 41343.2 41440.2 36130.6 40209.8 40716.0 40889.4 41466.0 38580.0 38660.4 38777.8 39243.4 39465.2 33962.3 34877.1 34877.5 35121.0 36049.6 22933.0 23094.7 25505.9 26217.2 26467.3 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | [#2] jquery.html Cycles:180 Average:36675.51 Median:2603.13 stddev:98772.47 (3794.4%) stddev-sans-first:99011.94 13:20:13 INFO - PROCESS | 2010 | Values: 373.1 375.8 382.9 384.6 397.0 19954.5 21793.7 22239.2 22413.9 22466.0 20302.6 21346.0 21378.3 21399.1 21616.8 5354.8 5991.8 6097.8 6108.0 6150.0 3908.6 5848.9 5988.1 6175.3 6185.4 6072.3 6181.3 6185.4 6198.4 6206.4 7184.2 7443.4 7563.7 7615.5 7625.9 7112.8 7254.6 7298.7 7399.3 7431.1 23060.9 30049.8 30257.7 30874.2 31014.7 2412.8 2418.9 2500.0 2706.3 3051.9 17330.7 17352.3 17918.3 17951.5 18361.7 1838.5 1906.7 1931.7 1990.9 2097.8 124388.0 128154.7 128547.4 157753.2 163021.0 21457.3 22239.1 22246.4 22309.1 22437.4 36300.8 36307.6 36371.5 36445.8 36728.0 10795.8 11221.8 11235.9 11241.8 11242.8 9161.0 9185.4 9200.1 9256.3 9323.3 10102.7 10169.7 10229.6 10283.7 10306.1 1603.8 1703.0 1724.9 1747.2 3379.7 916.5 964.4 983.5 988.8 1072.7 19282.6 19829.9 21203.8 21685.8 21786.0 794.6 887.3 949.6 970.7 987.5 10053.3 10788.4 11273.7 11389.1 11496.3 565651.0 581495.0 588192.0 610127.0 610747.0 79772.2 82725.0 93743.5 134386.0 136254.0 914.1 981.0 1002.7 1049.9 1080.2 17571.6 18303.9 19820.4 19982.0 20134.4 57419.0 57803.0 57916.4 59006.0 59158.7 69779.0 78409.2 82676.6 84206.0 89515.1 8010.3 8149.6 8238.3 8342.3 8365.1 9161.1 10330.0 12276.8 12887.9 13337.1 10960.1 11094.3 11175.3 11249.7 11437.5 9582.9 10536.7 11111.3 11204.8 11363.0 11031.8 11251.1 11392.7 11451.1 11687.5 8223.6 8334.2 8336.6 8352.2 8461.4 7710.0 10216.5 11160.5 11260.0 11527.5 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | [#3] mootools.html Cycles:180 Average:5822.54 Median:4732.64 stddev:3295.98 (69.6%) stddev-sans-first:3289.77 13:20:13 INFO - PROCESS | 2010 | Values: 1575.5 1607.7 1835.1 1904.5 1919.8 8221.8 8652.4 8770.5 9225.6 9269.6 8684.5 8825.9 8840.6 8939.9 8952.0 2354.4 2403.4 2407.7 2408.8 2418.3 2392.3 2394.9 2411.5 2418.0 2435.3 2388.0 2395.9 2405.3 2408.1 2411.6 2371.4 2382.1 2394.2 2396.2 2403.2 2371.3 2377.5 2405.8 2417.2 2559.1 9081.8 9124.7 9137.5 9147.7 9157.1 4687.7 5372.5 5436.4 5504.2 5516.2 3581.6 3668.7 3706.0 3733.7 3746.4 1053.5 1074.5 1078.7 1091.7 1095.2 10948.3 11070.6 11962.3 12096.8 12207.2 4777.6 4793.1 4893.8 4972.7 4981.7 8434.3 10102.2 10491.3 10493.7 10510.0 5397.5 5448.8 5489.1 5502.5 5503.7 4480.1 4822.4 4987.3 5018.6 5028.5 4101.9 4111.4 4124.0 4137.2 4148.5 1305.9 1312.7 1332.9 1342.8 1345.6 857.6 920.8 921.1 926.0 947.4 5725.9 5818.4 5841.6 5903.6 5965.4 428.8 434.2 441.5 449.5 454.2 3436.9 3692.7 3904.4 3931.8 3939.5 10650.5 11112.2 11182.7 11186.2 11189.0 10856.4 10899.0 11072.9 11132.9 11165.6 8290.6 8395.2 8402.5 8474.0 8539.8 5801.4 5815.2 5821.8 5830.3 5918.5 10166.8 10230.5 10292.6 10317.7 10344.4 9742.2 10310.6 10320.4 10397.2 10452.7 7626.8 7655.3 7845.3 7851.2 7876.3 8376.5 8521.0 8555.8 8593.4 8609.4 7377.8 7651.3 7794.1 7805.4 7906.1 7553.4 7579.0 7661.3 7763.5 7769.1 7130.8 7206.4 7220.6 7229.6 7255.9 4155.0 4884.7 4902.4 5027.1 5040.2 5012.9 5039.3 5042.5 5083.9 5170.4 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | [#4] prototype.html Cycles:180 Average:4729.38 Median:5341.65 stddev:1491.66 (27.9%) stddev-sans-first:1457.82 13:20:13 INFO - PROCESS | 2010 | Values: 271.0 282.3 289.7 311.6 312.9 4629.8 4908.6 5004.3 5573.9 5614.2 5422.2 5472.5 5473.5 5498.5 5523.3 4044.6 4168.7 4239.6 4268.3 4275.1 3414.0 3489.5 4110.6 4238.3 4301.5 3489.8 3493.6 3830.9 3985.3 4211.3 3500.3 3900.4 4192.2 4196.3 4218.9 3579.0 3587.8 3595.2 3615.8 3619.9 4424.3 5403.2 5418.5 5488.3 5494.4 4422.4 4699.2 4815.9 4820.7 4841.8 5007.8 5579.7 5807.9 5833.9 5888.4 3409.3 3885.2 3905.3 3918.3 3921.6 5884.9 6038.1 6158.7 6169.5 6181.7 3993.9 4005.9 4006.9 4010.1 4010.9 3715.8 4066.6 4083.0 4087.6 4093.7 3751.8 4136.6 4579.7 4609.0 4803.7 5146.6 5862.8 5907.4 5912.6 5923.8 1325.0 1356.3 1393.4 1395.9 1405.6 847.1 862.4 862.5 867.8 902.2 4306.8 4964.3 5222.3 5471.4 5497.2 4511.5 5294.4 6045.3 6083.8 6119.3 4963.7 5156.5 5364.4 5392.5 5412.1 3137.6 3166.0 3173.7 3184.6 3187.0 5273.4 5664.9 6179.8 6261.4 6281.1 5093.4 5520.4 5742.2 5902.0 6175.3 5434.5 6215.0 6262.6 6270.7 6302.9 5316.7 5615.3 5951.6 5965.6 6159.5 5145.7 6039.6 6062.8 6069.3 6075.6 5960.7 6051.3 6071.4 6335.7 6405.4 4031.2 4052.5 4055.4 4072.6 4082.8 6122.3 6227.0 6230.5 6237.2 6248.4 5229.8 5770.1 5954.7 5995.8 6019.9 5882.4 5953.4 6000.0 6016.5 6067.4 5252.5 5860.6 5901.3 5901.6 5916.8 5676.9 5966.9 5975.7 6021.6 6033.3 5053.4 5318.9 5535.2 5824.9 5838.5 13:20:13 INFO - PROCESS | 2010 | 13:20:13 INFO - PROCESS | 2010 | [#5] yui.html Cycles:180 Average:24724.26 Median:3618.15 stddev:39227.57 (1084.2%) stddev-sans-first:39296.23 13:20:13 INFO - PROCESS | 2010 | Values: 725.2 762.3 769.4 796.2 852.0 15443.2 15943.0 16133.4 16143.1 16190.4 14719.8 14773.9 14805.6 14855.8 14901.9 699.5 871.5 871.5 895.9 906.6 869.8 873.9 890.0 898.3 901.5 949.8 951.3 952.4 954.1 960.2 924.2 948.6 948.7 948.9 949.3 692.9 702.0 704.1 706.4 707.0 15377.9 15383.5 15444.2 15459.1 15512.8 12165.4 14852.6 14887.4 14956.9 14957.0 10138.6 11869.3 12001.5 12026.4 12090.9 3633.3 3883.4 3908.6 3962.0 4076.1 100009.0 106875.0 108205.0 111457.4 113026.0 11382.1 11433.4 11476.6 11478.4 11588.4 23975.5 24012.4 24016.9 24018.8 24057.9 8062.0 8156.6 8337.5 8436.7 8472.7 4593.5 4605.8 4647.3 4650.3 4771.1 3554.8 3603.0 3654.9 3662.2 3667.7 628.4 680.2 684.9 690.1 696.4 544.4 557.3 673.6 682.1 697.0 8945.0 9443.5 9561.3 9634.9 9855.6 641.3 654.9 677.2 698.4 719.0 4686.5 4689.4 4723.8 4762.5 4791.8 95572.5 122530.0 138269.3 148026.6 160443.0 134509.3 138396.3 139412.0 142038.7 144416.3 118624.0 119412.4 119568.0 119601.0 119863.4 7334.4 8410.7 8507.4 8909.0 9057.7 63915.7 65648.0 65666.4 66496.7 68616.3 62122.7 64275.0 68398.3 80664.6 99244.5 12182.9 12349.6 12379.3 12412.3 12667.4 10452.2 13554.0 13605.0 13679.5 14193.2 12214.6 12609.3 13766.4 14773.0 15230.3 14256.9 14535.2 14694.5 14810.9 15273.3 12317.8 13897.3 14067.9 14089.0 14786.8 11478.7 11761.9 11774.5 11808.5 12072.2 10650.9 11437.3 11779.7 11867.7 11998.8 13:20:13 INFO - PROCESS | 2010 | -------- Summary: end -------- 13:20:13 INFO - PROCESS | 2010 | 13:20:14 INFO - TEST-INFO | 2010: exit 0 13:20:14 INFO - TEST-OK | dromaeo_css | took 1114201ms 13:20:14 INFO - TEST-START | kraken 13:20:14 INFO - operating with platform_type : mac_ 13:20:14 INFO - Initialising browser for kraken test... 13:20:14 INFO - TEST-INFO | started process 2014 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpQD7Ine/profile http://localhost:49396/getInfo.html) 13:20:17 INFO - PROCESS | 2014 | __metrics Screen width/height:1600/1200 13:20:17 INFO - PROCESS | 2014 | colorDepth:24 13:20:17 INFO - PROCESS | 2014 | Browser inner width/height: 1024/689 13:20:17 INFO - PROCESS | 2014 | __metrics 13:20:17 ERROR - PROCESS | 2014 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:20:18 INFO - TEST-INFO | 2014: exit 0 13:20:18 INFO - Browser initialized. 13:20:18 INFO - Running cycle 1/1 for kraken test... 13:20:18 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpQD7Ine/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:30 INFO - PROCESS | 2016 | RSS: Main: 254083072 13:20:30 INFO - PROCESS | 2016 | 13:20:32 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-beat-detection) 13:20:33 INFO - PROCESS | 2016 | RSS: Main: 266878976 13:20:33 INFO - PROCESS | 2016 | 13:20:36 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-dft) 13:20:36 INFO - PROCESS | 2016 | RSS: Main: 271003648 13:20:36 INFO - PROCESS | 2016 | 13:20:40 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-fft) 13:20:40 INFO - PROCESS | 2016 | RSS: Main: 271237120 13:20:40 INFO - PROCESS | 2016 | 13:20:42 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49396/tests/kraken/driver.html?testName=audio-oscillator) 13:20:43 INFO - PROCESS | 2016 | RSS: Main: 272134144 13:20:43 INFO - PROCESS | 2016 | 13:20:45 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:20:45 INFO - PROCESS | 2016 | RSS: Main: 272769024 13:20:45 INFO - PROCESS | 2016 | 13:20:48 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49396/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:49 INFO - PROCESS | 2016 | RSS: Main: 272588800 13:20:49 INFO - PROCESS | 2016 | 13:20:52 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49396/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:53 INFO - PROCESS | 2016 | RSS: Main: 273448960 13:20:53 INFO - PROCESS | 2016 | 13:20:56 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49396/tests/kraken/driver.html?testName=json-parse-financial) 13:20:57 INFO - PROCESS | 2016 | RSS: Main: 273522688 13:20:57 INFO - PROCESS | 2016 | 13:20:58 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:20:59 INFO - PROCESS | 2016 | RSS: Main: 273137664 13:20:59 INFO - PROCESS | 2016 | 13:21:01 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:21:02 INFO - PROCESS | 2016 | RSS: Main: 273199104 13:21:02 INFO - PROCESS | 2016 | 13:21:04 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:21:05 INFO - PROCESS | 2016 | RSS: Main: 273473536 13:21:05 INFO - PROCESS | 2016 | 13:21:07 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:21:08 INFO - PROCESS | 2016 | RSS: Main: 273752064 13:21:08 INFO - PROCESS | 2016 | 13:21:11 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:21:12 INFO - PROCESS | 2016 | RSS: Main: 273592320 13:21:12 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49396/tests/kraken/driver.html?testName=ai-astar) 13:21:13 INFO - PROCESS | 2016 | RSS: Main: 274714624 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | __start_tp_report 13:21:13 INFO - PROCESS | 2016 | _x_x_mozilla_page_load 13:21:13 INFO - PROCESS | 2016 | _x_x_mozilla_page_load_details 13:21:13 INFO - PROCESS | 2016 | |i|pagename|runs| 13:21:13 INFO - PROCESS | 2016 | |0;ai-astar;104;117;108;114;115;117;113;115;97;163 13:21:13 INFO - PROCESS | 2016 | |1;audio-beat-detection;144;126;154;154;107;149;160;113;158;108 13:21:13 INFO - PROCESS | 2016 | |2;audio-dft;195;201;198;203;218;206;192;196;199;193 13:21:13 INFO - PROCESS | 2016 | |3;audio-fft;70;83;75;100;84;80;75;61;131;59 13:21:13 INFO - PROCESS | 2016 | |4;audio-oscillator;70;73;126;103;101;86;111;70;70;113 13:21:13 INFO - PROCESS | 2016 | |5;imaging-gaussian-blur;88;104;134;86;88;86;88;89;89;76 13:21:13 INFO - PROCESS | 2016 | |6;imaging-darkroom;95;106;95;143;150;136;96;128;151;149 13:21:13 INFO - PROCESS | 2016 | |7;imaging-desaturate;151;150;101;150;116;96;95;138;124;91 13:21:13 INFO - PROCESS | 2016 | |8;json-parse-financial;55;58;57;57;58;56;57;58;55;57 13:21:13 INFO - PROCESS | 2016 | |9;json-stringify-tinderbox;67;70;101;124;72;67;67;82;106;108 13:21:13 INFO - PROCESS | 2016 | |10;stanford-crypto-aes;96;100;78;98;97;106;93;84;84;84 13:21:13 INFO - PROCESS | 2016 | |11;stanford-crypto-ccm;137;136;135;134;133;134;150;137;248;158 13:21:13 INFO - PROCESS | 2016 | |12;stanford-crypto-pbkdf2;166;163;177;168;166;169;164;163;166;163 13:21:13 INFO - PROCESS | 2016 | |13;stanford-crypto-sha256-iterative;66;66;66;69;71;67;66;70;64;68 13:21:13 INFO - PROCESS | 2016 | __end_tp_report 13:21:13 INFO - PROCESS | 2016 | __start_cc_report 13:21:13 INFO - PROCESS | 2016 | _x_x_mozilla_cycle_collect,1118 13:21:13 INFO - PROCESS | 2016 | __end_cc_report 13:21:13 INFO - PROCESS | 2016 | __startTimestamp1468441273929__endTimestamp 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | ------- Summary: start ------- 13:21:13 INFO - PROCESS | 2016 | Number of tests: 14 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#0] ai-astar Cycles:10 Average:116.30 Median:116.00 stddev:17.62 (15.2%) stddev-sans-first:18.12 13:21:13 INFO - PROCESS | 2016 | Values: 104.0 117.0 108.0 114.0 115.0 117.0 113.0 115.0 97.0 163.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:151.50 stddev:21.55 (14.2%) stddev-sans-first:22.72 13:21:13 INFO - PROCESS | 2016 | Values: 144.0 126.0 154.0 154.0 107.0 149.0 160.0 113.0 158.0 108.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#2] audio-dft Cycles:10 Average:200.10 Median:200.00 stddev:7.67 (3.8%) stddev-sans-first:7.91 13:21:13 INFO - PROCESS | 2016 | Values: 195.0 201.0 198.0 203.0 218.0 206.0 192.0 196.0 199.0 193.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:20.94 (27.9%) stddev-sans-first:21.77 13:21:13 INFO - PROCESS | 2016 | Values: 70.0 83.0 75.0 100.0 84.0 80.0 75.0 61.0 131.0 59.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:70.00 stddev:21.10 (30.1%) stddev-sans-first:20.78 13:21:13 INFO - PROCESS | 2016 | Values: 70.0 73.0 126.0 103.0 101.0 86.0 111.0 70.0 70.0 113.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:88.00 stddev:15.97 (18.1%) stddev-sans-first:16.84 13:21:13 INFO - PROCESS | 2016 | Values: 88.0 104.0 134.0 86.0 88.0 86.0 88.0 89.0 89.0 76.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#6] imaging-darkroom Cycles:10 Average:124.90 Median:150.50 stddev:24.34 (16.2%) stddev-sans-first:23.29 13:21:13 INFO - PROCESS | 2016 | Values: 95.0 106.0 95.0 143.0 150.0 136.0 96.0 128.0 151.0 149.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#7] imaging-desaturate Cycles:10 Average:121.20 Median:150.50 stddev:24.73 (16.4%) stddev-sans-first:23.77 13:21:13 INFO - PROCESS | 2016 | Values: 151.0 150.0 101.0 150.0 116.0 96.0 95.0 138.0 124.0 91.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.14 (2.0%) stddev-sans-first:1.00 13:21:13 INFO - PROCESS | 2016 | Values: 55.0 58.0 57.0 57.0 58.0 56.0 57.0 58.0 55.0 57.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#9] json-stringify-tinderbox Cycles:10 Average:86.40 Median:67.00 stddev:21.35 (31.9%) stddev-sans-first:21.46 13:21:13 INFO - PROCESS | 2016 | Values: 67.0 70.0 101.0 124.0 72.0 67.0 67.0 82.0 106.0 108.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:88.50 stddev:8.98 (10.1%) stddev-sans-first:9.41 13:21:13 INFO - PROCESS | 2016 | Values: 96.0 100.0 78.0 98.0 97.0 106.0 93.0 84.0 84.0 84.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:137.00 stddev:35.32 (25.8%) stddev-sans-first:37.14 13:21:13 INFO - PROCESS | 2016 | Values: 137.0 136.0 135.0 134.0 133.0 134.0 150.0 137.0 248.0 158.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.00 stddev:4.25 (2.6%) stddev-sans-first:4.50 13:21:13 INFO - PROCESS | 2016 | Values: 166.0 163.0 177.0 168.0 166.0 169.0 164.0 163.0 166.0 163.0 13:21:13 INFO - PROCESS | 2016 | 13:21:13 INFO - PROCESS | 2016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.16 (3.2%) stddev-sans-first:2.24 13:21:13 INFO - PROCESS | 2016 | Values: 66.0 66.0 66.0 69.0 71.0 67.0 66.0 70.0 64.0 68.0 13:21:13 INFO - PROCESS | 2016 | -------- Summary: end -------- 13:21:13 INFO - PROCESS | 2016 | 13:21:14 INFO - TEST-INFO | 2016: exit 0 13:21:14 INFO - TEST-OK | kraken | took 60270ms 13:21:14 INFO - SUITE-END | took 1174s 13:21:15 INFO - Completed test suite (00:19:34) 13:21:15 INFO - javascript benchmark 13:21:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7611.697804597334, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.06003349079, 3444.689977901988, 3445.793252404856, 3448.5516882805246, 3468.687818096371, 4946.9257961130525, 5823.941760582393, 5847.298324201097, 5873.292024545992, 5928.911066334003, 5652.152177173426, 5825.271841019872, 5863.736131874065, 5866.853328666785, 5935.910961335583, 5281.392639846428, 5298.779545035142, 5302.549283310923, 5409.323834520685, 5434.809781657623, 5394.05604019297, 5425.37608175061, 5444.101723215665, 5447.346318441792, 5471.206675032118, 4774.546418090275, 5261.736913154327, 5269.0, 5317.707526086064, 5339.519443250107, 5367.677939323614, 5370.113931201347, 5373.247745315659, 5382.085045542267, 5409.134538473864, 5242.7378631068295, 5309.150535914274, 5343.812966546191, 5358.517733404013, 5385.676859388449, 5520.91718624221, 5896.174535565025, 5969.403059694039, 5979.970100149471, 5985.191999080112, 6212.627242365427, 6239.126522286883, 6243.625382477066, 6252.155958945529, 6282.2147231596055, 6174.5060395168275, 6189.412005859436, 6314.71583778731, 6316.0, 6334.588251763621, 4900.926486102711, 5849.912251316234, 5869.647821130746, 5935.258092738408, 5983.880322393571, 5642.6614403135945, 6315.810525684236, 6341.143945567382, 6389.137466441971, 6402.935970640234, 6143.723532441051, 6159.5072394209255, 6167.290761562478, 6235.719392627343, 6247.156633854463, 6244.0, 6291.559590828598, 6304.716287767062, 6308.936910630927, 6338.334474880164, 6180.690965451709, 6199.752009919643, 6205.968970155121, 6254.21822272216, 6286.245650521967, 6045.78839740607, 6175.567710260329, 6236.314005459396, 6249.7187626556915, 6276.592021518587, 4980.626453016038, 5026.74866256693, 5043.142665746832, 5047.9495205048215, 5081.644284900095, 4483.148201841705, 4484.730916145042, 4489.753063581469, 4525.0497395546645, 4581.473130589959, 5903.498202652822, 5971.253593300838, 5992.43071908168, 6015.0676645120075, 6079.908801367983, 6299.937000630027, 6316.463100636405, 6317.273513545909, 6338.7464501420345, 6342.714577844008, 6041.24484439445, 6053.0, 6061.515078793686, 6069.484093851984, 6070.119832624245, 5419.485148910847, 5507.201455788888, 5551.72241387929, 5571.526420254243, 5588.6646801192055, 6499.220093588705, 6550.672466376662, 6570.605763654196, 6581.736730530725, 6582.473402127723, 6308.369163083655, 6311.558190926591, 6326.905096423466, 6335.113084168128, 6335.429811316819, 6308.306086330592, 6388.456981156468, 6474.449671777952, 6490.578112422678, 6584.934150658623, 6206.72069756871, 6227.782027629011, 6235.314115447388, 6284.088807123033, 6286.717097730704, 5112.233165025276, 6197.597156185014, 6300.338464461165, 6326.810195694136, 6353.110564520878, 6100.30868792748, 6169.938300617116, 6176.629402235881, 6185.41238582334, 6223.657698826608, 6210.192674952227, 6219.937800621936, 6224.657643829632, 6242.5942313749465, 6255.655938923403, 6051.213342265477, 6084.11780291864, 6166.506679465542, 6180.969095154495, 6224.875502490016, 6150.446459818459, 6158.384161583985, 6208.937910620836, 6230.501559875109, 6241.906371404523, 6136.723847426787, 6140.078988151813, 6155.815325540241, 6156.076588511759, 6170.382961703794], "value": 5803.533819622202, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.2673945493666, 489.98040078396843, 526.2395838014069, 532.2070115527864, 563.4281204577352, 27085.864570677142, 36788.81605591971, 38635.227295454075, 38740.225195496074, 40081.19837603246, 40322.99192520181, 40515.39226911599, 41342.0, 41353.58646413535, 41382.0, 9214.401063930856, 9352.953235233814, 9459.763505912373, 9487.098725621056, 9527.761805954837, 8255.25702686758, 9545.331826772128, 9579.473128977903, 9686.32195746298, 9727.173190278834, 9630.662926797564, 9662.806743865154, 9672.177864881494, 9678.322517423783, 9683.225341972626, 9584.0, 9623.0, 9627.759306017335, 9673.709788706316, 9676.080772326617, 9621.0, 9723.319367644268, 9733.367331123454, 9736.75658108546, 9769.462679552622, 38921.0, 39005.21989560221, 39012.80493597514, 39090.022749431206, 39208.21583568313, 2797.237394126496, 3318.8120783649847, 3414.393641339261, 3481.669241422061, 3495.4582039783872, 30811.537826932614, 31037.068887933397, 31316.686833131833, 31344.686553134405, 31415.057548273588, 3093.334932989418, 3131.24850035992, 3134.388794185135, 3142.4500712375243, 3142.4814905540557, 420520.0, 455259.7237013794, 487794.0, 504480.0, 505465.0, 62835.0, 63212.68393658094, 63408.36591634117, 63429.68285158637, 63576.68211658912, 35674.64325356765, 36190.0, 36223.27553448916, 65865.67067164634, 66114.33885661178, 13852.515161969484, 16973.236204370834, 17123.0, 17154.828451715322, 17173.57066073333, 12855.29295888735, 12890.548830790878, 12910.289934053717, 13054.34728263583, 13068.281244531452, 20127.49681257951, 20271.4932126698, 20307.0, 20319.593608127754, 20365.490862728253, 6729.865402692017, 8218.794530136674, 8287.295579875778, 8336.541490218096, 8353.498790072616, 856.9614367353485, 928.150742071011, 928.475411392561, 937.3672770879629, 1011.6813203840767, 30730.539041914388, 30926.845365773475, 31524.211894702818, 31533.8423307882, 31673.0, 1131.3155540897803, 1140.8688000879838, 1146.4955419615342, 1164.3537836500823, 1178.7465694875643, 15948.68102637964, 16193.919030404773, 16221.918890405708, 16222.918885405497, 16271.430499932445, 606149.0, 719977.0, 722035.0, 724603.0, 731197.0, 58792.412075878696, 58801.0, 59274.55440841868, 59432.405675943555, 59446.108308375406, 1180.6635108993896, 1405.4588983241322, 1406.866347696967, 1421.9075760075561, 1423.5302350224608, 28457.573136403385, 30165.396692066475, 30205.640746166915, 30353.0, 30679.386412272077, 41703.58296416997, 51638.483615163364, 52085.47914520806, 52323.0, 52391.47608523866, 504561.0, 505881.0, 511865.0, 515704.0, 515991.0, 26998.595021074307, 27122.72877271202, 27233.685136763597, 27429.31426714348, 27433.039843605377, 41412.96467588334, 47198.29202561895, 48976.0204795895, 49583.504164957885, 49782.00435991332, 35878.820605896806, 40204.0, 40749.0, 41343.173136537705, 41440.171196576506, 36130.63869361273, 40209.79370618886, 40716.0, 40889.38665919954, 41466.0, 38580.0, 38660.420093698056, 38777.806110969264, 39243.41134883036, 39465.210695786496, 33962.320753585285, 34877.128071798405, 34877.47683784796, 35121.0, 36049.63950360463, 22933.0, 23094.653580195976, 25505.903034419563, 26217.213483595522, 26467.338316542242], "value": 19955.176400983997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1306056887453, 375.81209395302346, 382.9387298032315, 384.5923321279446, 397.00550121944525, 19954.501137471554, 21793.67309490359, 22239.22162724305, 22413.887930560366, 22466.0, 20302.59394812103, 21346.0, 21378.251761188363, 21399.144034238612, 21616.783832161673, 5354.785808567653, 5991.820245392645, 6097.756089756426, 6107.969460152693, 6149.969250153766, 3908.609139086097, 5848.941510584882, 5988.1317209004665, 6175.320714721377, 6185.4433101020895, 6072.2713274406915, 6181.289151747539, 6185.35053819347, 6198.411150940653, 6206.441420272175, 7184.245654206312, 7443.404527637776, 7563.7352692655495, 7615.46691731579, 7625.923740762577, 7112.786616401516, 7254.5647261164495, 7298.708051677927, 7399.334059934632, 7431.108267007994, 23060.884695576413, 30049.849750751324, 30257.697423025707, 30874.228144296347, 31014.689853101405, 2412.843165194274, 2418.9274321770376, 2499.9750002499923, 2706.282835048694, 3051.908442746721, 17330.74003889943, 17352.305907763675, 17918.283268669238, 17951.461456156205, 18361.7245741314, 1838.4668446150733, 1906.7044608085769, 1931.6812725900209, 1990.8705934114237, 2097.7587577428485, 124388.0, 128154.71845281521, 128547.35726321403, 157753.2112339431, 163021.0, 21457.283417326576, 22239.110435582395, 22246.443838904157, 22309.107635694716, 22437.43906402353, 36300.81849590735, 36307.636923630955, 36371.4544281836, 36445.817770911504, 36728.0, 10795.83806242907, 11221.775564488664, 11235.887641123647, 11241.796088114848, 11242.831357529643, 9161.0, 9185.35702500832, 9200.125988031126, 9256.305777066747, 9323.25413966881, 10102.747431314276, 10169.745756356002, 10229.641962531276, 10283.691489255334, 10306.072453479223, 1603.7834892289625, 1702.9829701703072, 1724.9137543122793, 1747.161362545985, 3379.6620337966497, 916.5234078279258, 964.3924327673661, 983.4952522640372, 988.7874107067015, 1072.7371793910543, 19282.614347712966, 19829.900850495655, 21203.787962120183, 21685.783142168693, 21786.0, 794.6225542867091, 887.3123329419751, 949.5774380400655, 970.6651205334149, 987.5161171026145, 10053.346532475365, 10788.406637635006, 11273.661790146309, 11389.145814063979, 11496.252743571642, 565651.0, 581495.0, 588192.0, 610127.0, 610747.0, 79772.20227797648, 82725.0, 93743.53128234314, 134386.0, 136254.0, 914.1087439746194, 980.9754756131153, 1002.6791426743519, 1049.9317544359592, 1080.2384319055047, 17571.648567028842, 18303.90176589409, 19820.40538783839, 19982.0, 20134.395968120978, 57419.0, 57803.0, 57916.420835791105, 59006.0, 59158.704206478695, 69778.95331570132, 78409.21590784247, 82676.58661706652, 84206.0, 89515.10484895328, 8010.279074883289, 8149.633266502903, 8238.299744521782, 8342.29090527312, 8365.121662225622, 9161.083891610786, 10330.0, 12276.815847762113, 12887.904528114841, 13337.133086349357, 10960.08198565232, 11094.278871873303, 11175.273607215506, 11249.718757030812, 11437.542498300307, 9582.856257156009, 10536.683899483029, 11111.277766945122, 11204.83192752093, 11363.0, 11031.83452248233, 11251.099912007183, 11392.658220253406, 11451.141164412536, 11687.474063667325, 8223.588820559067, 8334.20825021622, 8336.62485188156, 8352.164783521599, 8461.40770146084, 7710.0, 10216.489175541343, 11160.497777599865, 11260.042896353902, 11527.481263343001], "value": 10816.146126701431, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.4800915697822, 1607.7025750236207, 1835.0916296433259, 1904.495308743184, 1919.7600299962505, 8221.794455138624, 8652.394332396734, 8770.517621530822, 9225.584848681818, 9269.629214831399, 8684.523630982732, 8825.940887093559, 8840.60217290222, 8939.910600893989, 8952.0, 2354.3643216331625, 2403.387136280246, 2407.723111842134, 2408.8072954163626, 2418.2745176447083, 2392.28231530541, 2394.9281521554294, 2411.5297516984197, 2417.9758202418016, 2435.305937807725, 2387.9880600597057, 2395.940101497459, 2405.278416475059, 2408.084927727461, 2411.577973854577, 2371.4071482129466, 2382.118616112041, 2394.209910729464, 2396.197273913241, 2403.182917807945, 2371.2530552875787, 2377.465070359173, 2405.8315917885757, 2417.178159425786, 2559.0659409315467, 9081.772955676095, 9124.726258212264, 9137.497437640926, 9147.725568232963, 9157.130072643089, 4687.695299805502, 5372.462753724596, 5436.429174936614, 5504.22940788286, 5516.172574113875, 3581.623929487392, 3668.7248456365614, 3705.981470092659, 3733.6826369758605, 3746.400575907842, 1053.4679986606714, 1074.484247561175, 1078.741102135482, 1091.650671785029, 1095.2497539185604, 10948.288361256493, 11070.557177712883, 11962.282263064244, 12096.758064838741, 12207.206531575419, 4777.593904518086, 4793.089313030513, 4893.828715994923, 4972.726500042532, 4981.701097934136, 8434.32525397979, 10102.242331825142, 10491.318064325795, 10493.685189444328, 10510.0, 5397.487238712394, 5448.809291674773, 5489.149181876815, 5502.477264659851, 5503.697296648643, 4480.103979204172, 4822.445418776815, 4987.251912213124, 5018.648694591417, 5028.497150284942, 4101.947057536663, 4111.444954931046, 4123.97938010308, 4137.213929353413, 4148.502179738451, 1305.8694130586866, 1312.665270356053, 1332.8933685305153, 1342.7717288061053, 1345.6232254968625, 857.6226460357423, 920.8075542172902, 921.1019256225127, 925.9629614815332, 947.4362754161263, 5725.914111288334, 5818.44724751148, 5841.561882858802, 5903.616264942851, 5965.433283838029, 428.8156092880029, 434.1942870737984, 441.52756550491307, 449.4628918442495, 454.2096751652102, 3436.879709210216, 3692.667659910567, 3904.39481880309, 3931.7837518936735, 3939.5075615548058, 10650.467476626138, 11112.16658750597, 11182.66452006441, 11186.216964812385, 11188.992990630883, 10856.402897840695, 10899.0, 11072.944635276934, 11132.944335278271, 11165.609203677832, 8290.626921788535, 8395.24442800151, 8402.537860417735, 8473.983122025273, 8539.82920341602, 5801.361850196559, 5815.156802263564, 5821.79623713168, 5830.271216097988, 5918.496927761188, 10166.847497287694, 10230.48847557634, 10292.588296468057, 10317.690469285933, 10344.379337239488, 9742.220622350053, 10310.587576496857, 10320.380777153396, 10397.168226541708, 10452.738681532719, 7626.847463050819, 7655.349295309961, 7845.293923546908, 7851.2148785121035, 7876.291133797757, 8376.49741015541, 8520.957395212985, 8555.82888342242, 8593.398462107592, 8609.397342185986, 7377.815554610963, 7651.273129052731, 7794.103678076867, 7805.414593905366, 7906.090799557895, 7553.395728341609, 7578.962105189659, 7661.310482056641, 7763.4953728007495, 7769.106552746506, 7130.821729456805, 7206.351428371472, 7220.566765993847, 7229.566226026455, 7255.927440725525, 4154.979225103976, 4884.731339776346, 4902.3872015998, 5027.120253955616, 5040.218766091261, 5012.924806127838, 5039.319691841554, 5042.520960508746, 5083.949160508348, 5170.37955445349], "value": 4594.32480955424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.97832173426127, 282.2815933449371, 289.6509705804506, 311.5949265954259, 312.9297801518805, 4629.791659375328, 4908.582770464511, 5004.324416203812, 5573.860653483665, 5614.214010038598, 5422.1595652673805, 5472.480114389136, 5473.507384335409, 5498.477644623755, 5523.28197334347, 4044.575319591452, 4168.687348448863, 4239.576042395751, 4268.274393353137, 4275.080857615612, 3413.982930085346, 3489.5114683944266, 4110.6094920982605, 4238.258304796648, 4301.537477257732, 3489.842957066938, 3493.615702272748, 3830.885073447787, 3985.3224951758125, 4211.263028969934, 3500.317438099559, 3900.3564411872007, 4192.203481338551, 4196.265653510623, 4218.915621687549, 3579.0336609115393, 3587.8385472653795, 3595.1551385424405, 3615.8011309377976, 3619.855205791765, 4424.256960684396, 5403.243545903577, 5418.512333889929, 5488.286522752017, 5494.36814766303, 4422.385829172361, 4699.224627936386, 4815.927761083586, 4820.662553621248, 4841.8063277468855, 5007.7981284491825, 5579.6652200867675, 5807.941920580824, 5833.854153646151, 5888.38171991939, 3409.2670075933793, 3885.2229554089013, 3905.2775236581324, 3918.2555314490155, 3921.5882332355263, 5884.941150588525, 6038.0715353054175, 6158.6612736299485, 6169.475594574466, 6181.732744787308, 3993.8602148924647, 4005.939910901339, 4006.939895901564, 4010.0926828049433, 4010.939835902464, 3715.7956312403076, 4066.552679205285, 4083.0, 4087.6116768906904, 4093.672506199497, 3751.7748935063983, 4136.627703506639, 4579.748113853703, 4609.032103258353, 4803.735794531264, 5146.562542183881, 5862.824115276549, 5907.3797251288, 5912.645241285537, 5923.7926672566255, 1324.973500529984, 1356.2540602668494, 1393.4008376398247, 1395.864327578806, 1405.6134562995053, 847.0555330806106, 862.4092496639822, 862.4609618988133, 867.8394497018072, 902.2105657549644, 4306.82772689089, 4964.280179373971, 5222.3472065991755, 5471.425500322488, 5497.230387745719, 4511.458624964959, 5294.364676238876, 6045.274567051982, 6083.7870674526175, 6119.296280927751, 4963.70217786934, 5156.458571849977, 5364.409914909357, 5392.548768787979, 5412.103285634337, 3137.5607414961923, 3166.0, 3173.6826317368077, 3184.601924759405, 3186.952195717066, 5273.44628813969, 5664.8867022659315, 6179.783707570304, 6261.436470717657, 6281.057841323838, 5093.439721630618, 5520.365158006881, 5742.196092547047, 5902.0, 6175.2898416681755, 5434.483724046209, 6215.0, 6262.5616206866, 6270.717817698123, 6302.936970630235, 5316.734163291897, 5615.2700148980375, 5951.583389162717, 5965.642061476326, 6159.476444502267, 5145.716985565829, 6039.577229593886, 6062.818115456544, 6069.2716873975405, 6075.605085669417, 5960.748242868873, 6051.33435322123, 6071.362506936708, 6335.746570137143, 6405.3594640535575, 4031.23406552754, 4052.4731784867777, 4055.371417430303, 4072.5927407259037, 4082.755034697928, 6122.326544080237, 6226.968865155645, 6230.470410015199, 6237.220347456568, 6248.375162483715, 5229.790808367623, 5770.086106516183, 5954.702264886825, 5995.790147344822, 6019.939800602113, 5882.411758824083, 5953.404659534012, 6000.0, 6016.47308130595, 6067.423594758491, 5252.527272545489, 5860.589758717019, 5901.29184497863, 5901.557383196363, 5916.792912248051, 5676.864627074684, 5966.850828729316, 5975.671338076274, 6021.578489505692, 6033.306169790355, 5053.372246431762, 5318.8936221276135, 5535.225068490495, 5824.854378640398, 5838.532917366516], "value": 4243.170409951341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.1696807155806, 762.3215338348868, 769.4152444142453, 796.2356138107417, 851.9606080581689, 15443.15062671554, 15943.0, 16133.43532976346, 16143.11212883294, 16190.352385904564, 14719.779203311959, 14773.926130369333, 14805.55583332499, 14855.777163342558, 14901.850981490183, 699.464909344352, 871.4684042733943, 871.5293741379647, 895.8835351404308, 906.5784410249232, 869.821686554258, 873.9038705742363, 889.9733008009738, 898.3127907151035, 901.5086777706133, 949.7910459698855, 951.3198063384679, 952.3857112162651, 954.0697819625879, 960.1550635440802, 924.1959495239184, 948.5541795356172, 948.7485816258697, 948.9383190092622, 949.2975198353168, 692.9133858267717, 701.9859602807966, 704.0565642039692, 706.4136766483806, 706.9611171385571, 15377.92354535183, 15383.461578844799, 15444.227788610637, 15459.072455652697, 15512.767308490382, 12165.391730413445, 14852.554423367315, 14887.404503819942, 14956.925215373962, 14957.0, 10138.645147419806, 11869.347185904771, 12001.51993920242, 12026.398680065962, 12090.879091209063, 3633.255182687543, 3883.417487376888, 3908.609139086097, 3962.0094976255937, 4076.12498250805, 100009.0, 106875.0, 108205.0, 111457.44271278592, 113026.0, 11382.146339024606, 11433.371164586028, 11476.598319058792, 11478.368689721978, 11588.362640054878, 23975.52048959046, 24012.39969000789, 24016.87991560031, 24018.75981240165, 24057.879710601333, 8061.959690201512, 8156.551389673625, 8337.458065225863, 8436.704715335056, 8472.661093556311, 4593.540645935446, 4605.792739326738, 4647.256438969816, 4650.279206722963, 4771.117343291502, 3554.7511674183074, 3603.045193023851, 3654.945175822365, 3662.1760103976394, 3667.688246499024, 628.4187126907683, 680.1973671068088, 684.9315068493211, 690.082190686386, 696.373264062348, 544.413317797554, 557.31299768943, 673.5520878615764, 682.1200651159949, 696.9756058537927, 8944.955275223712, 9443.480608566457, 9561.330706850455, 9634.855477167848, 9855.605775769032, 641.3202005873788, 654.8853950558633, 677.1501765284536, 698.4307789151825, 718.9676464559108, 4686.461056978423, 4689.437267527918, 4723.763811809465, 4762.499937506581, 4791.784369703371, 95572.52213738886, 122530.0, 138269.3086534581, 148026.55920322408, 160443.0, 134509.32745336212, 138396.30801845927, 139412.0, 142038.73883783503, 144416.27791861183, 118624.0, 119412.41762746958, 119568.0, 119601.0, 119863.40068299777, 7334.4132469403385, 8410.663573456994, 8507.447015943944, 8908.955455222682, 9057.71577683634, 63915.68042159759, 65648.0, 65666.35834103994, 66496.66751666211, 68616.31383686299, 62122.689386552775, 64275.0, 68398.31601683919, 80664.59667701623, 99244.50377748066, 12182.903538681561, 12349.629511114681, 12379.257244565355, 12412.255264684149, 12667.429965651383, 10452.216083793897, 13554.0, 13605.0, 13679.521216757366, 14193.219372934587, 12214.633560993185, 12609.30648814324, 13766.380512876744, 14773.039752416058, 15230.314635841636, 14256.857431425553, 14535.183102112236, 14694.485693000694, 14810.925945370635, 15273.312700928707, 12317.753644926872, 13897.305134743425, 14067.929660351632, 14089.0, 14786.778198326818, 11478.713032174262, 11761.88238117608, 11774.470148843151, 11808.468618911998, 12072.20346432784, 10650.946745266225, 11437.256578322382, 11779.705507362041, 11867.703307417383, 11998.76002479963], "value": 7963.621430120999, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 108.0, 114.0, 115.0, 117.0, 113.0, 115.0, 97.0, 163.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 126.0, 154.0, 154.0, 107.0, 149.0, 160.0, 113.0, 158.0, 108.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 201.0, 198.0, 203.0, 218.0, 206.0, 192.0, 196.0, 199.0, 193.0], "value": 200.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 75.0, 100.0, 84.0, 80.0, 75.0, 61.0, 131.0, 59.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 126.0, 103.0, 101.0, 86.0, 111.0, 70.0, 70.0, 113.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 104.0, 134.0, 86.0, 88.0, 86.0, 88.0, 89.0, 89.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 95.0, 143.0, 150.0, 136.0, 96.0, 128.0, 151.0, 149.0], "value": 124.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 101.0, 150.0, 116.0, 96.0, 95.0, 138.0, 124.0, 91.0], "value": 121.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 57.0, 58.0, 56.0, 57.0, 58.0, 55.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 101.0, 124.0, 72.0, 67.0, 67.0, 82.0, 106.0, 108.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 78.0, 98.0, 97.0, 106.0, 93.0, 84.0, 84.0, 84.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 135.0, 134.0, 133.0, 134.0, 150.0, 137.0, 248.0, 158.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 177.0, 168.0, 166.0, 169.0, 164.0, 163.0, 166.0, 163.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 69.0, 71.0, 67.0, 66.0, 70.0, 64.0, 68.0], "value": 67.3, "unit": "score"}]}]} 13:21:15 INFO - Return code: 0 13:21:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:21:15 ERROR - # TBPL SUCCESS # 13:21:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:21:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:21:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:21:15 INFO - 2016-07-13 13:21:15.269 screenresolution[2022:13184] starting screenresolution argv=screenresolution get 13:21:15 INFO - 2016-07-13 13:21:15.271 screenresolution[2022:13184] Display 0: 1600x1200x32@60 13:21:15 INFO - 2016-07-13 13:21:15.277 screenresolution[2023:13187] starting screenresolution argv=screenresolution list 13:21:15 INFO - Available Modes on Display 0 13:21:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:21:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:21:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:21:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:21:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:21:15 INFO - Intel Iris: 13:21:15 INFO - Chipset Model: Intel Iris 13:21:15 INFO - Type: GPU 13:21:15 INFO - Bus: Built-In 13:21:15 INFO - VRAM (Dynamic, Max): 1536 MB 13:21:15 INFO - Vendor: Intel (0x8086) 13:21:15 INFO - Device ID: 0x0a2e 13:21:15 INFO - Revision ID: 0x0009 13:21:15 INFO - Displays: 13:21:15 INFO - Display: 13:21:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:21:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:21:15 INFO - Display Serial Number: 1600x1200 60 13:21:15 INFO - Main Display: Yes 13:21:15 INFO - Mirror: Off 13:21:15 INFO - Online: Yes 13:21:15 INFO - Rotation: Supported 13:21:15 INFO - Return code: 0 13:21:15 INFO - Running post-action listener: _resource_record_post_action 13:21:15 INFO - ##### 13:21:15 INFO - ##### Finished run-tests step (success) 13:21:15 INFO - ##### 13:21:15 INFO - Running post-run listener: _resource_record_post_run 13:21:15 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1486848; Write bytes: 702925824; Read time: 10; Write time: 1961 13:21:15 INFO - TinderboxPrint: CPU usage
54.1% 13:21:15 INFO - TinderboxPrint: I/O read bytes / time
1,486,848 / 10 13:21:15 INFO - TinderboxPrint: I/O write bytes / time
702,925,824 / 1,961 13:21:15 INFO - TinderboxPrint: CPU idle
2,221.6 (45.9%) 13:21:15 INFO - TinderboxPrint: CPU system
972.8 (20.1%) 13:21:15 INFO - TinderboxPrint: CPU user
1,643.3 (34.0%) 13:21:15 INFO - TinderboxPrint: Swap in / out
408,817,664 / 0 13:21:15 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 398686720; Write bytes: 393286656; Read time: 29442; Write time: 705 13:21:15 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1478656; Write bytes: 292022272; Read time: 10; Write time: 1218 13:21:15 INFO - Running post-run listener: _upload_blobber_files 13:21:15 INFO - Blob upload gear active. 13:21:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:21:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:21:16 INFO - (blobuploader) - INFO - Open directory for files ... 13:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:17 INFO - (blobuploader) - INFO - Done attempting. 13:21:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:21:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:20 INFO - (blobuploader) - INFO - Done attempting. 13:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:23 INFO - (blobuploader) - INFO - Done attempting. 13:21:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:21:23 INFO - Return code: 0 13:21:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:21:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:21:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bf77ca2bca0d0cd9b772fc1f3b6d57526aecc26e22966b3284042d9c98fb6f0f4989db77d0978698420aafeb4f5569478f02aca5bfd7d45120e05c64b3676d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c3e0f17d03707082913a73072f24a83045390b34140c227d75f5773f726304f64d30773eb6f71f3ebee4cb3f6f7e13eb1ef3f364c5321a21ab756e4e0785395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67f04ace81ed6f8e2c9f08a546cb97948a41439198059cdda48019ed30037b4fa972fe982d331ae227696d4db4e17099dda4d2084fb59d733b195258b83530ac"} 13:21:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:21:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:21:23 INFO - Contents: 13:21:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bf77ca2bca0d0cd9b772fc1f3b6d57526aecc26e22966b3284042d9c98fb6f0f4989db77d0978698420aafeb4f5569478f02aca5bfd7d45120e05c64b3676d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c3e0f17d03707082913a73072f24a83045390b34140c227d75f5773f726304f64d30773eb6f71f3ebee4cb3f6f7e13eb1ef3f364c5321a21ab756e4e0785395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67f04ace81ed6f8e2c9f08a546cb97948a41439198059cdda48019ed30037b4fa972fe982d331ae227696d4db4e17099dda4d2084fb59d733b195258b83530ac"} 13:21:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:21:23 INFO - Copying logs to upload dir... 13:21:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:21:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.123166 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-13 13:21:23.382638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:21:23.386458) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bf77ca2bca0d0cd9b772fc1f3b6d57526aecc26e22966b3284042d9c98fb6f0f4989db77d0978698420aafeb4f5569478f02aca5bfd7d45120e05c64b3676d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c3e0f17d03707082913a73072f24a83045390b34140c227d75f5773f726304f64d30773eb6f71f3ebee4cb3f6f7e13eb1ef3f364c5321a21ab756e4e0785395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67f04ace81ed6f8e2c9f08a546cb97948a41439198059cdda48019ed30037b4fa972fe982d331ae227696d4db4e17099dda4d2084fb59d733b195258b83530ac"} build_url:https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/Orsf8ndbSpe3-GBv4oU-4A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/73bf77ca2bca0d0cd9b772fc1f3b6d57526aecc26e22966b3284042d9c98fb6f0f4989db77d0978698420aafeb4f5569478f02aca5bfd7d45120e05c64b3676d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c3e0f17d03707082913a73072f24a83045390b34140c227d75f5773f726304f64d30773eb6f71f3ebee4cb3f6f7e13eb1ef3f364c5321a21ab756e4e0785395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67f04ace81ed6f8e2c9f08a546cb97948a41439198059cdda48019ed30037b4fa972fe982d331ae227696d4db4e17099dda4d2084fb59d733b195258b83530ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:21:23.419589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:21:23.419918) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KVtQKo2Q1v/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STgh1zmgA0/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005367 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:21:23.468855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:21:23.472335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:21:23.472927) ========= ========= Total master_lag: 0.18 =========