builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1476911219.9 results: success (0) buildid: 20161019122722 builduid: bb8d8481d12a47029b05f21f2c3a8d9d revision: 49dfb63c28b9c093f13391b999de40b01f125613 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:06:59.896459) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:06:59.897011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:06:59.897361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:06:59.921376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:06:59.921858) ========= 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.rJCdkAPjrn/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.00e1kFQEOr/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-10-19 14:06:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.56M=0.001s 2016-10-19 14:07:00 (8.56 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:07:00.066234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:07:00.066642) ========= 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.rJCdkAPjrn/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.00e1kFQEOr/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.021901 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:07:00.116245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-19 14:07:00.116629) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 49dfb63c28b9c093f13391b999de40b01f125613 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 49dfb63c28b9c093f13391b999de40b01f125613 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rJCdkAPjrn/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.00e1kFQEOr/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-10-19 14:07:00,186 truncating revision to first 12 chars 2016-10-19 14:07:00,186 Setting DEBUG logging. 2016-10-19 14:07:00,186 attempt 1/10 2016-10-19 14:07:00,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/49dfb63c28b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 14:07:02,006 unpacking tar archive at: mozilla-aurora-49dfb63c28b9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.091627 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-19 14:07:02.231149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:07:02.231494) ========= script_repo_revision: 49dfb63c28b9c093f13391b999de40b01f125613 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:07:02.231902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:07:02.232172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:07:02.250692) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-19 14:07:02.251101) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rJCdkAPjrn/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.00e1kFQEOr/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:02 INFO - MultiFileLogger online at 20161019 14:07:02 in /builds/slave/test 14:07:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:07:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:02 INFO - {'append_to_log': False, 14:07:02 INFO - 'base_work_dir': '/builds/slave/test', 14:07:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:07:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:02 INFO - 'branch': 'Mozilla-Aurora', 14:07:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:02 INFO - 'config_files': ('talos/mac_config.py',), 14:07:02 INFO - 'default_actions': ('clobber', 14:07:02 INFO - 'read-buildbot-config', 14:07:02 INFO - 'download-and-extract', 14:07:02 INFO - 'populate-webroot', 14:07:02 INFO - 'create-virtualenv', 14:07:02 INFO - 'install', 14:07:02 INFO - 'run-tests'), 14:07:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:02 INFO - 'download_minidump_stackwalk': True, 14:07:02 INFO - 'download_symbols': 'ondemand', 14:07:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:02 INFO - 'installer_path': 'installer.exe', 14:07:02 INFO - 'log_level': 'info', 14:07:02 INFO - 'log_name': 'talos', 14:07:02 INFO - 'log_to_console': True, 14:07:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:07:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:07:02 INFO - 'opt_config_files': (), 14:07:02 INFO - 'pip_index': False, 14:07:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:07:02 INFO - 'cmd': ('bash', 14:07:02 INFO - '-c', 14:07:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:07:02 INFO - 'enabled': True, 14:07:02 INFO - 'halt_on_failure': False, 14:07:02 INFO - 'name': 'check_screen_resolution'},), 14:07:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:07:02 INFO - 'cmd': ('bash', 14:07:02 INFO - '-c', 14:07:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:07:02 INFO - 'enabled': True, 14:07:02 INFO - 'halt_on_failure': False, 14:07:02 INFO - 'name': 'check_screen_resolution'},), 14:07:02 INFO - 'run_cmd_checks_enabled': True, 14:07:02 INFO - 'sps_profile': False, 14:07:02 INFO - 'sps_profile_interval': 0, 14:07:02 INFO - 'suite': 'dromaeojs', 14:07:02 INFO - 'system_bits': '32', 14:07:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:02 INFO - 'title': 't-yosemite-r7-0023', 14:07:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:02 INFO - 'use_talos_json': True, 14:07:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:02 INFO - 'work_dir': 'build'} 14:07:02 INFO - [mozharness: 2016-10-19 21:07:02.442336Z] Running clobber step. 14:07:02 INFO - Running pre-action listener: _resource_record_pre_action 14:07:02 INFO - Running main action method: clobber 14:07:02 INFO - rmtree: /builds/slave/test/build 14:07:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:03 INFO - Running post-action listener: _resource_record_post_action 14:07:03 INFO - [mozharness: 2016-10-19 21:07:03.937635Z] Finished clobber step (success) 14:07:03 INFO - [mozharness: 2016-10-19 21:07:03.937967Z] Running read-buildbot-config step. 14:07:03 INFO - Running pre-action listener: _resource_record_pre_action 14:07:03 INFO - Running main action method: read_buildbot_config 14:07:03 INFO - Using buildbot properties: 14:07:03 INFO - { 14:07:03 INFO - "project": "", 14:07:03 INFO - "product": "firefox", 14:07:03 INFO - "script_repo_revision": "production", 14:07:03 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:07:03 INFO - "repository": "", 14:07:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:07:03 INFO - "buildid": "20161019122722", 14:07:03 INFO - "pgo_build": "False", 14:07:03 INFO - "basedir": "/builds/slave/test", 14:07:03 INFO - "buildnumber": 14, 14:07:03 INFO - "slavename": "t-yosemite-r7-0023", 14:07:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:07:03 INFO - "platform": "yosemite_r7", 14:07:03 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:07:03 INFO - "branch": "mozilla-aurora", 14:07:03 INFO - "repo_path": "releases/mozilla-aurora", 14:07:03 INFO - "revision": "49dfb63c28b9c093f13391b999de40b01f125613", 14:07:03 INFO - "stage_platform": "macosx64", 14:07:03 INFO - "builduid": "bb8d8481d12a47029b05f21f2c3a8d9d", 14:07:03 INFO - "slavebuilddir": "test" 14:07:03 INFO - } 14:07:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:07:03 INFO - Running post-action listener: _resource_record_post_action 14:07:03 INFO - [mozharness: 2016-10-19 21:07:03.943638Z] Finished read-buildbot-config step (success) 14:07:03 INFO - [mozharness: 2016-10-19 21:07:03.943836Z] Running download-and-extract step. 14:07:03 INFO - Running pre-action listener: _resource_record_pre_action 14:07:03 INFO - Running main action method: download_and_extract 14:07:03 INFO - mkdir: /builds/slave/test/build/tests 14:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:03 INFO - trying https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:07:03 INFO - Downloading https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 14:07:05 INFO - Downloaded 1199 bytes. 14:07:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:07:05 INFO - Using the following test package requirements: 14:07:05 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:07:05 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:07:05 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:07:05 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'jsshell-mac.zip'], 14:07:05 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:07:05 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:07:05 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:07:05 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:07:05 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:07:05 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:07:05 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:07:05 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:07:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:07:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:07:05 INFO - Fetch https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:07:05 INFO - Expected file size: 16436093 14:07:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:07:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:07:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:07:12 INFO - Fetch https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:07:13 INFO - Expected file size: 16436093 14:07:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 14:07:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:07:19 INFO - Fetch https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 14:07:20 INFO - Expected file size: 14414081 14:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:21 INFO - trying https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:07:21 INFO - Downloading https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 14:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 14:07:23 INFO - Downloaded 115422471 bytes. 14:07:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:07:23 INFO - mkdir: /builds/slave/test/properties 14:07:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:23 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:23 INFO - Contents: 14:07:23 INFO - build_url:https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:07:24 INFO - Running post-action listener: _resource_record_post_action 14:07:24 INFO - Running post-action listener: set_extra_try_arguments 14:07:24 INFO - [mozharness: 2016-10-19 21:07:24.549632Z] Finished download-and-extract step (success) 14:07:24 INFO - [mozharness: 2016-10-19 21:07:24.549772Z] Running populate-webroot step. 14:07:24 INFO - Running pre-action listener: _resource_record_pre_action 14:07:24 INFO - Running main action method: populate_webroot 14:07:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:24 INFO - '--tppagecycles', 14:07:24 INFO - '7'], 14:07:24 INFO - 'tests': ['tsvgm']}}, 14:07:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['damp', 'tps']}, 14:07:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'tests': ['damp', 'tps']}, 14:07:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['dromaeo_dom']}, 14:07:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['basic_compositor_video']}, 14:07:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:07:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['a11yr', 14:07:24 INFO - 'ts_paint', 14:07:24 INFO - 'tpaint', 14:07:24 INFO - 'sessionrestore', 14:07:24 INFO - 'sessionrestore_no_auto_restore', 14:07:24 INFO - 'tabpaint']}, 14:07:24 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:24 INFO - 'ts_paint', 14:07:24 INFO - 'tpaint', 14:07:24 INFO - 'sessionrestore', 14:07:24 INFO - 'sessionrestore_no_auto_restore', 14:07:24 INFO - 'tabpaint']}, 14:07:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:07:24 INFO - 'ts_paint', 14:07:24 INFO - 'tpaint', 14:07:24 INFO - 'sessionrestore', 14:07:24 INFO - 'sessionrestore_no_auto_restore', 14:07:24 INFO - 'tabpaint']}, 14:07:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:07:24 INFO - 'ts_paint', 14:07:24 INFO - 'tpaint', 14:07:24 INFO - 'sessionrestore', 14:07:24 INFO - 'sessionrestore_no_auto_restore', 14:07:24 INFO - 'tabpaint']}, 14:07:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['a11yr', 14:07:24 INFO - 'ts_paint', 14:07:24 INFO - 'tpaint', 14:07:24 INFO - 'sessionrestore', 14:07:24 INFO - 'sessionrestore_no_auto_restore', 14:07:24 INFO - 'tabpaint']}, 14:07:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['a11yr', 14:07:24 INFO - 'ts_paint', 14:07:24 INFO - 'tpaint', 14:07:24 INFO - 'sessionrestore', 14:07:24 INFO - 'sessionrestore_no_auto_restore', 14:07:24 INFO - 'tabpaint']}, 14:07:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['tsvgx', 14:07:24 INFO - 'tsvgr_opacity', 14:07:24 INFO - 'tart', 14:07:24 INFO - 'tscrollx', 14:07:24 INFO - 'cart']}, 14:07:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:24 INFO - 'tsvgr_opacity', 14:07:24 INFO - 'tart', 14:07:24 INFO - 'tscrollx', 14:07:24 INFO - 'cart']}, 14:07:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'talos_options': ['--disable-e10s'], 14:07:24 INFO - 'tests': ['tp5o']}, 14:07:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'tests': ['tp5o']}, 14:07:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'talos_options': ['--disable-e10s', 14:07:24 INFO - '--xperf_path', 14:07:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:24 INFO - 'tests': ['tp5n']}, 14:07:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:24 INFO - 'talos_options': ['--xperf_path', 14:07:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:24 INFO - 'tests': ['tp5n']}}, 14:07:24 INFO - 'talos.zip': {'path': '', 14:07:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:24 INFO - Running post-action listener: _resource_record_post_action 14:07:24 INFO - [mozharness: 2016-10-19 21:07:24.568041Z] Finished populate-webroot step (success) 14:07:24 INFO - [mozharness: 2016-10-19 21:07:24.568148Z] Running create-virtualenv step. 14:07:24 INFO - Running pre-action listener: _resource_record_pre_action 14:07:24 INFO - Running main action method: create_virtualenv 14:07:24 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:24 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 14:07:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:24 INFO - Using real prefix '/tools/python27' 14:07:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:25 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:28 INFO - Installing pip.................done. 14:07:28 INFO - Return code: 0 14:07:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:28 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 14:07:28 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 14:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:28 INFO - 'HOME': '/Users/cltbld', 14:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:28 INFO - 'LOGNAME': 'cltbld', 14:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:28 INFO - 'MOZ_NO_REMOTE': '1', 14:07:28 INFO - 'NO_EM_RESTART': '1', 14:07:28 INFO - 'PAGER': '/bin/cat', 14:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:28 INFO - 'PWD': '/builds/slave/test', 14:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:28 INFO - 'SHELL': '/bin/bash', 14:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:28 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:28 INFO - 'USER': 'cltbld', 14:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:28 INFO - 'XPC_FLAGS': '0x0', 14:07:28 INFO - 'XPC_SERVICE_NAME': '0', 14:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:28 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 14:07:28 INFO - Cleaning up... 14:07:28 INFO - Return code: 0 14:07:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:28 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 14:07:28 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 14:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:28 INFO - 'HOME': '/Users/cltbld', 14:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:28 INFO - 'LOGNAME': 'cltbld', 14:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:28 INFO - 'MOZ_NO_REMOTE': '1', 14:07:28 INFO - 'NO_EM_RESTART': '1', 14:07:28 INFO - 'PAGER': '/bin/cat', 14:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:28 INFO - 'PWD': '/builds/slave/test', 14:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:28 INFO - 'SHELL': '/bin/bash', 14:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:28 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:28 INFO - 'USER': 'cltbld', 14:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:28 INFO - 'XPC_FLAGS': '0x0', 14:07:28 INFO - 'XPC_SERVICE_NAME': '0', 14:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:28 INFO - Downloading/unpacking psutil>=3.1.1 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:31 INFO - Installing collected packages: psutil 14:07:31 INFO - Running setup.py install for psutil 14:07:31 INFO - building 'psutil._psutil_osx' extension 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 INFO - building 'psutil._psutil_posix' extension 14:07:31 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 14:07:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:07:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:07:32 INFO - ^ 14:07:32 INFO - 1 warning generated. 14:07:32 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 14:07:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:32 INFO - Successfully installed psutil 14:07:32 INFO - Cleaning up... 14:07:32 INFO - Return code: 0 14:07:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:32 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:32 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 14:07:32 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 14:07:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:32 INFO - 'HOME': '/Users/cltbld', 14:07:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:32 INFO - 'LOGNAME': 'cltbld', 14:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:32 INFO - 'MOZ_NO_REMOTE': '1', 14:07:32 INFO - 'NO_EM_RESTART': '1', 14:07:32 INFO - 'PAGER': '/bin/cat', 14:07:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:32 INFO - 'PWD': '/builds/slave/test', 14:07:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:32 INFO - 'SHELL': '/bin/bash', 14:07:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:32 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:32 INFO - 'USER': 'cltbld', 14:07:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:32 INFO - 'XPC_FLAGS': '0x0', 14:07:32 INFO - 'XPC_SERVICE_NAME': '0', 14:07:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:07:35 INFO - Installing collected packages: mozsystemmonitor 14:07:35 INFO - Running setup.py install for mozsystemmonitor 14:07:35 INFO - Successfully installed mozsystemmonitor 14:07:35 INFO - Cleaning up... 14:07:35 INFO - Return code: 0 14:07:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:35 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:35 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 14:07:35 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 14:07:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:35 INFO - 'HOME': '/Users/cltbld', 14:07:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:35 INFO - 'LOGNAME': 'cltbld', 14:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:35 INFO - 'MOZ_NO_REMOTE': '1', 14:07:35 INFO - 'NO_EM_RESTART': '1', 14:07:35 INFO - 'PAGER': '/bin/cat', 14:07:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:35 INFO - 'PWD': '/builds/slave/test', 14:07:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:35 INFO - 'SHELL': '/bin/bash', 14:07:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:35 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:35 INFO - 'USER': 'cltbld', 14:07:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:35 INFO - 'XPC_FLAGS': '0x0', 14:07:35 INFO - 'XPC_SERVICE_NAME': '0', 14:07:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:35 INFO - Downloading/unpacking jsonschema==2.5.1 14:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:38 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:38 INFO - warning: no files found matching '*.txt' 14:07:38 INFO - no previously-included directories found matching 'build' 14:07:38 INFO - no previously-included directories found matching 'dist' 14:07:38 INFO - no previously-included directories found matching '.git*' 14:07:38 INFO - Installing collected packages: jsonschema, functools32 14:07:38 INFO - Running setup.py install for functools32 14:07:38 INFO - warning: no files found matching '*.txt' 14:07:38 INFO - no previously-included directories found matching 'build' 14:07:38 INFO - no previously-included directories found matching 'dist' 14:07:38 INFO - no previously-included directories found matching '.git*' 14:07:38 INFO - Successfully installed jsonschema functools32 14:07:38 INFO - Cleaning up... 14:07:38 INFO - Return code: 0 14:07:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:38 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:38 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:07:38 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 functools32==3.2.3-2 14:07:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:38 INFO - 'HOME': '/Users/cltbld', 14:07:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:38 INFO - 'LOGNAME': 'cltbld', 14:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:38 INFO - 'MOZ_NO_REMOTE': '1', 14:07:38 INFO - 'NO_EM_RESTART': '1', 14:07:38 INFO - 'PAGER': '/bin/cat', 14:07:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:38 INFO - 'PWD': '/builds/slave/test', 14:07:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:38 INFO - 'SHELL': '/bin/bash', 14:07:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:38 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:38 INFO - 'USER': 'cltbld', 14:07:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:38 INFO - 'XPC_FLAGS': '0x0', 14:07:38 INFO - 'XPC_SERVICE_NAME': '0', 14:07:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:07:39 INFO - Cleaning up... 14:07:39 INFO - Return code: 0 14:07:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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', '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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:07: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 blobuploader==1.2.4 14:07:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:39 INFO - 'HOME': '/Users/cltbld', 14:07:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:39 INFO - 'LOGNAME': 'cltbld', 14:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:39 INFO - 'MOZ_NO_REMOTE': '1', 14:07:39 INFO - 'NO_EM_RESTART': '1', 14:07:39 INFO - 'PAGER': '/bin/cat', 14:07:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:39 INFO - 'PWD': '/builds/slave/test', 14:07:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:39 INFO - 'SHELL': '/bin/bash', 14:07:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:39 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:39 INFO - 'USER': 'cltbld', 14:07:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:39 INFO - 'XPC_FLAGS': '0x0', 14:07:39 INFO - 'XPC_SERVICE_NAME': '0', 14:07:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:39 INFO - Downloading/unpacking blobuploader==1.2.4 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:41 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:42 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 14:07:42 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 14:07:42 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 14:07:42 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 14:07:42 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 14:07:42 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 14:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:07:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:42 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 14:07:42 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 14:07:42 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 14:07:42 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 14:07:42 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 14:07:42 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 14:07:43 INFO - Downloading docopt-0.6.1.tar.gz 14:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:43 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:43 INFO - Running setup.py install for blobuploader 14:07:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:07:43 INFO - Running setup.py install for requests 14:07:43 INFO - Running setup.py install for docopt 14:07:44 INFO - Successfully installed blobuploader requests docopt 14:07:44 INFO - Cleaning up... 14:07:44 INFO - Return code: 0 14:07:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:44 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:44 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:44 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:44 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 14:07:44 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 14:07:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:44 INFO - 'HOME': '/Users/cltbld', 14:07:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:44 INFO - 'LOGNAME': 'cltbld', 14:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:44 INFO - 'MOZ_NO_REMOTE': '1', 14:07:44 INFO - 'NO_EM_RESTART': '1', 14:07:44 INFO - 'PAGER': '/bin/cat', 14:07:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:44 INFO - 'PWD': '/builds/slave/test', 14:07:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:44 INFO - 'SHELL': '/bin/bash', 14:07:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:44 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:44 INFO - 'USER': 'cltbld', 14:07:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:44 INFO - 'XPC_FLAGS': '0x0', 14:07:44 INFO - 'XPC_SERVICE_NAME': '0', 14:07:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wFphNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WMewfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-b0c4fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-tf6Srx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rsoZWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zqSnoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7Oq_Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-O6NdyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-RWnv9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-oRnR6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VPiQ5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-4t32FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-p19Ti0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-U1PRHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-amVMuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-m3b83Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AufQ2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:46 INFO - Running setup.py install for manifestparser 14:07:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:07:46 INFO - Running setup.py install for mozcrash 14:07:46 INFO - Running setup.py install for mozdebug 14:07:46 INFO - Running setup.py install for mozdevice 14:07:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:07:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:07:46 INFO - Running setup.py install for mozfile 14:07:46 INFO - Running setup.py install for mozhttpd 14:07:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Running setup.py install for mozinfo 14:07:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Running setup.py install for mozInstall 14:07:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Running setup.py install for mozleak 14:07:47 INFO - Running setup.py install for mozlog 14:07:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Running setup.py install for moznetwork 14:07:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:07:47 INFO - Running setup.py install for mozprocess 14:07:47 INFO - Running setup.py install for mozprofile 14:07:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:07:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:07:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:07:48 INFO - Running setup.py install for mozrunner 14:07:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:07:48 INFO - Running setup.py install for mozscreenshot 14:07:48 INFO - Running setup.py install for moztest 14:07:48 INFO - Running setup.py install for mozversion 14:07:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:07:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:48 INFO - Cleaning up... 14:07:48 INFO - Return code: 0 14:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:48 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:48 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 14:07:48 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 14:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:48 INFO - 'HOME': '/Users/cltbld', 14:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:48 INFO - 'LOGNAME': 'cltbld', 14:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:48 INFO - 'MOZ_NO_REMOTE': '1', 14:07:48 INFO - 'NO_EM_RESTART': '1', 14:07:48 INFO - 'PAGER': '/bin/cat', 14:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:48 INFO - 'PWD': '/builds/slave/test', 14:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:48 INFO - 'SHELL': '/bin/bash', 14:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:48 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:48 INFO - 'USER': 'cltbld', 14:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:48 INFO - 'XPC_FLAGS': '0x0', 14:07:48 INFO - 'XPC_SERVICE_NAME': '0', 14:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:07:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-qa2YcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-8g8tLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Ob8Byb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-vYyaKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-IGpOdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-pz6twn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-yCVh66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WvHSUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-XAXn_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:07:49 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)) 14:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:07:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZOdKaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 14:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:07:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-dtAapg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:07:50 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)) 14:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:07:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-GClty9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:07:50 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)) 14:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:07:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gngBbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:07:50 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)) 14:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:07:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-xfzYEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:07:50 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)) 14:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-uSSAuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:07:50 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)) 14:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:07:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-nYir18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:07:50 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)) 14:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:07:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-hbsWL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:07:50 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)) 14:07:50 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)) 14:07:50 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)) 14:07:50 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)) 14:07:50 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)) 14:07:50 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)) 14:07:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:53 INFO - Downloading blessings-1.6.tar.gz 14:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:53 INFO - Installing collected packages: blessings 14:07:53 INFO - Running setup.py install for blessings 14:07:53 INFO - Successfully installed blessings 14:07:53 INFO - Cleaning up... 14:07:53 INFO - Return code: 0 14:07:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:53 INFO - Reading from file tmpfile_stdout 14:07:53 INFO - Current package versions: 14:07:53 INFO - blessings == 1.6 14:07:53 INFO - blobuploader == 1.2.4 14:07:53 INFO - docopt == 0.6.1 14:07:53 INFO - functools32 == 3.2.3-2 14:07:53 INFO - jsonschema == 2.5.1 14:07:53 INFO - manifestparser == 1.1 14:07:53 INFO - mozInstall == 1.12 14:07:53 INFO - mozcrash == 0.17 14:07:53 INFO - mozdebug == 0.1 14:07:53 INFO - mozdevice == 0.48 14:07:53 INFO - mozfile == 1.2 14:07:53 INFO - mozhttpd == 0.7 14:07:53 INFO - mozinfo == 0.9 14:07:53 INFO - mozleak == 0.1 14:07:53 INFO - mozlog == 3.4 14:07:53 INFO - moznetwork == 0.27 14:07:53 INFO - mozprocess == 0.23 14:07:53 INFO - mozprofile == 0.28 14:07:53 INFO - mozrunner == 6.12 14:07:53 INFO - mozscreenshot == 0.1 14:07:53 INFO - mozsystemmonitor == 0.3 14:07:53 INFO - moztest == 0.7 14:07:53 INFO - mozversion == 1.4 14:07:53 INFO - psutil == 3.1.1 14:07:53 INFO - requests == 1.2.3 14:07:53 INFO - wsgiref == 0.1.2 14:07:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:07:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:53 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:53 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 14:07:53 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 14:07:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:53 INFO - 'HOME': '/Users/cltbld', 14:07:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:53 INFO - 'LOGNAME': 'cltbld', 14:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:53 INFO - 'MOZ_NO_REMOTE': '1', 14:07:53 INFO - 'NO_EM_RESTART': '1', 14:07:53 INFO - 'PAGER': '/bin/cat', 14:07:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:53 INFO - 'PWD': '/builds/slave/test', 14:07:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:53 INFO - 'SHELL': '/bin/bash', 14:07:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:53 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:53 INFO - 'USER': 'cltbld', 14:07:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:53 INFO - 'XPC_FLAGS': '0x0', 14:07:53 INFO - 'XPC_SERVICE_NAME': '0', 14:07:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 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)) 14:07:54 INFO - Cleaning up... 14:07:54 INFO - Return code: 0 14:07:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:54 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 0x10a8be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a834570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffefad51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, '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.rJCdkAPjrn/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.00e1kFQEOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 14:07:54 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 14:07:54 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 14:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:54 INFO - 'HOME': '/Users/cltbld', 14:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:54 INFO - 'LOGNAME': 'cltbld', 14:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:54 INFO - 'MOZ_NO_REMOTE': '1', 14:07:54 INFO - 'NO_EM_RESTART': '1', 14:07:54 INFO - 'PAGER': '/bin/cat', 14:07:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:54 INFO - 'PWD': '/builds/slave/test', 14:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:54 INFO - 'SHELL': '/bin/bash', 14:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:07:54 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:54 INFO - 'USER': 'cltbld', 14:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:54 INFO - 'XPC_FLAGS': '0x0', 14:07:54 INFO - 'XPC_SERVICE_NAME': '0', 14:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:07:54 INFO - Cleaning up... 14:07:54 INFO - Return code: 0 14:07:54 INFO - Running post-action listener: _resource_record_post_action 14:07:54 INFO - Running post-action listener: _start_resource_monitoring 14:07:54 INFO - Starting resource monitoring. 14:07:54 INFO - [mozharness: 2016-10-19 21:07:54.504137Z] Finished create-virtualenv step (success) 14:07:54 INFO - [mozharness: 2016-10-19 21:07:54.505130Z] Running install step. 14:07:54 INFO - Running pre-action listener: _resource_record_pre_action 14:07:54 INFO - Running main action method: install 14:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:54 INFO - Reading from file tmpfile_stdout 14:07:54 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:54 INFO - Reading from file tmpfile_stdout 14:07:54 INFO - Output received: 14:07:54 INFO - Usage: mozinstall [options] installer 14:07:54 INFO - Options: 14:07:54 INFO - -h, --help show this help message and exit 14:07:54 INFO - -d DEST, --destination=DEST 14:07:54 INFO - Directory to install application into. [default: 14:07:54 INFO - "/builds/slave/test"] 14:07:54 INFO - --app=APP Application being installed. [default: firefox] 14:07:54 INFO - mkdir: /builds/slave/test/build/application 14:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:08:27 INFO - Reading from file tmpfile_stdout 14:08:27 INFO - Output received: 14:08:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:08:27 INFO - Running post-action listener: _resource_record_post_action 14:08:27 INFO - [mozharness: 2016-10-19 21:08:27.650759Z] Finished install step (success) 14:08:27 INFO - [mozharness: 2016-10-19 21:08:27.650928Z] Running run-tests step. 14:08:27 INFO - Running pre-action listener: _resource_record_pre_action 14:08:27 INFO - Running main action method: run_tests 14:08:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:08:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:08:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:08:27 INFO - 2016-10-19 14:08:27.665 screenresolution[1919:24689] starting screenresolution argv=screenresolution get 14:08:27 INFO - 2016-10-19 14:08:27.667 screenresolution[1919:24689] Display 0: 1600x1200x32@60 14:08:27 INFO - 2016-10-19 14:08:27.673 screenresolution[1920:24691] starting screenresolution argv=screenresolution list 14:08:27 INFO - Available Modes on Display 0 14:08:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:08:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:08:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:08:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:08:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:08:27 INFO - Intel Iris: 14:08:27 INFO - Chipset Model: Intel Iris 14:08:27 INFO - Type: GPU 14:08:27 INFO - Bus: Built-In 14:08:27 INFO - VRAM (Dynamic, Max): 1536 MB 14:08:27 INFO - Vendor: Intel (0x8086) 14:08:27 INFO - Device ID: 0x0a2e 14:08:27 INFO - Revision ID: 0x0009 14:08:27 INFO - Displays: 14:08:27 INFO - Display: 14:08:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:08:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:08:27 INFO - Display Serial Number: 1600x1200 60 14:08:27 INFO - Main Display: Yes 14:08:27 INFO - Mirror: Off 14:08:27 INFO - Online: Yes 14:08:27 INFO - Rotation: Supported 14:08:27 INFO - Return code: 0 14:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:27 INFO - Python 2.7.3 14:08:27 INFO - Return code: 0 14:08:27 INFO - grabbing minidump binary from tooltool 14:08:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:27 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 0x10a6d2d30>, '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 0x10a538db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6cab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:27 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 14:08:27 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 14:08:27 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 14:08:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:28 INFO - Return code: 0 14:08:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:08:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:08:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rJCdkAPjrn/Render', 14:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:28 INFO - 'HOME': '/Users/cltbld', 14:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:28 INFO - 'LOGNAME': 'cltbld', 14:08:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:28 INFO - 'MOZ_NO_REMOTE': '1', 14:08:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:28 INFO - 'NO_EM_RESTART': '1', 14:08:28 INFO - 'PAGER': '/bin/cat', 14:08:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:28 INFO - 'PWD': '/builds/slave/test', 14:08:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:28 INFO - 'SHELL': '/bin/bash', 14:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00e1kFQEOr/Listeners', 14:08:28 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 14:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:28 INFO - 'USER': 'cltbld', 14:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:28 INFO - 'XPC_FLAGS': '0x0', 14:08:28 INFO - 'XPC_SERVICE_NAME': '0', 14:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:08:28 INFO - mozversion application_buildid: 20161019122722 14:08:28 INFO - mozversion application_changeset: 49dfb63c28b9c093f13391b999de40b01f125613 14:08:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:08:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:28 INFO - mozversion application_name: Firefox 14:08:28 INFO - mozversion application_remotingname: firefox-dev 14:08:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:08:28 INFO - mozversion application_vendor: Mozilla 14:08:28 INFO - mozversion application_version: 51.0a2 14:08:28 INFO - mozversion platform_buildid: 20161019122722 14:08:28 INFO - mozversion platform_changeset: 49dfb63c28b9c093f13391b999de40b01f125613 14:08:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:08:28 INFO - mozversion platform_version: 51.0a2 14:08:28 INFO - using testdate: 1476911308 14:08:28 INFO - actual date: 1476911308 14:08:28 INFO - starting webserver on 'localhost:53137' 14:08:28 INFO - SUITE-START | Running 2 tests 14:08:28 INFO - TEST-START | dromaeo_css 14:08:28 INFO - operating with platform_type : mac_ 14:08:28 INFO - Initialising browser for dromaeo_css test... 14:08:28 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmptY7Qlo/profile http://localhost:53137/getInfo.html) 14:08:30 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 14:08:30 INFO - PROCESS | 1930 | colorDepth:24 14:08:30 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 14:08:30 INFO - PROCESS | 1930 | __metrics 14:08:30 INFO - PROCESS | 1930 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:08:30 INFO - PROCESS | 1930 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:31 INFO - TEST-INFO | 1930: exit 0 14:08:31 INFO - Browser initialized. 14:08:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:31 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmptY7Qlo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:43 INFO - PROCESS | 1932 | RSS: Main: 219119616 14:08:43 INFO - PROCESS | 1932 | 14:09:35 INFO - PROCESS | 1932 | 1476911375292 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] 14:11:46 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53137/tests/dromaeo/cssquery-ext.html) 14:11:47 INFO - PROCESS | 1932 | RSS: Main: 366292992 14:11:47 INFO - PROCESS | 1932 | 14:14:50 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-ext.html (next: http://localhost:53137/tests/dromaeo/cssquery-jquery.html) 14:14:51 INFO - PROCESS | 1932 | RSS: Main: 351019008 14:14:51 INFO - PROCESS | 1932 | 14:17:53 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53137/tests/dromaeo/cssquery-mootools.html) 14:17:54 INFO - PROCESS | 1932 | RSS: Main: 316284928 14:17:54 INFO - PROCESS | 1932 | 14:20:56 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53137/tests/dromaeo/cssquery-prototype.html) 14:20:57 INFO - PROCESS | 1932 | RSS: Main: 324804608 14:20:57 INFO - PROCESS | 1932 | 14:24:00 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53137/tests/dromaeo/cssquery-yui.html) 14:24:01 INFO - PROCESS | 1932 | RSS: Main: 310575104 14:24:01 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-yui.html (next: http://localhost:53137/tests/dromaeo/cssquery-dojo.html) 14:27:04 INFO - PROCESS | 1932 | RSS: Main: 613855232 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | __start_tp_report 14:27:04 INFO - PROCESS | 1932 | _x_x_mozilla_page_load 14:27:04 INFO - PROCESS | 1932 | _x_x_mozilla_page_load_details 14:27:04 INFO - PROCESS | 1932 | |i|pagename|runs| 14:27:04 INFO - PROCESS | 1932 | |0;dojo.html;2888.2923683697495;3307.470804671253;3342.6323104458506;3368.141124013376;3389.4237979543477;5152.252923326116;5482.698451585161;5693.914591281134;5777.075667893133;5842.1820945067675;5719.14212868069;5800.883982320351;5815.941840581593;5836.737346819393;5856.063029915214;5238.214267859814;5246.0032593807055;5251.212318152288;5253.553447956909;5321.733913304339;5159.638825282232;5208.270842082112;5209.244659524366;5356.651817631861;5361.705106219157;5256.8685782855355;5265.789368425278;5283.154695248761;5287.39194992575;5291.365036195662;5278.47215278473;5287.920681189786;5310.468953104659;5325.334333208349;5329.653572517774;5126.666766660155;5169.172932330846;5234.528892399702;5265.736713164327;5278.815241466568;5663.207150998864;5707.229524014247;5741.741621627037;5750.88498230033;5774.942250577525;6051.0923361496125;6093.146959425684;6121.816345509642;6132.754689812402;6135.263768347827;6064.818055458343;6145.969270153665;6160.84597885052;6164.198654174974;6177.3822617738315;5665.49010589049;5764.596478246483;5776.191333213354;5804.361520232771;5897.764089436418;5260.500252476085;6233.501319894398;6248.062790581449;6251.843703907439;6281.214848143982;6106.358832322631;6111.877762444727;6113.20528331323;6135.509159267248;6155.138280640714;6065.757369705162;6090.69546522681;6125.9087146859765;6134.8159555213415;6141.7543298267565;6053.636781793019;6122.448979591858;6135.477655820289;6140.846478837975;6141.969290153521;6108.847278818065;6109.572329936951;6115.936978868578;6125.052321061979;6128.383804625999;4909.705417674951;4920.40955085392;4932.136876046678;4935.925961110586;4947.084789313988;4380.934285985649;4406.779661016936;4424.977875110668;4429.335599660077;4493.730376177375;5864.882702345929;5905.46850783423;5920.200772895604;5945.851353716192;5965.313988891333;6150.938490615126;6157.384261573807;6188.44304012641;6204.565680402328;6205.100260462208;5648.378678345379;5740.425957404226;5833.183354330397;5880.676562789002;5881.32364778056;5354.089804733127;5411.2153737708595;5435.320584926884;5439.700816455133;5446.482584154499;6292.2134733158355;6304.432601065926;6328.651924144032;6334.429901308904;6338.683065846689;6129.601575897553;6169.352218017044;6210.627362358273;6217.09852071438;6217.409346112112;6160.845978850385;6167.013277875519;6212.285587157535;6250.49996000328;6298.275698294755;6131.7501724086305;6151.708141290379;6156.846078848064;6168.444839964424;6188.535859810442;6171.105189747372;6172.506199504119;6182.629042257479;6201.069839524108;6210.5652604317265;5936.821895343147;6021.187139736255;6068.575199736153;6099.054646529795;6149.108379284889;6096.969515152396;6124.014786914997;6129.572745043149;6135.93706321624;6146.108814222002;4784.904301913873;6044.24446944132;6050.5764596479585;6065.332813390435;6068.120122582289;5932.762689492372;6037.577369584087;6110.052941794029;6114.755409783559;6139.6009259398;5945.3757355477055;5956.76172953077;5967.1049342597225;5976.402359763989;6024.8795024100145 14:27:04 INFO - PROCESS | 1932 | |1;ext.html;463.9628829693623;467.0239200071849;505.07571144805013;518.2278405176286;528.994909671624;30279.697203027965;40328.59671403289;41366;41522.37716434256;41552.792236038855;42785;42936.78531607345;43012.354814677805;43088.56911430885;43106.56893431065;9805.95097024514;10003.549840257207;10006.59973601055;10007.29948903577;10015.399076055424;8850.601722922484;9042.095790420972;9053.094690530927;9183.311251656152;9197.494137822418;11975.041996640248;12247.938760306231;12257;12431.502739890393;12436.564720234794;12258.387080645976;12350.44423000967;12367.62897113088;12375.381230938507;12382.93808530956;12078.879211207863;12151.696207594792;12190;12190.024798016137;12192.57325993586;33358.49962250568;40119.7994010031;40474.39288410676;40517.39223911644;40535.39196912049;3257.625373082102;3273.067175854894;3429.3484237994703;3548.9530588476205;3709.7403181777286;28130.859345703346;29189.41621167565;29195.85402072976;30301;30495.542566861513;3114.205877501223;3133.2166958260436;3212.903612891617;3260.8858689945737;3327.101682545723;501272;501881;502101;502658;507692;56823.71588142033;57777;57797.13304300439;57799;58004.419955800746;61096.38903610907;61222;61275.08087378693;61275.69362153161;61470.38529614736;16613.750793738105;16833.158342082847;16855.157242137844;16880.324787008383;16902.985820850787;13080.018998575146;13082.018848586395;13103.279319637511;13124.015698822626;13158.934205328913;13611.591652250449;13889.513867014606;13890.93054534741;14800.555983320517;14986.925065374604;5999.610025348426;6141.263048434216;6163.876722465615;6175.166352542439;6198.6280823150755;808.3937047214589;895.471671713679;898.4878619187001;910.6858133943779;1051.1013083813382;28106;28964;29410;30100.84949575238;30109.096727098222;976.4385478349977;1017.3031473440717;1050.0969166516788;1066.8719753629614;1138.7722455508765;15352.462663806713;15391.922565420313;15410;15598.688026239412;15653.139077350626;669497;679106;682422;682899;686913;49579.75210123998;50322;50401;53073.93852122936;53091.01817363636;1217.598192596441;1295.0675513630172;1309.6005718256024;1333.993330033363;1336.2650542201945;29810.552841707824;30838.229044273176;30838.537421939138;31816.681833182298;32058;55795;56240;56286;56385.71807140938;56509.71745141248;519416.402917983;617044;617166;618149;657494;19129;23618.700971446735;23903.88048059818;23936.88031559831;23975.76024239735;45171.548284516735;45360.86597834949;45490.77254613706;45757;45977.77011115057;37753.43369849509;38119;40872.79563602163;41106.588934110274;41341.7040715398;38507.61492385152;38789.80352725096;39183.80408097941;39399.60600394074;39807.40288895611;37556.248875022895;38077;38351;38421.847344579706;38541.80729096449;32750.50874236936;33857.83071084629;33981.15047123842;34763;34889.47665785066;25366.209716930753;25439.10963116282;25533.61699574545;25800.741992579835;26140.8692956534 14:27:04 INFO - PROCESS | 1932 | |2;jquery.html;304.89938320354287;323.237160301688;365.5795834789991;374.9737518373713;400.6214127649371;14970.850291497081;15065.849341506582;20009.89995050023;20234.89882550587;21307.25424610139;19687.310944116958;20091.59816803663;20125.29561465349;20166;20342.186312547517;5805.419458054193;5999.070144127667;6052.334243233241;6069;6075.088736689488;4651.7441540715245;5929.970350148244;5984.910226346608;5989.9517584422765;6044.939550604482;6021.157038014681;6025.15647809307;6028.63828170309;6037.30570984338;6048.637081775086;5738.885222295552;5888.882222355572;5934.1692163097205;5942.435468630473;6027.63834169949;5144.485551444825;5145.794168233266;5151.793928242866;5154.716490593053;5156.8968620627375;23941.880290598434;24807.379815504577;24879.751202487925;24906.875465622736;25068.87190076451;2260.2654137405243;2361.3270217987792;2417.721961974378;3080.5071188609713;3226.3869864725625;9858.211343092535;10361;10368.481575921174;10465.476726163737;14638;1760.2870837310782;1877.9389396454892;1904.238304678126;1910.751602291707;1927.3158028899818;128183.35908320492;129961;131998;133286.6671333284;133608;11186.608468703556;11329.886701133048;11483.942580287045;11497;11565.479553420117;14449.711005779825;14464.783028254584;14471.131732096108;14493.492727754689;14501.129932204101;8501.574921253912;8634.56827158652;8670.393072484865;8676.913230867736;8765.386422950332;8653.221210091122;8657.610407531676;8667.653293868301;8834.95582522096;8853.468791872509;4491.438570178728;4504.414426124583;4506.571875671806;4514.367988481616;4591.242444996538;1496.8203815541988;1718.0454495684899;1760.6214663847334;1886.3869242496244;1917.2426891378107;698.2982102986567;699.8180473077036;738.8780851159498;750.7935317787652;1052.4842827014709;19812.60374792496;20389.694154587694;22130.557388852456;22977.770222297564;23085.422864428187;880.2693764175718;888.3870129610548;894.6153154143781;896.188949001155;927.3276874266103;10710;11348.31910085381;11401.543938242543;11440.94279528597;11444.828327575093;611079;623191;637102;660049.297781601;660182;88663.55668221747;130569.34715326552;132462;137597.3120134413;144603;955.9761005974906;956.93779904306;987.3434166279487;988.0218583602326;1028.4343611013762;18175.545611359823;19044.047797610343;19512.31706890252;19681.803181967996;19720.40838774839;54879;56798;57090.42909570851;57335;58332.12501812561;80107;81891.5905420469;84372.57813710893;84598.57700711457;85804.57097714471;7920.317052570583;7931.246531579491;7939.245771651684;8141.43009989295;8173;8743.562821859008;12709.745805083661;12856.55002074923;13028;13207.009474289274;8701.564921754014;11157.609483668033;11288.661340159808;11344.489497972447;11451.59919402817;9028.458292502472;9420.963693993792;10963.287386319864;11030.944845275722;11080.5567777288;5716.114002329479;6098.786542470993;11015.669529914116;11305.943470282597;11708.590199342982;7986.600669966595;8035.718749843727;8040.67837286502;8187;8234.094249632655;9410.717678469657;9941.552630131517;10645.361278323326;11251.099912007183;11424 14:27:04 INFO - PROCESS | 1932 | |3;mootools.html;1500.0999400359783;1507.0580886945659;1719.982800171998;1858.897760623167;1900.6103748731512;7972.681092756297;8213.342932565396;8435.957820210899;9039.683611073613;9045.728628141158;8130.471519351238;8590.140985901407;8772.69295574655;8773.078826723198;8949.865752013726;2363.9763602363973;2391.079434417753;2395.125779090628;2398.9040438382444;2400.7119145702454;2082.4689704125503;2172.1094351315965;2358.929232123039;2374.857508549484;2412.2039726890084;2227.7103976483036;2303.9884800575974;2310.341552657493;2314.456102815837;2319.489712263299;1877.2584828992472;1906.6282074995381;2207.8896055197174;2224.0325458425555;2242.1031587365023;2385.5348207099623;2386.5226954609147;2390.748971358;2396.341006223285;2396.4607963208314;8927.37508374414;9047.140521650434;9050.185483306534;9073.954630226872;9079.773005674844;5258.474152584711;5327.30745003151;5441.428649991773;5451.890962180734;5454.890902181974;3548.077499850032;3670.229251857113;3725.105974566112;3726.441033844918;3742.083189618561;1073.1629329123296;1087.3801932898252;1097.3799803111297;1121.0919155484003;1126.9718257043558;11904.702382440422;11939.820902686466;11945.462454189583;11947.163698541019;11979;4549.45406551216;4587.220172570671;4828.155072862235;4845.5881250094135;4889.755512224375;10143.64497242593;10152.593896244216;10152.644657436955;10155.289129760993;10155.898441015643;5398.1632846908005;5398.865028374244;5399.325084364455;5400.21696853954;5402.8919421611345;4750.904981900412;4886.877828054327;4895.31465594817;4928.334674818925;4942.678725882806;3839.577646458887;3861.6717579005535;3872.0900588361715;3878.6121387861554;3918.5101862267215;1111.8165502692127;1128.6444769897455;1183.6389901080254;1184.1000839362148;1188.2276520261726;635.9268684101295;721.8592374486925;734.4161391693616;760.3081196111511;918.9982918618738;4999.375078115236;5549.861253468614;5621.4659607337235;5805.042168042226;5892.351841297454;860.5697151424288;869.5261082709939;892.2237653241722;960.1694534227983;977.2133432586836;3724.6089160638285;3786.8674596388996;3836.5971572984995;3881.2819628368843;3967.861124860616;10434.37393756377;10941.890581094247;10949.397783121845;10949.507272172772;10957.01386875185;10915.836262456069;10920.017198452177;10925.125989920945;10930.672079837617;10948.34309941406;7839.608019598997;8146.30756385702;8259.174082591693;8413;8451;5998.550108741949;6068.544859135494;6084.178635884276;6109.022556390956;6148.938510615016;10007.999200080225;10240.743981400525;10253.58985640566;10257.794844103226;10258.487075646337;8577.95711021441;9311.627534898798;9317.580708867981;10033.247506436901;10265.58937642486;7523.924760752322;7624.466287359832;7681.116671582839;7698.461107722405;7708.730194443167;7872.645730942007;7984.121746607984;8043.436959412785;8049.557274349967;8057.274845263954;7232.493725439169;7397.630118493946;7577.1665116836;7604.353629941295;7650.579218142833;7349.118105827335;7444.441666875115;7467.141278752796;7475.514091584029;7491.026166598307;6987.965060174666;7093.255208203271;7116.359527642537;7121.715131394686;7132;4837.879053023703;4895.559399654048;4929.901401971869;4950.2079667253065;4991.57571606403;4520.819167233405;4833.830815921567;4901.215805471107;4982.078315511642;5089.312942752681 14:27:04 INFO - PROCESS | 1932 | |4;prototype.html;300.586693296717;302.5205049995758;308.15719008511724;311.49071268476035;317.2275509135254;4238.067625122476;4485.32720091986;5308.336457942757;5332.840014799553;5394.622376433651;4195.685323600735;4995.425526064504;5162.716050617215;5201.323827902377;5296.311479507668;3912.8826135215845;4012.458318127059;4012.7391719538136;4024.9736317239062;4040.6565441937323;4082.5711001149657;4088.8364465421346;4105.958940410603;4115.60069576344;4146.232946904817;3718.646728560796;3944.664703500206;4055.918881622366;4056.574059723731;4075.32757095079;3323.418401779691;3347.364000839857;3818.522684664417;4034.657054150386;4038.2125485530332;3063.632364116298;3192.728618067467;3359.8744420619123;3473.426884564044;3498.6676265754713;4008.478897743304;4168.853565269545;5092.872678183075;5210.505002024802;5213.504717051874;4261.6590672746415;4560.247559152735;4568.474625418086;4579.564941330568;4602.286645569909;4375.584319489643;5480.177973303997;5568.359638641527;5580.246666700024;5598.804041858515;3803.505544279226;3811.6188381161937;3824.9808750956067;3827.1771569112775;3827.3876179811095;5318.877869651013;5489.862753431156;5605.635633683838;5879.970600147015;5922.06857605488;3614.1868079681863;3686.9078273043388;3841.4237864320576;3851.2297540491454;3859.4755071746504;3450;3679.7976111314133;3956.9802150989062;3970.7220494565104;3983.6016398359934;3771.830267637963;4419.558044195619;4492;4644.676267263813;4746;4634.513376095461;5559.33288005442;5622.606417550814;5630.4369563043365;5637.436256374412;1266.2339284732789;1309.428685577311;1334.5329134802935;1342.7515909556569;1345.4349173347218;840.0255703384045;866.1901122450529;871.329076611006;893.4371346051946;908.3323757038571;4481.932771008437;4938.851834444972;5138.100832354323;5189.42916279209;5246.7638956247065;4869.440014398389;5113.233015047698;5549.500544950974;5747.137929310553;5812.447817457335;5121.590272778169;5140.917928238994;5218.791248350023;5266.526012658879;5276.4911333963255;2257.4807794207422;2553.578659521158;2882.942341153165;2958.05342290465;3000.369922316338;5171.81898633546;5628.352739434936;5878.676672782953;5892.381299963527;5909.881802364014;4940.481249468826;5635.830925072254;5987.401259874065;6000.459958603659;6038.30559485656;5287.656302340259;5829.269267668696;6005.819825405245;6048.637081775108;6183.423227077066;5308.840734777963;5612.102063669793;5804.535637148933;5869.413058694096;5933.436323549256;4299.9355009674255;4998.525140111684;5017.974910125572;5729.656220626775;5765.221695071112;4936.75316234194;5459.508644222039;5546.389897111234;6044.274687037408;6078.331383547895;3068.5090385538206;3867.400552914303;3889.319369110451;3889.86385476507;3892.57181710006;4941.901161976669;5743.483086522233;5750.5112065474905;5759.444949863597;5812.622179558315;5225.294585230945;5308.018016666929;5620;5673.432656734293;5703.828885133453;4958.785097651099;5002.499750024968;5307.681539107666;5561.8609534760335;5650.463205995424;4350.477942646902;4360.520342762357;5452.7546260417585;5489.64317319373;5505.660094459919;5132.486751324837;5461.603409255587;5466.72666366688;5526.22632831412;5535.750891209986;4657.441107067174;5546.72266386671;5588.469095435927;5593.244911936837;5594.4125866785025 14:27:04 INFO - PROCESS | 1932 | |5;yui.html;685.6229074009294;689.4484412470024;732.3701616609711;732.5092188233883;774.2373761844582;14509.201993890332;15461.613459663515;15696.293666785008;15697.29362178702;15722.213889305533;14123.717525649481;14169.78745318821;14310.21293828839;14322.283885805695;14343.497977570787;673.8955461903413;689.8171984424132;690.7444245629124;823.9217274358926;832.6211573733937;829.5686243153557;832.4256263178388;836.5148214035875;836.8995720513517;843.9578021098952;899.6446403670546;900.7477906186245;901.0583939782942;902.3503077783985;902.4449963272606;897.9942464439804;900.2707806676613;900.3067637918831;902.3097330542108;903.9231665308457;524.8005757812007;544.0452006728207;553.4493179286595;649.7758273395671;662.734906037584;12538.435770390355;12542.24746515212;12545.12184147101;12578.622641320775;12605.93697031518;13807.240601766898;14110.788338174936;14236.644083897882;14376.35306411214;14392.352344144434;12414.841028255545;12531.498740050387;12616.747665046647;13083.149595276276;13570.45718171272;4490.910181796378;4511.548845115462;4632.420947381577;4803.471618122004;4814.374131362935;124152;128961.35519322437;129039;129332.3533382327;130467.6953230465;10844.240903136862;11134.443277836075;11214.55141794319;11239.157063220291;11421.828672569918;22526.54946901053;22620.434489137573;22773.202937897095;22828.771712282996;23294.65058024131;7927.801804954807;7982.201779822088;8005.559694216874;8016.398770092266;8050.27547520726;4269.402283680287;4299.658128127657;4450.287953927356;4513.119941611354;4620.745858977789;3256.413845507784;3278.4098862205033;3315.8507867145554;3340.315235376742;3363.899083027513;539.9217113518596;548.3392512023003;607.5261296188979;642.5887432043496;665.4809248785955;524.6930545630848;545.1414022913926;597.2593983460478;604.4590091867753;608.8295277322356;8943.23982461498;8966.730998070068;9031.548422578844;9116.726498205064;9126.589303481227;595.5860676829562;605.7213681706464;622.2595111817013;632.3298390523018;647.9449246813979;4226.767527786002;4464.1071785643;4480.529544397857;4485.866040701073;4565.748883811422;169207.1539642294;171535;171827;173871;174001.12999435174;138223;143802;146593;150159;151703;82339;82482;83012;104221;113017.43491282492;9458.959514453267;9918.40489570628;10040.64857729976;10096.040876116756;10194.337368071052;60439.69780151071;60543;63182.15680294306;65070.34929650832;67753.66123169352;44182.33726494041;67459.66270168617;83824;87480;96932.0306796923;12474.75050499003;12619.74760504803;13041.934790325988;13244.801327979896;13545;13985.790213146607;14270;15041.924790375979;15710.214489275262;15886.285117169524;13112.344382781013;13461.394237259543;13590.048696591144;14550.054246473945;14721.116732996055;13232.206067635587;13349.265790381234;14245.358958847084;14368.353424095732;14551.85448145505;10635.361878287327;13984.230867302396;14301.070430421989;14312.427502899767;14444.711105777615;10609.628662996758;11450.141239406912;11571.594994175164;11641.73436859839;12152.513899443924;10020.546548130129;10391.518841188286;11252.381119038531;11632;11658.6502404928 14:27:04 INFO - PROCESS | 1932 | __end_tp_report 14:27:04 INFO - PROCESS | 1932 | __start_cc_report 14:27:04 INFO - PROCESS | 1932 | _x_x_mozilla_cycle_collect,1430 14:27:04 INFO - PROCESS | 1932 | __end_cc_report 14:27:04 INFO - PROCESS | 1932 | __startTimestamp1476912424791__endTimestamp 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | ------- Summary: start ------- 14:27:04 INFO - PROCESS | 1932 | Number of tests: 6 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | [#0] dojo.html Cycles:165 Average:5728.21 Median:5976.40 stddev:632.61 (10.6%) stddev-sans-first:594.03 14:27:04 INFO - PROCESS | 1932 | Values: 2888.3 3307.5 3342.6 3368.1 3389.4 5152.3 5482.7 5693.9 5777.1 5842.2 5719.1 5800.9 5815.9 5836.7 5856.1 5238.2 5246.0 5251.2 5253.6 5321.7 5159.6 5208.3 5209.2 5356.7 5361.7 5256.9 5265.8 5283.2 5287.4 5291.4 5278.5 5287.9 5310.5 5325.3 5329.7 5126.7 5169.2 5234.5 5265.7 5278.8 5663.2 5707.2 5741.7 5750.9 5774.9 6051.1 6093.1 6121.8 6132.8 6135.3 6064.8 6146.0 6160.8 6164.2 6177.4 5665.5 5764.6 5776.2 5804.4 5897.8 5260.5 6233.5 6248.1 6251.8 6281.2 6106.4 6111.9 6113.2 6135.5 6155.1 6065.8 6090.7 6125.9 6134.8 6141.8 6053.6 6122.4 6135.5 6140.8 6142.0 6108.8 6109.6 6115.9 6125.1 6128.4 4909.7 4920.4 4932.1 4935.9 4947.1 4380.9 4406.8 4425.0 4429.3 4493.7 5864.9 5905.5 5920.2 5945.9 5965.3 6150.9 6157.4 6188.4 6204.6 6205.1 5648.4 5740.4 5833.2 5880.7 5881.3 5354.1 5411.2 5435.3 5439.7 5446.5 6292.2 6304.4 6328.7 6334.4 6338.7 6129.6 6169.4 6210.6 6217.1 6217.4 6160.8 6167.0 6212.3 6250.5 6298.3 6131.8 6151.7 6156.8 6168.4 6188.5 6171.1 6172.5 6182.6 6201.1 6210.6 5936.8 6021.2 6068.6 6099.1 6149.1 6097.0 6124.0 6129.6 6135.9 6146.1 4784.9 6044.2 6050.6 6065.3 6068.1 5932.8 6037.6 6110.1 6114.8 6139.6 5945.4 5956.8 5967.1 5976.4 6024.9 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | [#1] ext.html Cycles:180 Average:72327.58 Median:20632.99 stddev:160978.34 (780.2%) stddev-sans-first:161339.50 14:27:04 INFO - PROCESS | 1932 | Values: 464.0 467.0 505.1 518.2 529.0 30279.7 40328.6 41366.0 41522.4 41552.8 42785.0 42936.8 43012.4 43088.6 43106.6 9806.0 10003.5 10006.6 10007.3 10015.4 8850.6 9042.1 9053.1 9183.3 9197.5 11975.0 12247.9 12257.0 12431.5 12436.6 12258.4 12350.4 12367.6 12375.4 12382.9 12078.9 12151.7 12190.0 12190.0 12192.6 33358.5 40119.8 40474.4 40517.4 40535.4 3257.6 3273.1 3429.3 3549.0 3709.7 28130.9 29189.4 29195.9 30301.0 30495.5 3114.2 3133.2 3212.9 3260.9 3327.1 501272.0 501881.0 502101.0 502658.0 507692.0 56823.7 57777.0 57797.1 57799.0 58004.4 61096.4 61222.0 61275.1 61275.7 61470.4 16613.8 16833.2 16855.2 16880.3 16903.0 13080.0 13082.0 13103.3 13124.0 13158.9 13611.6 13889.5 13890.9 14800.6 14986.9 5999.6 6141.3 6163.9 6175.2 6198.6 808.4 895.5 898.5 910.7 1051.1 28106.0 28964.0 29410.0 30100.8 30109.1 976.4 1017.3 1050.1 1066.9 1138.8 15352.5 15391.9 15410.0 15598.7 15653.1 669497.0 679106.0 682422.0 682899.0 686913.0 49579.8 50322.0 50401.0 53073.9 53091.0 1217.6 1295.1 1309.6 1334.0 1336.3 29810.6 30838.2 30838.5 31816.7 32058.0 55795.0 56240.0 56286.0 56385.7 56509.7 519416.4 617044.0 617166.0 618149.0 657494.0 19129.0 23618.7 23903.9 23936.9 23975.8 45171.5 45360.9 45490.8 45757.0 45977.8 37753.4 38119.0 40872.8 41106.6 41341.7 38507.6 38789.8 39183.8 39399.6 39807.4 37556.2 38077.0 38351.0 38421.8 38541.8 32750.5 33857.8 33981.2 34763.0 34889.5 25366.2 25439.1 25533.6 25800.7 26140.9 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | [#2] jquery.html Cycles:180 Average:36614.85 Median:387.80 stddev:106670.15 (27506.7%) stddev-sans-first:106934.55 14:27:04 INFO - PROCESS | 1932 | Values: 304.9 323.2 365.6 375.0 400.6 14970.9 15065.8 20009.9 20234.9 21307.3 19687.3 20091.6 20125.3 20166.0 20342.2 5805.4 5999.1 6052.3 6069.0 6075.1 4651.7 5930.0 5984.9 5990.0 6044.9 6021.2 6025.2 6028.6 6037.3 6048.6 5738.9 5888.9 5934.2 5942.4 6027.6 5144.5 5145.8 5151.8 5154.7 5156.9 23941.9 24807.4 24879.8 24906.9 25068.9 2260.3 2361.3 2417.7 3080.5 3226.4 9858.2 10361.0 10368.5 10465.5 14638.0 1760.3 1877.9 1904.2 1910.8 1927.3 128183.4 129961.0 131998.0 133286.7 133608.0 11186.6 11329.9 11483.9 11497.0 11565.5 14449.7 14464.8 14471.1 14493.5 14501.1 8501.6 8634.6 8670.4 8676.9 8765.4 8653.2 8657.6 8667.7 8835.0 8853.5 4491.4 4504.4 4506.6 4514.4 4591.2 1496.8 1718.0 1760.6 1886.4 1917.2 698.3 699.8 738.9 750.8 1052.5 19812.6 20389.7 22130.6 22977.8 23085.4 880.3 888.4 894.6 896.2 927.3 10710.0 11348.3 11401.5 11440.9 11444.8 611079.0 623191.0 637102.0 660049.3 660182.0 88663.6 130569.3 132462.0 137597.3 144603.0 956.0 956.9 987.3 988.0 1028.4 18175.5 19044.0 19512.3 19681.8 19720.4 54879.0 56798.0 57090.4 57335.0 58332.1 80107.0 81891.6 84372.6 84598.6 85804.6 7920.3 7931.2 7939.2 8141.4 8173.0 8743.6 12709.7 12856.6 13028.0 13207.0 8701.6 11157.6 11288.7 11344.5 11451.6 9028.5 9421.0 10963.3 11030.9 11080.6 5716.1 6098.8 11015.7 11305.9 11708.6 7986.6 8035.7 8040.7 8187.0 8234.1 9410.7 9941.6 10645.4 11251.1 11424.0 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | [#3] mootools.html Cycles:180 Average:5722.53 Median:4888.32 stddev:3246.71 (66.4%) stddev-sans-first:3240.31 14:27:04 INFO - PROCESS | 1932 | Values: 1500.1 1507.1 1720.0 1858.9 1900.6 7972.7 8213.3 8436.0 9039.7 9045.7 8130.5 8590.1 8772.7 8773.1 8949.9 2364.0 2391.1 2395.1 2398.9 2400.7 2082.5 2172.1 2358.9 2374.9 2412.2 2227.7 2304.0 2310.3 2314.5 2319.5 1877.3 1906.6 2207.9 2224.0 2242.1 2385.5 2386.5 2390.7 2396.3 2396.5 8927.4 9047.1 9050.2 9074.0 9079.8 5258.5 5327.3 5441.4 5451.9 5454.9 3548.1 3670.2 3725.1 3726.4 3742.1 1073.2 1087.4 1097.4 1121.1 1127.0 11904.7 11939.8 11945.5 11947.2 11979.0 4549.5 4587.2 4828.2 4845.6 4889.8 10143.6 10152.6 10152.6 10155.3 10155.9 5398.2 5398.9 5399.3 5400.2 5402.9 4750.9 4886.9 4895.3 4928.3 4942.7 3839.6 3861.7 3872.1 3878.6 3918.5 1111.8 1128.6 1183.6 1184.1 1188.2 635.9 721.9 734.4 760.3 919.0 4999.4 5549.9 5621.5 5805.0 5892.4 860.6 869.5 892.2 960.2 977.2 3724.6 3786.9 3836.6 3881.3 3967.9 10434.4 10941.9 10949.4 10949.5 10957.0 10915.8 10920.0 10925.1 10930.7 10948.3 7839.6 8146.3 8259.2 8413.0 8451.0 5998.6 6068.5 6084.2 6109.0 6148.9 10008.0 10240.7 10253.6 10257.8 10258.5 8578.0 9311.6 9317.6 10033.2 10265.6 7523.9 7624.5 7681.1 7698.5 7708.7 7872.6 7984.1 8043.4 8049.6 8057.3 7232.5 7397.6 7577.2 7604.4 7650.6 7349.1 7444.4 7467.1 7475.5 7491.0 6988.0 7093.3 7116.4 7121.7 7132.0 4837.9 4895.6 4929.9 4950.2 4991.6 4520.8 4833.8 4901.2 4982.1 5089.3 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | [#4] prototype.html Cycles:180 Average:4474.46 Median:5010.24 stddev:1396.02 (27.9%) stddev-sans-first:1364.33 14:27:04 INFO - PROCESS | 1932 | Values: 300.6 302.5 308.2 311.5 317.2 4238.1 4485.3 5308.3 5332.8 5394.6 4195.7 4995.4 5162.7 5201.3 5296.3 3912.9 4012.5 4012.7 4025.0 4040.7 4082.6 4088.8 4106.0 4115.6 4146.2 3718.6 3944.7 4055.9 4056.6 4075.3 3323.4 3347.4 3818.5 4034.7 4038.2 3063.6 3192.7 3359.9 3473.4 3498.7 4008.5 4168.9 5092.9 5210.5 5213.5 4261.7 4560.2 4568.5 4579.6 4602.3 4375.6 5480.2 5568.4 5580.2 5598.8 3803.5 3811.6 3825.0 3827.2 3827.4 5318.9 5489.9 5605.6 5880.0 5922.1 3614.2 3686.9 3841.4 3851.2 3859.5 3450.0 3679.8 3957.0 3970.7 3983.6 3771.8 4419.6 4492.0 4644.7 4746.0 4634.5 5559.3 5622.6 5630.4 5637.4 1266.2 1309.4 1334.5 1342.8 1345.4 840.0 866.2 871.3 893.4 908.3 4481.9 4938.9 5138.1 5189.4 5246.8 4869.4 5113.2 5549.5 5747.1 5812.4 5121.6 5140.9 5218.8 5266.5 5276.5 2257.5 2553.6 2882.9 2958.1 3000.4 5171.8 5628.4 5878.7 5892.4 5909.9 4940.5 5635.8 5987.4 6000.5 6038.3 5287.7 5829.3 6005.8 6048.6 6183.4 5308.8 5612.1 5804.5 5869.4 5933.4 4299.9 4998.5 5018.0 5729.7 5765.2 4936.8 5459.5 5546.4 6044.3 6078.3 3068.5 3867.4 3889.3 3889.9 3892.6 4941.9 5743.5 5750.5 5759.4 5812.6 5225.3 5308.0 5620.0 5673.4 5703.8 4958.8 5002.5 5307.7 5561.9 5650.5 4350.5 4360.5 5452.8 5489.6 5505.7 5132.5 5461.6 5466.7 5526.2 5535.8 4657.4 5546.7 5588.5 5593.2 5594.4 14:27:04 INFO - PROCESS | 1932 | 14:27:04 INFO - PROCESS | 1932 | [#5] yui.html Cycles:180 Average:25675.42 Median:3267.41 stddev:42890.69 (1312.7%) stddev-sans-first:42969.97 14:27:04 INFO - PROCESS | 1932 | Values: 685.6 689.4 732.4 732.5 774.2 14509.2 15461.6 15696.3 15697.3 15722.2 14123.7 14169.8 14310.2 14322.3 14343.5 673.9 689.8 690.7 823.9 832.6 829.6 832.4 836.5 836.9 844.0 899.6 900.7 901.1 902.4 902.4 898.0 900.3 900.3 902.3 903.9 524.8 544.0 553.4 649.8 662.7 12538.4 12542.2 12545.1 12578.6 12605.9 13807.2 14110.8 14236.6 14376.4 14392.4 12414.8 12531.5 12616.7 13083.1 13570.5 4490.9 4511.5 4632.4 4803.5 4814.4 124152.0 128961.4 129039.0 129332.4 130467.7 10844.2 11134.4 11214.6 11239.2 11421.8 22526.5 22620.4 22773.2 22828.8 23294.7 7927.8 7982.2 8005.6 8016.4 8050.3 4269.4 4299.7 4450.3 4513.1 4620.7 3256.4 3278.4 3315.9 3340.3 3363.9 539.9 548.3 607.5 642.6 665.5 524.7 545.1 597.3 604.5 608.8 8943.2 8966.7 9031.5 9116.7 9126.6 595.6 605.7 622.3 632.3 647.9 4226.8 4464.1 4480.5 4485.9 4565.7 169207.2 171535.0 171827.0 173871.0 174001.1 138223.0 143802.0 146593.0 150159.0 151703.0 82339.0 82482.0 83012.0 104221.0 113017.4 9459.0 9918.4 10040.6 10096.0 10194.3 60439.7 60543.0 63182.2 65070.3 67753.7 44182.3 67459.7 83824.0 87480.0 96932.0 12474.8 12619.7 13041.9 13244.8 13545.0 13985.8 14270.0 15041.9 15710.2 15886.3 13112.3 13461.4 13590.0 14550.1 14721.1 13232.2 13349.3 14245.4 14368.4 14551.9 10635.4 13984.2 14301.1 14312.4 14444.7 10609.6 11450.1 11571.6 11641.7 12152.5 10020.5 10391.5 11252.4 11632.0 11658.7 14:27:04 INFO - PROCESS | 1932 | -------- Summary: end -------- 14:27:04 INFO - PROCESS | 1932 | 14:27:05 INFO - TEST-INFO | 1932: exit 0 14:27:05 INFO - TEST-OK | dromaeo_css | took 1117192ms 14:27:05 INFO - TEST-START | kraken 14:27:05 INFO - operating with platform_type : mac_ 14:27:05 INFO - Initialising browser for kraken test... 14:27:05 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpyvt5AY/profile http://localhost:53137/getInfo.html) 14:27:07 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 14:27:07 INFO - PROCESS | 1935 | colorDepth:24 14:27:07 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 14:27:07 INFO - PROCESS | 1935 | __metrics 14:27:07 INFO - PROCESS | 1935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:27:07 INFO - PROCESS | 1935 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:27:08 INFO - TEST-INFO | 1935: exit 0 14:27:08 INFO - Browser initialized. 14:27:08 INFO - Running cycle 1/1 for kraken test... 14:27:08 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpyvt5AY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:20 INFO - PROCESS | 1936 | RSS: Main: 220000256 14:27:20 INFO - PROCESS | 1936 | 14:27:23 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:24 INFO - PROCESS | 1936 | RSS: Main: 269901824 14:27:24 INFO - PROCESS | 1936 | 14:27:27 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-dft) 14:27:27 INFO - PROCESS | 1936 | RSS: Main: 280387584 14:27:27 INFO - PROCESS | 1936 | 14:27:30 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-fft) 14:27:31 INFO - PROCESS | 1936 | RSS: Main: 376958976 14:27:31 INFO - PROCESS | 1936 | 14:27:33 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-oscillator) 14:27:34 INFO - PROCESS | 1936 | RSS: Main: 279900160 14:27:34 INFO - PROCESS | 1936 | 14:27:36 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:36 INFO - PROCESS | 1936 | RSS: Main: 280424448 14:27:36 INFO - PROCESS | 1936 | 14:27:39 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53137/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:40 INFO - PROCESS | 1936 | RSS: Main: 319188992 14:27:40 INFO - PROCESS | 1936 | 14:27:42 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53137/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:43 INFO - PROCESS | 1936 | RSS: Main: 319938560 14:27:43 INFO - PROCESS | 1936 | 14:27:46 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53137/tests/kraken/driver.html?testName=json-parse-financial) 14:27:46 INFO - PROCESS | 1936 | RSS: Main: 315990016 14:27:46 INFO - PROCESS | 1936 | 14:27:48 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:49 INFO - PROCESS | 1936 | RSS: Main: 290103296 14:27:49 INFO - PROCESS | 1936 | 14:27:50 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:51 INFO - PROCESS | 1936 | RSS: Main: 296488960 14:27:51 INFO - PROCESS | 1936 | 14:27:53 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:54 INFO - PROCESS | 1936 | RSS: Main: 302284800 14:27:54 INFO - PROCESS | 1936 | 14:27:57 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:57 INFO - PROCESS | 1936 | RSS: Main: 310534144 14:27:57 INFO - PROCESS | 1936 | 14:28:00 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:01 INFO - PROCESS | 1936 | RSS: Main: 310509568 14:28:01 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53137/tests/kraken/driver.html?testName=ai-astar) 14:28:03 INFO - PROCESS | 1936 | RSS: Main: 354439168 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | __start_tp_report 14:28:03 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 14:28:03 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 14:28:03 INFO - PROCESS | 1936 | |i|pagename|runs| 14:28:03 INFO - PROCESS | 1936 | |0;ai-astar;116;115;124;168;147;114;114;113;113;115 14:28:03 INFO - PROCESS | 1936 | |1;audio-beat-detection;145;109;141;174;140;109;111;108;137;128 14:28:03 INFO - PROCESS | 1936 | |2;audio-dft;184;183;185;186;180;183;185;184;186;185 14:28:03 INFO - PROCESS | 1936 | |3;audio-fft;83;59;58;87;60;59;60;56;82;56 14:28:03 INFO - PROCESS | 1936 | |4;audio-oscillator;87;70;95;69;68;70;91;68;68;90 14:28:03 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;89;87;88;87;88;86;90;87;89;85 14:28:03 INFO - PROCESS | 1936 | |6;imaging-darkroom;95;94;95;95;95;94;101;95;95;95 14:28:03 INFO - PROCESS | 1936 | |7;imaging-desaturate;85;87;86;84;85;86;85;84;85;84 14:28:03 INFO - PROCESS | 1936 | |8;json-parse-financial;58;51;52;53;56;58;59;59;59;57 14:28:03 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;65;72;67;79;74;71;70;69;70;70 14:28:03 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;84;84;82;84;85;85;84;81;84;83 14:28:03 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;138;137;135;153;121;126;152;148;199;136 14:28:03 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;162;163;163;163;164;165;163;163;164;165 14:28:03 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;66;65;67;66;66;65;65;66;65;64 14:28:03 INFO - PROCESS | 1936 | __end_tp_report 14:28:03 INFO - PROCESS | 1936 | __start_cc_report 14:28:03 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1994 14:28:03 INFO - PROCESS | 1936 | __end_cc_report 14:28:03 INFO - PROCESS | 1936 | __startTimestamp1476912483286__endTimestamp 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | ------- Summary: start ------- 14:28:03 INFO - PROCESS | 1936 | Number of tests: 14 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:123.90 Median:115.50 stddev:18.66 (16.2%) stddev-sans-first:19.57 14:28:03 INFO - PROCESS | 1936 | Values: 116.0 115.0 124.0 168.0 147.0 114.0 114.0 113.0 113.0 115.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:138.50 stddev:21.50 (15.5%) stddev-sans-first:22.13 14:28:03 INFO - PROCESS | 1936 | Values: 145.0 109.0 141.0 174.0 140.0 109.0 111.0 108.0 137.0 128.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.00 stddev:1.79 (1.0%) stddev-sans-first:1.90 14:28:03 INFO - PROCESS | 1936 | Values: 184.0 183.0 185.0 186.0 180.0 183.0 185.0 184.0 186.0 185.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:12.56 (20.9%) stddev-sans-first:11.72 14:28:03 INFO - PROCESS | 1936 | Values: 83.0 59.0 58.0 87.0 60.0 59.0 60.0 56.0 82.0 56.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:11.50 (14.7%) stddev-sans-first:11.68 14:28:03 INFO - PROCESS | 1936 | Values: 87.0 70.0 95.0 69.0 68.0 70.0 91.0 68.0 68.0 90.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.00 stddev:1.51 (1.7%) stddev-sans-first:1.51 14:28:03 INFO - PROCESS | 1936 | Values: 89.0 87.0 88.0 87.0 88.0 86.0 90.0 87.0 89.0 85.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.00 stddev:2.01 (2.1%) stddev-sans-first:2.13 14:28:03 INFO - PROCESS | 1936 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 101.0 95.0 95.0 95.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 14:28:03 INFO - PROCESS | 1936 | Values: 85.0 87.0 86.0 84.0 85.0 86.0 85.0 84.0 85.0 84.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:58.00 stddev:3.08 (5.3%) stddev-sans-first:3.20 14:28:03 INFO - PROCESS | 1936 | Values: 58.0 51.0 52.0 53.0 56.0 58.0 59.0 59.0 59.0 57.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:3.83 (5.4%) stddev-sans-first:3.46 14:28:03 INFO - PROCESS | 1936 | Values: 65.0 72.0 67.0 79.0 74.0 71.0 70.0 69.0 70.0 70.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 14:28:03 INFO - PROCESS | 1936 | Values: 84.0 84.0 82.0 84.0 85.0 85.0 84.0 81.0 84.0 83.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:143.00 stddev:21.77 (15.2%) stddev-sans-first:22.97 14:28:03 INFO - PROCESS | 1936 | Values: 138.0 137.0 135.0 153.0 121.0 126.0 152.0 148.0 199.0 136.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:163.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 14:28:03 INFO - PROCESS | 1936 | Values: 162.0 163.0 163.0 163.0 164.0 165.0 163.0 163.0 164.0 165.0 14:28:03 INFO - PROCESS | 1936 | 14:28:03 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 14:28:03 INFO - PROCESS | 1936 | Values: 66.0 65.0 67.0 66.0 66.0 65.0 65.0 66.0 65.0 64.0 14:28:03 INFO - PROCESS | 1936 | -------- Summary: end -------- 14:28:03 INFO - PROCESS | 1936 | 14:28:04 INFO - TEST-INFO | 1936: exit 0 14:28:04 INFO - TEST-OK | kraken | took 58678ms 14:28:04 INFO - SUITE-END | took 1175s 14:28:04 INFO - Completed test suite (00:19:36) 14:28:04 INFO - javascript benchmark 14:28:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2888.2923683697495, 3307.470804671253, 3342.6323104458506, 3368.141124013376, 3389.4237979543477, 5152.252923326116, 5482.698451585161, 5693.914591281134, 5777.075667893133, 5842.1820945067675, 5719.14212868069, 5800.883982320351, 5815.941840581593, 5836.737346819393, 5856.063029915214, 5238.214267859814, 5246.0032593807055, 5251.212318152288, 5253.553447956909, 5321.733913304339, 5159.638825282232, 5208.270842082112, 5209.244659524366, 5356.651817631861, 5361.705106219157, 5256.8685782855355, 5265.789368425278, 5283.154695248761, 5287.39194992575, 5291.365036195662, 5278.47215278473, 5287.920681189786, 5310.468953104659, 5325.334333208349, 5329.653572517774, 5126.666766660155, 5169.172932330846, 5234.528892399702, 5265.736713164327, 5278.815241466568, 5663.207150998864, 5707.229524014247, 5741.741621627037, 5750.88498230033, 5774.942250577525, 6051.0923361496125, 6093.146959425684, 6121.816345509642, 6132.754689812402, 6135.263768347827, 6064.818055458343, 6145.969270153665, 6160.84597885052, 6164.198654174974, 6177.3822617738315, 5665.49010589049, 5764.596478246483, 5776.191333213354, 5804.361520232771, 5897.764089436418, 5260.500252476085, 6233.501319894398, 6248.062790581449, 6251.843703907439, 6281.214848143982, 6106.358832322631, 6111.877762444727, 6113.20528331323, 6135.509159267248, 6155.138280640714, 6065.757369705162, 6090.69546522681, 6125.9087146859765, 6134.8159555213415, 6141.7543298267565, 6053.636781793019, 6122.448979591858, 6135.477655820289, 6140.846478837975, 6141.969290153521, 6108.847278818065, 6109.572329936951, 6115.936978868578, 6125.052321061979, 6128.383804625999, 4909.705417674951, 4920.40955085392, 4932.136876046678, 4935.925961110586, 4947.084789313988, 4380.934285985649, 4406.779661016936, 4424.977875110668, 4429.335599660077, 4493.730376177375, 5864.882702345929, 5905.46850783423, 5920.200772895604, 5945.851353716192, 5965.313988891333, 6150.938490615126, 6157.384261573807, 6188.44304012641, 6204.565680402328, 6205.100260462208, 5648.378678345379, 5740.425957404226, 5833.183354330397, 5880.676562789002, 5881.32364778056, 5354.089804733127, 5411.2153737708595, 5435.320584926884, 5439.700816455133, 5446.482584154499, 6292.2134733158355, 6304.432601065926, 6328.651924144032, 6334.429901308904, 6338.683065846689, 6129.601575897553, 6169.352218017044, 6210.627362358273, 6217.09852071438, 6217.409346112112, 6160.845978850385, 6167.013277875519, 6212.285587157535, 6250.49996000328, 6298.275698294755, 6131.7501724086305, 6151.708141290379, 6156.846078848064, 6168.444839964424, 6188.535859810442, 6171.105189747372, 6172.506199504119, 6182.629042257479, 6201.069839524108, 6210.5652604317265, 5936.821895343147, 6021.187139736255, 6068.575199736153, 6099.054646529795, 6149.108379284889, 6096.969515152396, 6124.014786914997, 6129.572745043149, 6135.93706321624, 6146.108814222002, 4784.904301913873, 6044.24446944132, 6050.5764596479585, 6065.332813390435, 6068.120122582289, 5932.762689492372, 6037.577369584087, 6110.052941794029, 6114.755409783559, 6139.6009259398, 5945.3757355477055, 5956.76172953077, 5967.1049342597225, 5976.402359763989, 6024.8795024100145], "value": 5687.401575753382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.9628829693623, 467.0239200071849, 505.07571144805013, 518.2278405176286, 528.994909671624, 30279.697203027965, 40328.59671403289, 41366.0, 41522.37716434256, 41552.792236038855, 42785.0, 42936.78531607345, 43012.354814677805, 43088.56911430885, 43106.56893431065, 9805.95097024514, 10003.549840257207, 10006.59973601055, 10007.29948903577, 10015.399076055424, 8850.601722922484, 9042.095790420972, 9053.094690530927, 9183.311251656152, 9197.494137822418, 11975.041996640248, 12247.938760306231, 12257.0, 12431.502739890393, 12436.564720234794, 12258.387080645976, 12350.44423000967, 12367.62897113088, 12375.381230938507, 12382.93808530956, 12078.879211207863, 12151.696207594792, 12190.0, 12190.024798016137, 12192.57325993586, 33358.49962250568, 40119.7994010031, 40474.39288410676, 40517.39223911644, 40535.39196912049, 3257.625373082102, 3273.067175854894, 3429.3484237994703, 3548.9530588476205, 3709.7403181777286, 28130.859345703346, 29189.41621167565, 29195.85402072976, 30301.0, 30495.542566861513, 3114.205877501223, 3133.2166958260436, 3212.903612891617, 3260.8858689945737, 3327.101682545723, 501272.0, 501881.0, 502101.0, 502658.0, 507692.0, 56823.71588142033, 57777.0, 57797.13304300439, 57799.0, 58004.419955800746, 61096.38903610907, 61222.0, 61275.08087378693, 61275.69362153161, 61470.38529614736, 16613.750793738105, 16833.158342082847, 16855.157242137844, 16880.324787008383, 16902.985820850787, 13080.018998575146, 13082.018848586395, 13103.279319637511, 13124.015698822626, 13158.934205328913, 13611.591652250449, 13889.513867014606, 13890.93054534741, 14800.555983320517, 14986.925065374604, 5999.610025348426, 6141.263048434216, 6163.876722465615, 6175.166352542439, 6198.6280823150755, 808.3937047214589, 895.471671713679, 898.4878619187001, 910.6858133943779, 1051.1013083813382, 28106.0, 28964.0, 29410.0, 30100.84949575238, 30109.096727098222, 976.4385478349977, 1017.3031473440717, 1050.0969166516788, 1066.8719753629614, 1138.7722455508765, 15352.462663806713, 15391.922565420313, 15410.0, 15598.688026239412, 15653.139077350626, 669497.0, 679106.0, 682422.0, 682899.0, 686913.0, 49579.75210123998, 50322.0, 50401.0, 53073.93852122936, 53091.01817363636, 1217.598192596441, 1295.0675513630172, 1309.6005718256024, 1333.993330033363, 1336.2650542201945, 29810.552841707824, 30838.229044273176, 30838.537421939138, 31816.681833182298, 32058.0, 55795.0, 56240.0, 56286.0, 56385.71807140938, 56509.71745141248, 519416.402917983, 617044.0, 617166.0, 618149.0, 657494.0, 19129.0, 23618.700971446735, 23903.88048059818, 23936.88031559831, 23975.76024239735, 45171.548284516735, 45360.86597834949, 45490.77254613706, 45757.0, 45977.77011115057, 37753.43369849509, 38119.0, 40872.79563602163, 41106.588934110274, 41341.7040715398, 38507.61492385152, 38789.80352725096, 39183.80408097941, 39399.60600394074, 39807.40288895611, 37556.248875022895, 38077.0, 38351.0, 38421.847344579706, 38541.80729096449, 32750.50874236936, 33857.83071084629, 33981.15047123842, 34763.0, 34889.47665785066, 25366.209716930753, 25439.10963116282, 25533.61699574545, 25800.741992579835, 26140.8692956534], "value": 19999.296188536766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.89938320354287, 323.237160301688, 365.5795834789991, 374.9737518373713, 400.6214127649371, 14970.850291497081, 15065.849341506582, 20009.89995050023, 20234.89882550587, 21307.25424610139, 19687.310944116958, 20091.59816803663, 20125.29561465349, 20166.0, 20342.186312547517, 5805.419458054193, 5999.070144127667, 6052.334243233241, 6069.0, 6075.088736689488, 4651.7441540715245, 5929.970350148244, 5984.910226346608, 5989.9517584422765, 6044.939550604482, 6021.157038014681, 6025.15647809307, 6028.63828170309, 6037.30570984338, 6048.637081775086, 5738.885222295552, 5888.882222355572, 5934.1692163097205, 5942.435468630473, 6027.63834169949, 5144.485551444825, 5145.794168233266, 5151.793928242866, 5154.716490593053, 5156.8968620627375, 23941.880290598434, 24807.379815504577, 24879.751202487925, 24906.875465622736, 25068.87190076451, 2260.2654137405243, 2361.3270217987792, 2417.721961974378, 3080.5071188609713, 3226.3869864725625, 9858.211343092535, 10361.0, 10368.481575921174, 10465.476726163737, 14638.0, 1760.2870837310782, 1877.9389396454892, 1904.238304678126, 1910.751602291707, 1927.3158028899818, 128183.35908320492, 129961.0, 131998.0, 133286.6671333284, 133608.0, 11186.608468703556, 11329.886701133048, 11483.942580287045, 11497.0, 11565.479553420117, 14449.711005779825, 14464.783028254584, 14471.131732096108, 14493.492727754689, 14501.129932204101, 8501.574921253912, 8634.56827158652, 8670.393072484865, 8676.913230867736, 8765.386422950332, 8653.221210091122, 8657.610407531676, 8667.653293868301, 8834.95582522096, 8853.468791872509, 4491.438570178728, 4504.414426124583, 4506.571875671806, 4514.367988481616, 4591.242444996538, 1496.8203815541988, 1718.0454495684899, 1760.6214663847334, 1886.3869242496244, 1917.2426891378107, 698.2982102986567, 699.8180473077036, 738.8780851159498, 750.7935317787652, 1052.4842827014709, 19812.60374792496, 20389.694154587694, 22130.557388852456, 22977.770222297564, 23085.422864428187, 880.2693764175718, 888.3870129610548, 894.6153154143781, 896.188949001155, 927.3276874266103, 10710.0, 11348.31910085381, 11401.543938242543, 11440.94279528597, 11444.828327575093, 611079.0, 623191.0, 637102.0, 660049.297781601, 660182.0, 88663.55668221747, 130569.34715326552, 132462.0, 137597.3120134413, 144603.0, 955.9761005974906, 956.93779904306, 987.3434166279487, 988.0218583602326, 1028.4343611013762, 18175.545611359823, 19044.047797610343, 19512.31706890252, 19681.803181967996, 19720.40838774839, 54879.0, 56798.0, 57090.42909570851, 57335.0, 58332.12501812561, 80107.0, 81891.5905420469, 84372.57813710893, 84598.57700711457, 85804.57097714471, 7920.317052570583, 7931.246531579491, 7939.245771651684, 8141.43009989295, 8173.0, 8743.562821859008, 12709.745805083661, 12856.55002074923, 13028.0, 13207.009474289274, 8701.564921754014, 11157.609483668033, 11288.661340159808, 11344.489497972447, 11451.59919402817, 9028.458292502472, 9420.963693993792, 10963.287386319864, 11030.944845275722, 11080.5567777288, 5716.114002329479, 6098.786542470993, 11015.669529914116, 11305.943470282597, 11708.590199342982, 7986.600669966595, 8035.718749843727, 8040.67837286502, 8187.0, 8234.094249632655, 9410.717678469657, 9941.552630131517, 10645.361278323326, 11251.099912007183, 11424.0], "value": 9498.435728053353, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.0999400359783, 1507.0580886945659, 1719.982800171998, 1858.897760623167, 1900.6103748731512, 7972.681092756297, 8213.342932565396, 8435.957820210899, 9039.683611073613, 9045.728628141158, 8130.471519351238, 8590.140985901407, 8772.69295574655, 8773.078826723198, 8949.865752013726, 2363.9763602363973, 2391.079434417753, 2395.125779090628, 2398.9040438382444, 2400.7119145702454, 2082.4689704125503, 2172.1094351315965, 2358.929232123039, 2374.857508549484, 2412.2039726890084, 2227.7103976483036, 2303.9884800575974, 2310.341552657493, 2314.456102815837, 2319.489712263299, 1877.2584828992472, 1906.6282074995381, 2207.8896055197174, 2224.0325458425555, 2242.1031587365023, 2385.5348207099623, 2386.5226954609147, 2390.748971358, 2396.341006223285, 2396.4607963208314, 8927.37508374414, 9047.140521650434, 9050.185483306534, 9073.954630226872, 9079.773005674844, 5258.474152584711, 5327.30745003151, 5441.428649991773, 5451.890962180734, 5454.890902181974, 3548.077499850032, 3670.229251857113, 3725.105974566112, 3726.441033844918, 3742.083189618561, 1073.1629329123296, 1087.3801932898252, 1097.3799803111297, 1121.0919155484003, 1126.9718257043558, 11904.702382440422, 11939.820902686466, 11945.462454189583, 11947.163698541019, 11979.0, 4549.45406551216, 4587.220172570671, 4828.155072862235, 4845.5881250094135, 4889.755512224375, 10143.64497242593, 10152.593896244216, 10152.644657436955, 10155.289129760993, 10155.898441015643, 5398.1632846908005, 5398.865028374244, 5399.325084364455, 5400.21696853954, 5402.8919421611345, 4750.904981900412, 4886.877828054327, 4895.31465594817, 4928.334674818925, 4942.678725882806, 3839.577646458887, 3861.6717579005535, 3872.0900588361715, 3878.6121387861554, 3918.5101862267215, 1111.8165502692127, 1128.6444769897455, 1183.6389901080254, 1184.1000839362148, 1188.2276520261726, 635.9268684101295, 721.8592374486925, 734.4161391693616, 760.3081196111511, 918.9982918618738, 4999.375078115236, 5549.861253468614, 5621.4659607337235, 5805.042168042226, 5892.351841297454, 860.5697151424288, 869.5261082709939, 892.2237653241722, 960.1694534227983, 977.2133432586836, 3724.6089160638285, 3786.8674596388996, 3836.5971572984995, 3881.2819628368843, 3967.861124860616, 10434.37393756377, 10941.890581094247, 10949.397783121845, 10949.507272172772, 10957.01386875185, 10915.836262456069, 10920.017198452177, 10925.125989920945, 10930.672079837617, 10948.34309941406, 7839.608019598997, 8146.30756385702, 8259.174082591693, 8413.0, 8451.0, 5998.550108741949, 6068.544859135494, 6084.178635884276, 6109.022556390956, 6148.938510615016, 10007.999200080225, 10240.743981400525, 10253.58985640566, 10257.794844103226, 10258.487075646337, 8577.95711021441, 9311.627534898798, 9317.580708867981, 10033.247506436901, 10265.58937642486, 7523.924760752322, 7624.466287359832, 7681.116671582839, 7698.461107722405, 7708.730194443167, 7872.645730942007, 7984.121746607984, 8043.436959412785, 8049.557274349967, 8057.274845263954, 7232.493725439169, 7397.630118493946, 7577.1665116836, 7604.353629941295, 7650.579218142833, 7349.118105827335, 7444.441666875115, 7467.141278752796, 7475.514091584029, 7491.026166598307, 6987.965060174666, 7093.255208203271, 7116.359527642537, 7121.715131394686, 7132.0, 4837.879053023703, 4895.559399654048, 4929.901401971869, 4950.2079667253065, 4991.57571606403, 4520.819167233405, 4833.830815921567, 4901.215805471107, 4982.078315511642, 5089.312942752681], "value": 4557.413389037581, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.586693296717, 302.5205049995758, 308.15719008511724, 311.49071268476035, 317.2275509135254, 4238.067625122476, 4485.32720091986, 5308.336457942757, 5332.840014799553, 5394.622376433651, 4195.685323600735, 4995.425526064504, 5162.716050617215, 5201.323827902377, 5296.311479507668, 3912.8826135215845, 4012.458318127059, 4012.7391719538136, 4024.9736317239062, 4040.6565441937323, 4082.5711001149657, 4088.8364465421346, 4105.958940410603, 4115.60069576344, 4146.232946904817, 3718.646728560796, 3944.664703500206, 4055.918881622366, 4056.574059723731, 4075.32757095079, 3323.418401779691, 3347.364000839857, 3818.522684664417, 4034.657054150386, 4038.2125485530332, 3063.632364116298, 3192.728618067467, 3359.8744420619123, 3473.426884564044, 3498.6676265754713, 4008.478897743304, 4168.853565269545, 5092.872678183075, 5210.505002024802, 5213.504717051874, 4261.6590672746415, 4560.247559152735, 4568.474625418086, 4579.564941330568, 4602.286645569909, 4375.584319489643, 5480.177973303997, 5568.359638641527, 5580.246666700024, 5598.804041858515, 3803.505544279226, 3811.6188381161937, 3824.9808750956067, 3827.1771569112775, 3827.3876179811095, 5318.877869651013, 5489.862753431156, 5605.635633683838, 5879.970600147015, 5922.06857605488, 3614.1868079681863, 3686.9078273043388, 3841.4237864320576, 3851.2297540491454, 3859.4755071746504, 3450.0, 3679.7976111314133, 3956.9802150989062, 3970.7220494565104, 3983.6016398359934, 3771.830267637963, 4419.558044195619, 4492.0, 4644.676267263813, 4746.0, 4634.513376095461, 5559.33288005442, 5622.606417550814, 5630.4369563043365, 5637.436256374412, 1266.2339284732789, 1309.428685577311, 1334.5329134802935, 1342.7515909556569, 1345.4349173347218, 840.0255703384045, 866.1901122450529, 871.329076611006, 893.4371346051946, 908.3323757038571, 4481.932771008437, 4938.851834444972, 5138.100832354323, 5189.42916279209, 5246.7638956247065, 4869.440014398389, 5113.233015047698, 5549.500544950974, 5747.137929310553, 5812.447817457335, 5121.590272778169, 5140.917928238994, 5218.791248350023, 5266.526012658879, 5276.4911333963255, 2257.4807794207422, 2553.578659521158, 2882.942341153165, 2958.05342290465, 3000.369922316338, 5171.81898633546, 5628.352739434936, 5878.676672782953, 5892.381299963527, 5909.881802364014, 4940.481249468826, 5635.830925072254, 5987.401259874065, 6000.459958603659, 6038.30559485656, 5287.656302340259, 5829.269267668696, 6005.819825405245, 6048.637081775108, 6183.423227077066, 5308.840734777963, 5612.102063669793, 5804.535637148933, 5869.413058694096, 5933.436323549256, 4299.9355009674255, 4998.525140111684, 5017.974910125572, 5729.656220626775, 5765.221695071112, 4936.75316234194, 5459.508644222039, 5546.389897111234, 6044.274687037408, 6078.331383547895, 3068.5090385538206, 3867.400552914303, 3889.319369110451, 3889.86385476507, 3892.57181710006, 4941.901161976669, 5743.483086522233, 5750.5112065474905, 5759.444949863597, 5812.622179558315, 5225.294585230945, 5308.018016666929, 5620.0, 5673.432656734293, 5703.828885133453, 4958.785097651099, 5002.499750024968, 5307.681539107666, 5561.8609534760335, 5650.463205995424, 4350.477942646902, 4360.520342762357, 5452.7546260417585, 5489.64317319373, 5505.660094459919, 5132.486751324837, 5461.603409255587, 5466.72666366688, 5526.22632831412, 5535.750891209986, 4657.441107067174, 5546.72266386671, 5588.469095435927, 5593.244911936837, 5594.4125866785025], "value": 4035.449265368895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.6229074009294, 689.4484412470024, 732.3701616609711, 732.5092188233883, 774.2373761844582, 14509.201993890332, 15461.613459663515, 15696.293666785008, 15697.29362178702, 15722.213889305533, 14123.717525649481, 14169.78745318821, 14310.21293828839, 14322.283885805695, 14343.497977570787, 673.8955461903413, 689.8171984424132, 690.7444245629124, 823.9217274358926, 832.6211573733937, 829.5686243153557, 832.4256263178388, 836.5148214035875, 836.8995720513517, 843.9578021098952, 899.6446403670546, 900.7477906186245, 901.0583939782942, 902.3503077783985, 902.4449963272606, 897.9942464439804, 900.2707806676613, 900.3067637918831, 902.3097330542108, 903.9231665308457, 524.8005757812007, 544.0452006728207, 553.4493179286595, 649.7758273395671, 662.734906037584, 12538.435770390355, 12542.24746515212, 12545.12184147101, 12578.622641320775, 12605.93697031518, 13807.240601766898, 14110.788338174936, 14236.644083897882, 14376.35306411214, 14392.352344144434, 12414.841028255545, 12531.498740050387, 12616.747665046647, 13083.149595276276, 13570.45718171272, 4490.910181796378, 4511.548845115462, 4632.420947381577, 4803.471618122004, 4814.374131362935, 124152.0, 128961.35519322437, 129039.0, 129332.3533382327, 130467.6953230465, 10844.240903136862, 11134.443277836075, 11214.55141794319, 11239.157063220291, 11421.828672569918, 22526.54946901053, 22620.434489137573, 22773.202937897095, 22828.771712282996, 23294.65058024131, 7927.801804954807, 7982.201779822088, 8005.559694216874, 8016.398770092266, 8050.27547520726, 4269.402283680287, 4299.658128127657, 4450.287953927356, 4513.119941611354, 4620.745858977789, 3256.413845507784, 3278.4098862205033, 3315.8507867145554, 3340.315235376742, 3363.899083027513, 539.9217113518596, 548.3392512023003, 607.5261296188979, 642.5887432043496, 665.4809248785955, 524.6930545630848, 545.1414022913926, 597.2593983460478, 604.4590091867753, 608.8295277322356, 8943.23982461498, 8966.730998070068, 9031.548422578844, 9116.726498205064, 9126.589303481227, 595.5860676829562, 605.7213681706464, 622.2595111817013, 632.3298390523018, 647.9449246813979, 4226.767527786002, 4464.1071785643, 4480.529544397857, 4485.866040701073, 4565.748883811422, 169207.1539642294, 171535.0, 171827.0, 173871.0, 174001.12999435174, 138223.0, 143802.0, 146593.0, 150159.0, 151703.0, 82339.0, 82482.0, 83012.0, 104221.0, 113017.43491282492, 9458.959514453267, 9918.40489570628, 10040.64857729976, 10096.040876116756, 10194.337368071052, 60439.69780151071, 60543.0, 63182.15680294306, 65070.34929650832, 67753.66123169352, 44182.33726494041, 67459.66270168617, 83824.0, 87480.0, 96932.0306796923, 12474.75050499003, 12619.74760504803, 13041.934790325988, 13244.801327979896, 13545.0, 13985.790213146607, 14270.0, 15041.924790375979, 15710.214489275262, 15886.285117169524, 13112.344382781013, 13461.394237259543, 13590.048696591144, 14550.054246473945, 14721.116732996055, 13232.206067635587, 13349.265790381234, 14245.358958847084, 14368.353424095732, 14551.85448145505, 10635.361878287327, 13984.230867302396, 14301.070430421989, 14312.427502899767, 14444.711105777615, 10609.628662996758, 11450.141239406912, 11571.594994175164, 11641.73436859839, 12152.513899443924, 10020.546548130129, 10391.518841188286, 11252.381119038531, 11632.0, 11658.6502404928], "value": 7783.046582160995, "unit": "score"}], "name": "dromaeo_css", "value": 7326.522927268891, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 124.0, 168.0, 147.0, 114.0, 114.0, 113.0, 113.0, 115.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 141.0, 174.0, 140.0, 109.0, 111.0, 108.0, 137.0, 128.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 185.0, 186.0, 180.0, 183.0, 185.0, 184.0, 186.0, 185.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 87.0, 60.0, 59.0, 60.0, 56.0, 82.0, 56.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 95.0, 69.0, 68.0, 70.0, 91.0, 68.0, 68.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 87.0, 88.0, 86.0, 90.0, 87.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 101.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 84.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 51.0, 52.0, 53.0, 56.0, 58.0, 59.0, 59.0, 59.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 67.0, 79.0, 74.0, 71.0, 70.0, 69.0, 70.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 84.0, 85.0, 85.0, 84.0, 81.0, 84.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 135.0, 153.0, 121.0, 126.0, 152.0, 148.0, 199.0, 136.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 164.0, 165.0, 163.0, 163.0, 164.0, 165.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 64.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1433.9, "alertThreshold": 2.0}]} 14:28:04 INFO - Return code: 0 14:28:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:28:04 INFO - # TBPL SUCCESS # 14:28:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:28:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:28:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:28:04 INFO - 2016-10-19 14:28:04.638 screenresolution[1940:26845] starting screenresolution argv=screenresolution get 14:28:04 INFO - 2016-10-19 14:28:04.641 screenresolution[1940:26845] Display 0: 1600x1200x32@60 14:28:04 INFO - 2016-10-19 14:28:04.647 screenresolution[1941:26848] starting screenresolution argv=screenresolution list 14:28:04 INFO - Available Modes on Display 0 14:28:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:28:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:28:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:28:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:28:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:28:04 INFO - Intel Iris: 14:28:04 INFO - Chipset Model: Intel Iris 14:28:04 INFO - Type: GPU 14:28:04 INFO - Bus: Built-In 14:28:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:28:04 INFO - Vendor: Intel (0x8086) 14:28:04 INFO - Device ID: 0x0a2e 14:28:04 INFO - Revision ID: 0x0009 14:28:04 INFO - Displays: 14:28:04 INFO - Display: 14:28:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:28:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:28:04 INFO - Display Serial Number: 1600x1200 60 14:28:04 INFO - Main Display: Yes 14:28:04 INFO - Mirror: Off 14:28:04 INFO - Online: Yes 14:28:04 INFO - Rotation: Supported 14:28:04 INFO - Return code: 0 14:28:04 INFO - Running post-action listener: _resource_record_post_action 14:28:04 INFO - [mozharness: 2016-10-19 21:28:04.882937Z] Finished run-tests step (success) 14:28:04 INFO - Running post-run listener: _resource_record_post_run 14:28:04 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 897024; Write bytes: 661411840; Read time: 10; Write time: 1971 14:28:04 INFO - TinderboxPrint: CPU usage
53.5% 14:28:04 INFO - TinderboxPrint: I/O read bytes / time
897,024 / 10 14:28:04 INFO - TinderboxPrint: I/O write bytes / time
661,411,840 / 1,971 14:28:04 INFO - TinderboxPrint: CPU idle
2,251.6 (46.5%) 14:28:04 INFO - TinderboxPrint: CPU system
973.5 (20.1%) 14:28:04 INFO - TinderboxPrint: CPU user
1,612.5 (33.3%) 14:28:04 INFO - TinderboxPrint: Swap in / out
364,548,096 / 0 14:28:04 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 364188160; Write bytes: 367003136; Read time: 28710; Write time: 763 14:28:04 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 786432; Write bytes: 293011968; Read time: 9; Write time: 1201 14:28:05 INFO - Running post-run listener: _upload_blobber_files 14:28:05 INFO - Blob upload gear active. 14:28:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:05 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 14:28:05 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:28:05 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:28:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:28:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:28:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:06 INFO - (blobuploader) - INFO - Done attempting. 14:28:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:28:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:28:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:07 INFO - (blobuploader) - INFO - Done attempting. 14:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:09 INFO - (blobuploader) - INFO - Done attempting. 14:28:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:09 INFO - Return code: 0 14:28:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:28:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78cbb5a815c237f805a58f0e468e2e59415f58d7834f233d834e7c93593de01b52c9edc88cd7bdf97a9e092c3bd65e4eb15195d3a792e36a67f7f9c50ccaac26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1ec00ca56fc428f5dccd57f0aa7eccf562218b1dc4cc4e15feac6f5769b08e19e3f945db79a984c4a6116e964e884555b66cef51ad3cc55c1a53600e4383e77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48e13755ba7ad532267921ce2821ae01a4ba0cb4753c0cfb17a9658b05eeaa26cd9501d7bab923da5ccd909c2eb84680f4e02fd242e8a3b07bc8be60ca429da0"} 14:28:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:28:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:28:09 INFO - Contents: 14:28:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78cbb5a815c237f805a58f0e468e2e59415f58d7834f233d834e7c93593de01b52c9edc88cd7bdf97a9e092c3bd65e4eb15195d3a792e36a67f7f9c50ccaac26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1ec00ca56fc428f5dccd57f0aa7eccf562218b1dc4cc4e15feac6f5769b08e19e3f945db79a984c4a6116e964e884555b66cef51ad3cc55c1a53600e4383e77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48e13755ba7ad532267921ce2821ae01a4ba0cb4753c0cfb17a9658b05eeaa26cd9501d7bab923da5ccd909c2eb84680f4e02fd242e8a3b07bc8be60ca429da0"} 14:28:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:09 INFO - Copying logs to upload dir... 14:28:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:28:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.175402 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-19 14:28:09.460939) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:09.464400) ========= 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.rJCdkAPjrn/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.00e1kFQEOr/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78cbb5a815c237f805a58f0e468e2e59415f58d7834f233d834e7c93593de01b52c9edc88cd7bdf97a9e092c3bd65e4eb15195d3a792e36a67f7f9c50ccaac26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1ec00ca56fc428f5dccd57f0aa7eccf562218b1dc4cc4e15feac6f5769b08e19e3f945db79a984c4a6116e964e884555b66cef51ad3cc55c1a53600e4383e77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48e13755ba7ad532267921ce2821ae01a4ba0cb4753c0cfb17a9658b05eeaa26cd9501d7bab923da5ccd909c2eb84680f4e02fd242e8a3b07bc8be60ca429da0"} build_url:https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/CSIZoQcqQKGs2p_Okd1dYw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78cbb5a815c237f805a58f0e468e2e59415f58d7834f233d834e7c93593de01b52c9edc88cd7bdf97a9e092c3bd65e4eb15195d3a792e36a67f7f9c50ccaac26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1ec00ca56fc428f5dccd57f0aa7eccf562218b1dc4cc4e15feac6f5769b08e19e3f945db79a984c4a6116e964e884555b66cef51ad3cc55c1a53600e4383e77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48e13755ba7ad532267921ce2821ae01a4ba0cb4753c0cfb17a9658b05eeaa26cd9501d7bab923da5ccd909c2eb84680f4e02fd242e8a3b07bc8be60ca429da0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:09.497045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:09.497367) ========= 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.rJCdkAPjrn/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.00e1kFQEOr/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005161 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:28:09.545514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 14:28:09.546004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 14:28:09.546298) ========= ========= Total master_lag: 0.17 =========