builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0217 starttime: 1489447261.83 results: success (0) buildid: 20170313135836 builduid: c324be7f3927488faac2d81d5221d170 revision: 727412152afc7cf3530ce0fd9f2199aa84aa33a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:01.827464) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:01.827970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:01.828252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:01.855679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:01.856226) ========= 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.RFN7zCysNS/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.GkcF5AkZjR/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 --2017-03-13 16:21:01-- 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% 18.2M=0.001s 2017-03-13 16:21:02 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:02.043810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:02.044126) ========= 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.RFN7zCysNS/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.GkcF5AkZjR/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.039782 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:02.107369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 16:21:02.107734) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 727412152afc7cf3530ce0fd9f2199aa84aa33a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 727412152afc7cf3530ce0fd9f2199aa84aa33a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RFN7zCysNS/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.GkcF5AkZjR/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 2017-03-13 16:21:02,214 truncating revision to first 12 chars 2017-03-13 16:21:02,215 Setting DEBUG logging. 2017-03-13 16:21:02,215 attempt 1/10 2017-03-13 16:21:02,215 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/727412152afc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 16:21:02,986 unpacking tar archive at: mozilla-central-727412152afc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.046503 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 16:21:03.180196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:03.180724) ========= script_repo_revision: 727412152afc7cf3530ce0fd9f2199aa84aa33a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:03.181379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:03.181916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 16:21:03.203560) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-13 16:21:03.204015) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RFN7zCysNS/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.GkcF5AkZjR/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:21:03 INFO - MultiFileLogger online at 20170313 16:21:03 in /builds/slave/test 16:21:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:21:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:03 INFO - {'append_to_log': False, 16:21:03 INFO - 'base_work_dir': '/builds/slave/test', 16:21:03 INFO - 'blob_upload_branch': 'Firefox', 16:21:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:03 INFO - 'branch': 'Firefox', 16:21:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:03 INFO - 'config_files': ('talos/mac_config.py',), 16:21:03 INFO - 'default_actions': ('clobber', 16:21:03 INFO - 'read-buildbot-config', 16:21:03 INFO - 'download-and-extract', 16:21:03 INFO - 'populate-webroot', 16:21:03 INFO - 'create-virtualenv', 16:21:03 INFO - 'install', 16:21:03 INFO - 'run-tests'), 16:21:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:03 INFO - 'download_minidump_stackwalk': True, 16:21:03 INFO - 'download_symbols': 'ondemand', 16:21:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:03 INFO - 'gecko_profile': False, 16:21:03 INFO - 'gecko_profile_interval': 0, 16:21:03 INFO - 'installer_path': 'installer.exe', 16:21:03 INFO - 'log_level': 'info', 16:21:03 INFO - 'log_name': 'talos', 16:21:03 INFO - 'log_to_console': True, 16:21:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:21:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:21:03 INFO - 'opt_config_files': (), 16:21:03 INFO - 'pip_index': False, 16:21:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:03 INFO - 'cmd': ('bash', 16:21:03 INFO - '-c', 16:21:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:03 INFO - 'enabled': True, 16:21:03 INFO - 'halt_on_failure': False, 16:21:03 INFO - 'name': 'check_screen_resolution'},), 16:21:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:03 INFO - 'cmd': ('bash', 16:21:03 INFO - '-c', 16:21:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:03 INFO - 'enabled': True, 16:21:03 INFO - 'halt_on_failure': False, 16:21:03 INFO - 'name': 'check_screen_resolution'},), 16:21:03 INFO - 'run_cmd_checks_enabled': True, 16:21:03 INFO - 'suite': 'dromaeojs-e10s', 16:21:03 INFO - 'system_bits': '32', 16:21:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:03 INFO - 'title': 't-yosemite-r7-0217', 16:21:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:03 INFO - 'use_talos_json': True, 16:21:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:03 INFO - 'work_dir': 'build'} 16:21:03 INFO - [mozharness: 2017-03-13 23:21:03.414136Z] Running clobber step. 16:21:03 INFO - Running pre-action listener: _resource_record_pre_action 16:21:03 INFO - Running main action method: clobber 16:21:03 INFO - rmtree: /builds/slave/test/build 16:21:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:05 INFO - Running post-action listener: _resource_record_post_action 16:21:05 INFO - [mozharness: 2017-03-13 23:21:05.895873Z] Finished clobber step (success) 16:21:05 INFO - [mozharness: 2017-03-13 23:21:05.895997Z] Running read-buildbot-config step. 16:21:05 INFO - Running pre-action listener: _resource_record_pre_action 16:21:05 INFO - Running main action method: read_buildbot_config 16:21:05 INFO - Using buildbot properties: 16:21:05 INFO - { 16:21:05 INFO - "project": "", 16:21:05 INFO - "product": "firefox", 16:21:05 INFO - "script_repo_revision": "production", 16:21:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:21:05 INFO - "repository": "", 16:21:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:21:05 INFO - "buildid": "20170313135836", 16:21:05 INFO - "pgo_build": "False", 16:21:05 INFO - "basedir": "/builds/slave/test", 16:21:05 INFO - "buildnumber": 171, 16:21:05 INFO - "slavename": "t-yosemite-r7-0217", 16:21:05 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:21:05 INFO - "platform": "yosemite_r7", 16:21:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:21:05 INFO - "branch": "mozilla-central", 16:21:05 INFO - "repo_path": "mozilla-central", 16:21:05 INFO - "revision": "727412152afc7cf3530ce0fd9f2199aa84aa33a0", 16:21:05 INFO - "stage_platform": "macosx64", 16:21:05 INFO - "builduid": "c324be7f3927488faac2d81d5221d170", 16:21:05 INFO - "slavebuilddir": "test" 16:21:05 INFO - } 16:21:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:21:05 INFO - Running post-action listener: _resource_record_post_action 16:21:05 INFO - [mozharness: 2017-03-13 23:21:05.899303Z] Finished read-buildbot-config step (success) 16:21:05 INFO - [mozharness: 2017-03-13 23:21:05.899402Z] Running download-and-extract step. 16:21:05 INFO - Running pre-action listener: _resource_record_pre_action 16:21:05 INFO - Running main action method: download_and_extract 16:21:05 INFO - mkdir: /builds/slave/test/build/tests 16:21:05 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')]} 16:21:05 INFO - trying https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:21:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:21:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:21:07 INFO - Downloaded 1199 bytes. 16:21:07 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:21:07 INFO - Using the following test package requirements: 16:21:07 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:21:07 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:21:07 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:21:07 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'jsshell-mac.zip'], 16:21:07 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:21:07 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:21:07 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:21:07 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:21:07 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:21:07 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:21:07 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:21:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:21:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:21:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:21:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:21:08 INFO - Expected file size: 52474089 16:21:08 INFO - Obtained file size: 52474089 16:21:24 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:21:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:21:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:21:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:21:27 INFO - Expected file size: 52474089 16:21:27 INFO - Obtained file size: 52474089 16:21:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:21:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:21:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:21:43 INFO - Expected file size: 14404438 16:21:43 INFO - Obtained file size: 14404438 16:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:43 INFO - trying https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:21:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:21:45 INFO - Downloaded 74871608 bytes. 16:21:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:21:45 INFO - mkdir: /builds/slave/test/properties 16:21:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:45 INFO - Contents: 16:21:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:21:46 INFO - Running post-action listener: _resource_record_post_action 16:21:46 INFO - Running post-action listener: set_extra_try_arguments 16:21:46 INFO - [mozharness: 2017-03-13 23:21:46.603876Z] Finished download-and-extract step (success) 16:21:46 INFO - [mozharness: 2017-03-13 23:21:46.603996Z] Running populate-webroot step. 16:21:46 INFO - Running pre-action listener: _resource_record_pre_action 16:21:46 INFO - Running main action method: populate_webroot 16:21:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:46 INFO - '--tppagecycles', 16:21:46 INFO - '7'], 16:21:46 INFO - 'tests': ['tsvgm']}}, 16:21:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:21:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:21:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:21:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:21:46 INFO - 'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:21:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:21:46 INFO - 'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['damp', 'tps']}, 16:21:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:21:46 INFO - 'tests': ['damp', 'tps']}, 16:21:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['dromaeo_dom']}, 16:21:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['basic_compositor_video']}, 16:21:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:21:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['a11yr', 16:21:46 INFO - 'ts_paint', 16:21:46 INFO - 'tpaint', 16:21:46 INFO - 'sessionrestore', 16:21:46 INFO - 'sessionrestore_no_auto_restore', 16:21:46 INFO - 'tabpaint']}, 16:21:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:21:46 INFO - 'ts_paint', 16:21:46 INFO - 'tpaint', 16:21:46 INFO - 'sessionrestore', 16:21:46 INFO - 'sessionrestore_no_auto_restore', 16:21:46 INFO - 'tabpaint']}, 16:21:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:21:46 INFO - 'ts_paint', 16:21:46 INFO - 'tpaint', 16:21:46 INFO - 'sessionrestore', 16:21:46 INFO - 'sessionrestore_no_auto_restore', 16:21:46 INFO - 'tabpaint']}, 16:21:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:21:46 INFO - 'ts_paint', 16:21:46 INFO - 'tpaint', 16:21:46 INFO - 'sessionrestore', 16:21:46 INFO - 'sessionrestore_no_auto_restore', 16:21:46 INFO - 'tabpaint']}, 16:21:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['a11yr', 16:21:46 INFO - 'ts_paint', 16:21:46 INFO - 'tpaint', 16:21:46 INFO - 'sessionrestore', 16:21:46 INFO - 'sessionrestore_no_auto_restore', 16:21:46 INFO - 'tabpaint']}, 16:21:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['a11yr', 16:21:46 INFO - 'ts_paint', 16:21:46 INFO - 'tpaint', 16:21:46 INFO - 'sessionrestore', 16:21:46 INFO - 'sessionrestore_no_auto_restore', 16:21:46 INFO - 'tabpaint']}, 16:21:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['tsvgx', 16:21:46 INFO - 'tsvgr_opacity', 16:21:46 INFO - 'tart', 16:21:46 INFO - 'tscrollx', 16:21:46 INFO - 'cart', 16:21:46 INFO - 'tsvg_static']}, 16:21:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:21:46 INFO - 'tsvgr_opacity', 16:21:46 INFO - 'tart', 16:21:46 INFO - 'tscrollx', 16:21:46 INFO - 'cart', 16:21:46 INFO - 'tsvg_static']}, 16:21:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:21:46 INFO - 'talos_options': ['--disable-e10s'], 16:21:46 INFO - 'tests': ['tp5o']}, 16:21:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:21:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:21:46 INFO - 'talos_options': ['--disable-e10s', 16:21:46 INFO - '--xperf_path', 16:21:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:46 INFO - 'tests': ['tp5n']}, 16:21:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:21:46 INFO - 'talos_options': ['--xperf_path', 16:21:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:46 INFO - 'tests': ['tp5n']}}, 16:21:46 INFO - 'talos.zip': {'path': '', 16:21:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:46 INFO - Running post-action listener: _resource_record_post_action 16:21:46 INFO - [mozharness: 2017-03-13 23:21:46.622082Z] Finished populate-webroot step (success) 16:21:46 INFO - [mozharness: 2017-03-13 23:21:46.622191Z] Running create-virtualenv step. 16:21:46 INFO - Running pre-action listener: _resource_record_pre_action 16:21:46 INFO - Running main action method: create_virtualenv 16:21:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:46 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 16:21:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:46 INFO - Using real prefix '/tools/python27' 16:21:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:50 INFO - Installing pip.................done. 16:21:50 INFO - Return code: 0 16:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:21:50 INFO - Reading from file tmpfile_stdout 16:21:50 INFO - Output received: 16:21:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:21:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:50 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')]} 16:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:50 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')]} 16:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:50 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:21:50 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 16:21:50 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 16:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:50 INFO - 'HOME': '/Users/cltbld', 16:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:50 INFO - 'LOGNAME': 'cltbld', 16:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:50 INFO - 'MOZ_NO_REMOTE': '1', 16:21:50 INFO - 'NO_EM_RESTART': '1', 16:21:50 INFO - 'PAGER': '/bin/cat', 16:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:50 INFO - 'PWD': '/builds/slave/test', 16:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:50 INFO - 'SHELL': '/bin/bash', 16:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:21:50 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:50 INFO - 'USER': 'cltbld', 16:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:50 INFO - 'XPC_FLAGS': '0x0', 16:21:50 INFO - 'XPC_SERVICE_NAME': '0', 16:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:50 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 16:21:50 INFO - Cleaning up... 16:21:50 INFO - Return code: 0 16:21:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:21:50 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')]} 16:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:50 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')]} 16:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:50 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:21:50 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 16:21:50 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 16:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:50 INFO - 'HOME': '/Users/cltbld', 16:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:50 INFO - 'LOGNAME': 'cltbld', 16:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:50 INFO - 'MOZ_NO_REMOTE': '1', 16:21:50 INFO - 'NO_EM_RESTART': '1', 16:21:50 INFO - 'PAGER': '/bin/cat', 16:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:50 INFO - 'PWD': '/builds/slave/test', 16:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:50 INFO - 'SHELL': '/bin/bash', 16:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:21:50 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:50 INFO - 'USER': 'cltbld', 16:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:50 INFO - 'XPC_FLAGS': '0x0', 16:21:50 INFO - 'XPC_SERVICE_NAME': '0', 16:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:51 INFO - Downloading/unpacking psutil>=3.1.1 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:54 INFO - Installing collected packages: psutil 16:21:54 INFO - Running setup.py install for psutil 16:21:54 INFO - building 'psutil._psutil_osx' extension 16:21:54 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 16:21:55 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 16:21:55 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 16:21:55 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 16:21:55 INFO - building 'psutil._psutil_posix' extension 16:21:55 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 16:21:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:21:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:21:55 INFO - ^ 16:21:55 INFO - 1 warning generated. 16:21:55 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 16:21:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:55 INFO - Successfully installed psutil 16:21:55 INFO - Cleaning up... 16:21:55 INFO - Return code: 0 16:21:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:21:55 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')]} 16:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:55 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')]} 16:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:55 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:21:55 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 16:21:55 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 16:21:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:21:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:55 INFO - 'HOME': '/Users/cltbld', 16:21:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:55 INFO - 'LOGNAME': 'cltbld', 16:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:55 INFO - 'MOZ_NO_REMOTE': '1', 16:21:55 INFO - 'NO_EM_RESTART': '1', 16:21:55 INFO - 'PAGER': '/bin/cat', 16:21:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:55 INFO - 'PWD': '/builds/slave/test', 16:21:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:55 INFO - 'SHELL': '/bin/bash', 16:21:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:21:55 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:21:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:55 INFO - 'USER': 'cltbld', 16:21:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:55 INFO - 'XPC_FLAGS': '0x0', 16:21:55 INFO - 'XPC_SERVICE_NAME': '0', 16:21:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:21:56 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 16:21:56 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 16:21:56 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 16:21:56 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 16:21:56 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 16:21:56 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 16:21:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:21:58 INFO - Installing collected packages: mozsystemmonitor 16:21:58 INFO - Running setup.py install for mozsystemmonitor 16:21:58 INFO - Successfully installed mozsystemmonitor 16:21:58 INFO - Cleaning up... 16:21:58 INFO - Return code: 0 16:21:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:21:58 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')]} 16:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:21:59 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 16:21:59 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 16:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:59 INFO - 'HOME': '/Users/cltbld', 16:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:59 INFO - 'LOGNAME': 'cltbld', 16:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:59 INFO - 'MOZ_NO_REMOTE': '1', 16:21:59 INFO - 'NO_EM_RESTART': '1', 16:21:59 INFO - 'PAGER': '/bin/cat', 16:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:59 INFO - 'PWD': '/builds/slave/test', 16:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:59 INFO - 'SHELL': '/bin/bash', 16:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:21:59 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:59 INFO - 'USER': 'cltbld', 16:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:59 INFO - 'XPC_FLAGS': '0x0', 16:21:59 INFO - 'XPC_SERVICE_NAME': '0', 16:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:59 INFO - Downloading/unpacking jsonschema==2.5.1 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:22:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:22:03 INFO - warning: no files found matching '*.txt' 16:22:03 INFO - no previously-included directories found matching 'build' 16:22:03 INFO - no previously-included directories found matching 'dist' 16:22:03 INFO - no previously-included directories found matching '.git*' 16:22:03 INFO - Installing collected packages: jsonschema, functools32 16:22:03 INFO - Running setup.py install for functools32 16:22:03 INFO - warning: no files found matching '*.txt' 16:22:03 INFO - no previously-included directories found matching 'build' 16:22:03 INFO - no previously-included directories found matching 'dist' 16:22:03 INFO - no previously-included directories found matching '.git*' 16:22:03 INFO - Successfully installed jsonschema functools32 16:22:03 INFO - Cleaning up... 16:22:03 INFO - Return code: 0 16:22:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:03 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:22:03 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 16:22:03 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 16:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:03 INFO - 'HOME': '/Users/cltbld', 16:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:03 INFO - 'LOGNAME': 'cltbld', 16:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:03 INFO - 'MOZ_NO_REMOTE': '1', 16:22:03 INFO - 'NO_EM_RESTART': '1', 16:22:03 INFO - 'PAGER': '/bin/cat', 16:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:03 INFO - 'PWD': '/builds/slave/test', 16:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:03 INFO - 'SHELL': '/bin/bash', 16:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:22:03 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:03 INFO - 'USER': 'cltbld', 16:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:03 INFO - 'XPC_FLAGS': '0x0', 16:22:03 INFO - 'XPC_SERVICE_NAME': '0', 16:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:22:04 INFO - Cleaning up... 16:22:04 INFO - Return code: 0 16:22:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:04 INFO - 'HOME': '/Users/cltbld', 16:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:04 INFO - 'LOGNAME': 'cltbld', 16:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:04 INFO - 'MOZ_NO_REMOTE': '1', 16:22:04 INFO - 'NO_EM_RESTART': '1', 16:22:04 INFO - 'PAGER': '/bin/cat', 16:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:04 INFO - 'PWD': '/builds/slave/test', 16:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:04 INFO - 'SHELL': '/bin/bash', 16:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:22:04 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:04 INFO - 'USER': 'cltbld', 16:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:04 INFO - 'XPC_FLAGS': '0x0', 16:22:04 INFO - 'XPC_SERVICE_NAME': '0', 16:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:04 INFO - Downloading/unpacking blobuploader==1.2.4 16:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:06 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:08 INFO - Downloading docopt-0.6.1.tar.gz 16:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:08 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:08 INFO - Running setup.py install for blobuploader 16:22:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:08 INFO - Running setup.py install for requests 16:22:09 INFO - Running setup.py install for docopt 16:22:09 INFO - Successfully installed blobuploader requests docopt 16:22:09 INFO - Cleaning up... 16:22:09 INFO - Return code: 0 16:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:09 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:22:09 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 16:22:09 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 16:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:09 INFO - 'HOME': '/Users/cltbld', 16:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:09 INFO - 'LOGNAME': 'cltbld', 16:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:09 INFO - 'MOZ_NO_REMOTE': '1', 16:22:09 INFO - 'NO_EM_RESTART': '1', 16:22:09 INFO - 'PAGER': '/bin/cat', 16:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:09 INFO - 'PWD': '/builds/slave/test', 16:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:09 INFO - 'SHELL': '/bin/bash', 16:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:22:09 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:09 INFO - 'USER': 'cltbld', 16:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:09 INFO - 'XPC_FLAGS': '0x0', 16:22:09 INFO - 'XPC_SERVICE_NAME': '0', 16:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:09 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-YNj7Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:09 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-chz5gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:09 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-vumbZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:09 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-I_Lh5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:09 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-JXRfSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-F9rPT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-50e8oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-qZQZV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-5m5p6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-0pQ9dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-3bh9_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-NeSlHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-g5j4mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:10 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-2TuGD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:11 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-wQfCK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:11 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-LcRZa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:11 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-Hf87Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:11 INFO - Running setup.py install for manifestparser 16:22:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:11 INFO - Running setup.py install for mozcrash 16:22:11 INFO - Running setup.py install for mozdebug 16:22:11 INFO - Running setup.py install for mozdevice 16:22:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:22:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:22:11 INFO - Running setup.py install for mozfile 16:22:12 INFO - Running setup.py install for mozhttpd 16:22:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Running setup.py install for mozinfo 16:22:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Running setup.py install for mozInstall 16:22:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Running setup.py install for mozleak 16:22:12 INFO - Running setup.py install for mozlog 16:22:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Running setup.py install for moznetwork 16:22:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:22:12 INFO - Running setup.py install for mozprocess 16:22:13 INFO - Running setup.py install for mozprofile 16:22:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:22:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:22:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:22:13 INFO - Running setup.py install for mozrunner 16:22:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:22:13 INFO - Running setup.py install for mozscreenshot 16:22:13 INFO - Running setup.py install for moztest 16:22:13 INFO - Running setup.py install for mozversion 16:22:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:22:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:22:13 INFO - Cleaning up... 16:22:13 INFO - Return code: 0 16:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:13 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')]} 16:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:13 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')]} 16:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:13 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:22:13 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 16:22:13 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 16:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:13 INFO - 'HOME': '/Users/cltbld', 16:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:13 INFO - 'LOGNAME': 'cltbld', 16:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:13 INFO - 'MOZ_NO_REMOTE': '1', 16:22:13 INFO - 'NO_EM_RESTART': '1', 16:22:13 INFO - 'PAGER': '/bin/cat', 16:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:13 INFO - 'PWD': '/builds/slave/test', 16:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:13 INFO - 'SHELL': '/bin/bash', 16:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:22:13 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:13 INFO - 'USER': 'cltbld', 16:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:13 INFO - 'XPC_FLAGS': '0x0', 16:22:13 INFO - 'XPC_SERVICE_NAME': '0', 16:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-h76RH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:14 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)) 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-OtMblt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-9EPs2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:14 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)) 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-weExOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-O9RrJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:14 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)) 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-v1G4AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:14 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)) 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-0YqfXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:14 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)) 16:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:14 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-sLmTIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:15 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-KauUIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:15 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-LWmD4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:15 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-M4X6TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:15 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-DVOVsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-VJfhBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:15 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-iRFVuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-QhPB2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:15 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-tvfLTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 16:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:15 INFO - Running setup.py (path:/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/pip-uv4h0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:16 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)) 16:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:22:16 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)) 16:22:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:22:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:22:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:18 INFO - Downloading blessings-1.6.tar.gz 16:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:22:18 INFO - Installing collected packages: blessings 16:22:18 INFO - Running setup.py install for blessings 16:22:18 INFO - Successfully installed blessings 16:22:18 INFO - Cleaning up... 16:22:18 INFO - Return code: 0 16:22:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:19 INFO - Reading from file tmpfile_stdout 16:22:19 INFO - Current package versions: 16:22:19 INFO - blessings == 1.6 16:22:19 INFO - blobuploader == 1.2.4 16:22:19 INFO - docopt == 0.6.1 16:22:19 INFO - functools32 == 3.2.3-2 16:22:19 INFO - jsonschema == 2.5.1 16:22:19 INFO - manifestparser == 1.1 16:22:19 INFO - mozInstall == 1.12 16:22:19 INFO - mozcrash == 1.0 16:22:19 INFO - mozdebug == 0.1 16:22:19 INFO - mozdevice == 0.49 16:22:19 INFO - mozfile == 1.2 16:22:19 INFO - mozhttpd == 0.7 16:22:19 INFO - mozinfo == 0.9 16:22:19 INFO - mozleak == 0.1 16:22:19 INFO - mozlog == 3.4 16:22:19 INFO - moznetwork == 0.27 16:22:19 INFO - mozprocess == 0.25 16:22:19 INFO - mozprofile == 0.28 16:22:19 INFO - mozrunner == 6.13 16:22:19 INFO - mozscreenshot == 0.1 16:22:19 INFO - mozsystemmonitor == 0.3 16:22:19 INFO - moztest == 0.8 16:22:19 INFO - mozversion == 1.4 16:22:19 INFO - psutil == 3.1.1 16:22:19 INFO - requests == 1.2.3 16:22:19 INFO - wsgiref == 0.1.2 16:22:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:19 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')]} 16:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:19 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')]} 16:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:19 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:22:19 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 16:22:19 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 16:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:19 INFO - 'HOME': '/Users/cltbld', 16:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:19 INFO - 'LOGNAME': 'cltbld', 16:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:19 INFO - 'MOZ_NO_REMOTE': '1', 16:22:19 INFO - 'NO_EM_RESTART': '1', 16:22:19 INFO - 'PAGER': '/bin/cat', 16:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:19 INFO - 'PWD': '/builds/slave/test', 16:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:19 INFO - 'SHELL': '/bin/bash', 16:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:22:19 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:19 INFO - 'USER': 'cltbld', 16:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:19 INFO - 'XPC_FLAGS': '0x0', 16:22:19 INFO - 'XPC_SERVICE_NAME': '0', 16:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 INFO - Cleaning up... 16:22:19 INFO - Return code: 0 16:22:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:22:19 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')]} 16:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:19 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')]} 16:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:19 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 0x105f2fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f32768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc2d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, '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.RFN7zCysNS/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.GkcF5AkZjR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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 16:22:19 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 16:22:19 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 16:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:19 INFO - 'HOME': '/Users/cltbld', 16:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:19 INFO - 'LOGNAME': 'cltbld', 16:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:19 INFO - 'MOZ_NO_REMOTE': '1', 16:22:19 INFO - 'NO_EM_RESTART': '1', 16:22:19 INFO - 'PAGER': '/bin/cat', 16:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:19 INFO - 'PWD': '/builds/slave/test', 16:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:19 INFO - 'SHELL': '/bin/bash', 16:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:22:19 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:19 INFO - 'USER': 'cltbld', 16:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:19 INFO - 'XPC_FLAGS': '0x0', 16:22:19 INFO - 'XPC_SERVICE_NAME': '0', 16:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:22:19 INFO - Cleaning up... 16:22:19 INFO - Return code: 0 16:22:19 INFO - Running post-action listener: _resource_record_post_action 16:22:19 INFO - Running post-action listener: _start_resource_monitoring 16:22:19 INFO - Starting resource monitoring. 16:22:19 INFO - [mozharness: 2017-03-13 23:22:19.797204Z] Finished create-virtualenv step (success) 16:22:19 INFO - [mozharness: 2017-03-13 23:22:19.798235Z] Running install step. 16:22:19 INFO - Running pre-action listener: _resource_record_pre_action 16:22:19 INFO - Running main action method: install 16:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:20 INFO - Reading from file tmpfile_stdout 16:22:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:22:20 INFO - Reading from file tmpfile_stdout 16:22:20 INFO - Output received: 16:22:20 INFO - Usage: mozinstall [options] installer 16:22:20 INFO - Options: 16:22:20 INFO - -h, --help show this help message and exit 16:22:20 INFO - -d DEST, --destination=DEST 16:22:20 INFO - Directory to install application into. [default: 16:22:20 INFO - "/builds/slave/test"] 16:22:20 INFO - --app=APP Application being installed. [default: firefox] 16:22:20 INFO - mkdir: /builds/slave/test/build/application 16:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:22:40 INFO - Reading from file tmpfile_stdout 16:22:40 INFO - Output received: 16:22:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:22:40 INFO - Running post-action listener: _resource_record_post_action 16:22:40 INFO - [mozharness: 2017-03-13 23:22:40.406546Z] Finished install step (success) 16:22:40 INFO - [mozharness: 2017-03-13 23:22:40.406715Z] Running run-tests step. 16:22:40 INFO - Running pre-action listener: _resource_record_pre_action 16:22:40 INFO - Running main action method: run_tests 16:22:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:22:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:22:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:22:40 INFO - 2017-03-13 16:22:40.421 screenresolution[1623:7280] starting screenresolution argv=screenresolution get 16:22:40 INFO - 2017-03-13 16:22:40.423 screenresolution[1623:7280] Display 0: 1600x1200x32@60 16:22:40 INFO - 2017-03-13 16:22:40.429 screenresolution[1624:7283] starting screenresolution argv=screenresolution list 16:22:40 INFO - Available Modes on Display 0 16:22:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:22:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:22:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:22:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:22:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:22:40 INFO - Intel Iris: 16:22:40 INFO - Chipset Model: Intel Iris 16:22:40 INFO - Type: GPU 16:22:40 INFO - Bus: Built-In 16:22:40 INFO - VRAM (Dynamic, Max): 1536 MB 16:22:40 INFO - Vendor: Intel (0x8086) 16:22:40 INFO - Device ID: 0x0a2e 16:22:40 INFO - Revision ID: 0x0009 16:22:40 INFO - Displays: 16:22:40 INFO - Display: 16:22:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:22:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:22:40 INFO - Display Serial Number: 1600x1200 60 16:22:40 INFO - Main Display: Yes 16:22:40 INFO - Mirror: Off 16:22:40 INFO - Online: Yes 16:22:40 INFO - Rotation: Supported 16:22:40 INFO - Return code: 0 16:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:40 INFO - Python 2.7.3 16:22:40 INFO - Return code: 0 16:22:40 INFO - grabbing minidump binary from tooltool 16:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:40 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 0x105d0dd30>, '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 0x105c34db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d02be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:40 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 16:22:40 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 16:22:40 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 16:22:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:40 INFO - Return code: 0 16:22:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:22:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:40 INFO - ENV: RUST_BACKTRACE is now 1 16:22:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:22:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0217 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RFN7zCysNS/Render', 16:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:40 INFO - 'HOME': '/Users/cltbld', 16:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:40 INFO - 'LOGNAME': 'cltbld', 16:22:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:40 INFO - 'MOZ_NO_REMOTE': '1', 16:22:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:40 INFO - 'NO_EM_RESTART': '1', 16:22:40 INFO - 'PAGER': '/bin/cat', 16:22:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:40 INFO - 'PWD': '/builds/slave/test', 16:22:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:40 INFO - 'RUST_BACKTRACE': '1', 16:22:40 INFO - 'SHELL': '/bin/bash', 16:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkcF5AkZjR/Listeners', 16:22:40 INFO - 'TMPDIR': '/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/', 16:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:40 INFO - 'USER': 'cltbld', 16:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:40 INFO - 'XPC_FLAGS': '0x0', 16:22:40 INFO - 'XPC_SERVICE_NAME': '0', 16:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:22:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0217', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:22:41 INFO - mozversion application_buildid: 20170313135836 16:22:41 INFO - mozversion application_changeset: 727412152afc7cf3530ce0fd9f2199aa84aa33a0 16:22:41 INFO - mozversion application_display_name: Nightly 16:22:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:41 INFO - mozversion application_name: Firefox 16:22:41 INFO - mozversion application_remotingname: firefox 16:22:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:22:41 INFO - mozversion application_vendor: Mozilla 16:22:41 INFO - mozversion application_version: 55.0a1 16:22:41 INFO - mozversion platform_buildid: 20170313135836 16:22:41 INFO - mozversion platform_changeset: 727412152afc7cf3530ce0fd9f2199aa84aa33a0 16:22:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:22:41 INFO - mozversion platform_version: 55.0a1 16:22:41 INFO - using testdate: 1489447361 16:22:41 INFO - actual date: 1489447361 16:22:41 INFO - starting webserver on 'localhost:49235' 16:22:41 INFO - SUITE-START | Running 2 tests 16:22:41 INFO - TEST-START | dromaeo_css 16:22:41 INFO - operating with platform_type : mac_ 16:22:41 INFO - Initialising browser for dromaeo_css test... 16:22:41 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpVtGo66/profile http://localhost:49235/getInfo.html) 16:22:43 INFO - PID 1634 | 2017-03-13 16:22:43.823 plugin-container[1636:7467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 16:22:43 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:22:43 INFO - PID 1634 | 2017-03-13 16:22:43.825 plugin-container[1636:7467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 16:22:43 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:22:43 INFO - PID 1634 | 2017-03-13 16:22:43.825 plugin-container[1636:7467] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:22:43 INFO - PID 1634 | __metrics Screen width/height:1600/1200 16:22:43 INFO - PID 1634 | colorDepth:24 16:22:43 INFO - PID 1634 | Browser inner width/height: 1024/689 16:22:43 INFO - PID 1634 | __metrics 16:22:43 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:22:44 INFO - TEST-INFO | 1634: exit 0 16:22:44 INFO - Browser initialized. 16:22:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:22:44 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpVtGo66/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:47 INFO - PID 1637 | 2017-03-13 16:22:47.103 plugin-container[1638:7595] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 16:22:47 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:22:47 INFO - PID 1637 | 2017-03-13 16:22:47.103 plugin-container[1638:7595] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4423, name = 'com.apple.CFPasteboardClient' 16:22:47 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:22:47 INFO - PID 1637 | 2017-03-13 16:22:47.103 plugin-container[1638:7595] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:22:56 INFO - PID 1637 | RSS: Main: 227233792 16:22:56 INFO - PID 1637 | 16:25:59 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 16:26:01 INFO - PID 1637 | RSS: Main: 253448192 16:26:01 INFO - PID 1637 | 16:27:45 INFO - PID 1637 | ************************* 16:27:45 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 16:27:45 INFO - PID 1637 | 16:27:45 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:27:45 INFO - PID 1637 | Full stack: 16:27:45 INFO - PID 1637 | ************************* 16:29:04 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 16:29:04 INFO - PID 1637 | RSS: Main: 260505600 16:29:04 INFO - PID 1637 | 16:32:06 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 16:32:07 INFO - PID 1637 | RSS: Main: 273305600 16:32:07 INFO - PID 1637 | 16:35:09 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 16:35:09 INFO - PID 1637 | RSS: Main: 266199040 16:35:09 INFO - PID 1637 | 16:38:12 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 16:38:13 INFO - PID 1637 | RSS: Main: 275968000 16:38:13 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 16:41:16 INFO - PID 1637 | RSS: Main: 269770752 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | __start_tp_report 16:41:16 INFO - PID 1637 | _x_x_mozilla_page_load 16:41:16 INFO - PID 1637 | _x_x_mozilla_page_load_details 16:41:16 INFO - PID 1637 | |i|pagename|runs| 16:41:16 INFO - PID 1637 | |0;dojo.html;2589.663343765311;2880.438314528667;3414.6926776590103;3421.6749408806154;3441.518187453755;5716.514096301819;5733.054046082397;5736.913946290803;5769.192313076167;5812.738426770806;5773.278340207474;5824.534037277018;5852.4440178183;5871.383504732005;5952.136940143688;5148.948510514884;5186.818461353853;5206.088934436478;5280.313559237294;5355.973220133894;5325;5345.278387417688;5348.491893270133;5366.007288651593;5370.785168593252;5105.591552675795;5140.383154021504;5149.871253218699;5152.587792976553;5285.8942821143555;5164.767585458663;5239.449857764918;5251.317328747276;5257.316548848626;5274.208868669692;5199.688018718889;5216.973915130438;5261.1319132343115;5269.2886460327745;5301.6818990860675;4735.12400205963;5585.888282234332;5773.191753154561;5777.959967205901;5831.5334773218465;6161.876762464771;6162.352952939922;6263.217097862767;6273.843153921142;6289.937100628981;5500.669959802424;6073.511989562541;6280.905786413207;6286.245650521967;6286.308506064329;5920.851978700523;5963.910541341883;5972.910406343822;5974.731137098841;6001.129836173817;5272.499112584298;6181.690915454209;6249.562530622813;6297.842553936188;6309.526785491014;6048.546359023091;6111.816645500553;6113.908291375633;6133.3866613339205;6232.781852635227;6236.563440559208;6260.7495700171485;6293.590916590407;6293.779717709858;6296.5277604178955;6186.041163619646;6282.1519094921605;6289.308176100625;6290.370962903765;6291.370862913672;6103.822585931194;6193.411625895533;6208.534359923024;6281.057841323838;6285.748570057147;4915.311856340115;4968.478309777493;5039.319691841628;5074.391073071255;5080.898382032413;4494.483134439582;4494.5730155635165;4497.820087196541;4509.143262780061;4514.796834142471;4876.756162191876;6108.908366374508;6120.418560236771;6146.078088286793;6156.538259630545;6172.660503672251;6175.62946223228;6179.969100154471;6212.254529456494;6246;6111.04482360895;6113.962834745988;6125.784909797739;6128.203333566607;6129.970128114947;5558.833235002957;5580.972095139579;5585;5585.218069470277;5591.552675786009;6251.499880009497;6306.085617585516;6311.621302721851;6475.4819614430735;6533.085368048477;5116.616253780907;5163.66436181647;6257.4681152102585;6286;6292.811215663537;6454.806355809334;6493.253275873335;6530.902036469552;6539.444147247537;6565.671716414256;6072.969635151796;6138.357744607992;6273.278572964167;6276.968615156895;6317.873642527215;6132.936844521141;6157.84605384869;6215.160953271251;6235.189425374672;6242.875142497215;6124;6206.968965155145;6221.3156552778255;6222.128901953821;6224.06639004153;6003.189569408074;6009.849753756191;6045.576809623284;6061.848453788691;6069.150318955261;5020.548150666312;5857.853553661193;5960.582759206987;6104.053871649901;6129.267100814889;6153.1270356686155;6207.503399727921;6217.4715149212825;6221.09794079865;6225.533085018551;6074.149619053424;6075.422834830684;6082.36135205797;6085.2393450818645;6094.39056094387 16:41:16 INFO - PID 1637 | |1;ext.html;642.9678516074197;714.885618301072;805.0500409516768;872.3936863879602;876.62743334083;37399.81300093499;38183.236335273345;38284;38354.80822595886;38456.80771596142;37299.4405083924;37715.43426848593;37772.81113594435;37778;37818;7625.389968802482;7780.377569794431;10743.62397316094;10972.286801357926;11015.063719583844;10961.451927403637;11042.834357484644;11059.834102488468;11121.666350009473;11133.832992505118;11141.164412669043;11220.158488113384;11251.60619378322;11267.718307042307;11284.984351408371;11156.442177891113;11228.101751859831;11229.775404491946;11234.988851003367;11240.381779002151;10931.01620854119;11009.339439633648;11014.339139651647;11030.06244469221;11033.282836615675;38637.42043869344;38646;38798.612013879785;38822.611773882185;38901.610983890365;3817.1793064491267;3828.3874580067054;3829.9808500957597;3840.8079596020366;3846.3845784674318;26631;27711.307217319525;27874;28003.0198943036;28181.718182818113;3124.172094394987;3132.0916934089087;3160.984195079033;3172.619285685709;3218.7746857719967;271466.6426667854;273073;277120;313686;314536;47788.761056195195;47804.043919121425;47847.65066445385;47863.521364786604;47864;49432.50567494351;49676.274279429184;49712;49790.751046244535;49804.0039199214;14219.431222751182;14235.217063061424;14254.3585538651;14365.856341436662;14399.712005760035;12052.457639406248;12062.457189426497;12078.27530348182;12110.757784844254;12117.091218158497;12397.442115104843;12920;13760.587182384344;13825.861741382658;13886.722265554632;5383.461653834664;5956.047032474783;6092.603980741238;6120.479759220516;6151.72317245716;1085.3976043296047;1096.6984079378235;1106.856108705863;1108.3737688206138;1170.8653504847052;24085.061095390272;28435.00477483278;29259.97590084337;29612.851935740615;29960.70039299579;1065.5737704918095;1080.7733222792187;1090.3675867996542;1104.86741591008;1108.1910205549993;12724.363781810873;14067.085639433404;14672;14967.625809354635;14992.850071499146;458428;464932;466975;467701;468175;55168;55644.721776390856;56098;56183.43816561864;56218.15672764912;1385.1827421821174;1402.9438822446987;1434.777609470513;1437.9065360751517;1458.9927050364681;24050.27849164528;27952.860235698692;28349.866005359556;28783.280417989718;28835;47094.1162353502;49794.25308620446;49971.75014124906;50243.74878125586;50343.993120138126;377273;464974;466563;468404;469461;26639.067632632767;27555.17334479969;32128;33558.832205838815;35652.969497591956;35328.64671353254;42307.576924231595;42350.788246059805;42505.36241956435;44125.33811992758;35159.94520164399;35185;35497;36270.274594507435;36438.81780591186;34759.82620086883;34967.30065398627;35785.64214357823;35886.923392298275;35947.82026089853;34353.828230858686;34894.65105349015;35267;35498.645013550566;35682;27511.17466476009;30164.396712065198;31645.20886977844;31717;31741.36517269688;19578.314758983368;22718;23757.812109394807;23978.52042959096;24340.148094816595 16:41:16 INFO - PID 1637 | |2;jquery.html;355.8629927477921;397.93036218661763;409.2960108613186;425.94462719846416;428.97047086991216;14240.857591424083;20719.792802071974;21010;21512.38657100716;21549.24577639783;21231.15075396982;21309.57380852382;21367.67948480774;22460.213892513766;22481.437964050867;6409.711562979665;6678.933210667904;6735.764248251312;6750.088738020353;6757;6435.8391040223905;6506.934930650704;6557.737690492375;6612.206535215781;6696.1629796275465;6638.634875081869;6638.634875081869;6654.534182607219;6654.600723956554;6658.6670666466725;6372.522060845432;6544.934550654504;6565.441937435324;6594.340565943391;6598.439132673729;6306.621602703853;6335.429811316957;6410.423061924449;6420.0690899819265;6437.356264373525;26206.73793262062;26369.494897984852;26406.943722251086;26594.069207577835;26652.73347266541;2855.4003659231585;2859.0850927703145;2868.6557613086356;2908.5346344584977;2916.47503449379;15318.463853765064;15982.881198316123;15999.20003999807;16439.424620138358;16590.004599724056;1731.9521689377998;1965.7542807149107;1997.3308941504613;2026.5136367271896;2030.8883011434366;127253.09120363202;151217;159920;162008;162538;21913.890430548065;22326.55346893053;22513.437164070703;22629.321120366087;22630.886845565667;34572;34577;34719.479207811906;34850.166481686996;34964.47553286703;10106.595736170471;10260.333078349884;10352.792944141074;10432.478376081317;10652.786944261226;7220.74727384539;8096.583097957834;8178.550179740052;8287.171282871785;8480.533570653673;10243.38539687621;10429.165666746641;10520.894791052144;10736.315921019745;10752.623658171926;4431.667624928079;4510.624259600853;4513.6233448797775;4544.818207271738;4553.704009239389;736.5543845973216;756.3986630628664;819.3936486999578;922.4327038871046;938.1181689212119;22349.553008940056;22828.346268299585;22956.770432295463;23048.88475557645;23102;844.4890841041205;908.8545832666874;951.1582249709057;958.9664361747444;982.597135174575;11064.61692288464;11930.642080737593;11977;11984.700382490333;11991.880081199251;677704;686461;693554;704341;710480;106443;121580;140023;151276;157943.21028394785;1318.9934050329687;1322.6825561865082;1364.5565191312862;1374.2579007336126;1376.256821316478;21208.893955530122;21281.27577673932;21371.35885923425;21616.459588510414;21705.457363566038;61046.694766525885;61131.39593883527;61320;64177.67911160414;64600;90060;90159.54920225356;90483;91064.5446772762;91610;8389.496630201964;8849.867251991354;11421.771564568828;11553.653390398302;11616.709582260512;12757.298348590917;12802.423890924745;12927.806082908575;12958.481660733465;13098.345082746015;9030.36787424874;10943.179261555257;11072.39101849406;11086.334819910831;11334.886651133384;10346.430946298025;10449.529771160163;10717.517711702836;10721.356718596597;10766.623168189075;10761.784764304826;11091.779904210693;11141.83287250708;11666.300021998708;11766.88233117658;11365.31808091517;11455.541778328774;11659.708507287385;11702;11780.528778849093;10985.505652245509;11261.887381126084;11324.433778311217;11384.48769805344;11457.541698331974 16:41:16 INFO - PID 1637 | |3;mootools.html;1411.5694713112503;1509.7508911029674;1536.5236776599254;1572.5911263071598;1590.976135357969;10661.093807026393;10671.78656426872;10939.28894621849;10961.835572466409;11052.613158539452;10830.837537436924;11022.724431889186;11040.944795276013;11055.336679799218;11093.8335924961;2319.675245465636;2362.8582285062953;2373.821963352747;2378.5480758655885;2380.059876348841;2318.53629274145;2349.753275906031;2360.433495960974;2361.067378385537;2361.7047869016374;1980.762308522972;2270.137347807839;2299.655051742235;2301.551197516485;2302.838801283911;2300.3559003479054;2301.5051763870847;2318.5594736999915;2322.0827773029728;2322.8257880658934;2267.8774006866706;2296.517731276434;2322.419395151212;2327.813774898004;2327.976720232793;8201.671933122669;9549.761255968588;9892.851607225897;10951.288166269167;11069.114470842313;4858.659893807435;5665.348484924204;5908.409159084057;5915.290165180163;5929.644221346733;3122.2506598416444;3420.2133509292753;3521;3674.5223120994365;3719.237556300952;1135.8239472881717;1165.0912288414966;1171.420147027227;1176.452949378543;1234.9320787356692;13530.797038044437;13671.17972921628;14565.854341456556;15191.392344306214;15193.392264309414;4520.457545094544;4564.657650676212;4699.647526435531;4707.576318131316;4737.763111844394;9971.750706232257;11211.103111751041;11373.431328433546;11387.715307117389;11392.829107563393;5676.176954341598;5700.00249956256;5743.0811070228565;5743.54051675865;5753.108268218432;5095.261187127846;5165.948340516622;5227.686338819683;5259.184826351921;5276.445973172838;3772.773633581994;3855.132595166065;3874.7093967952515;3939.4878665773267;3946.625070618287;1049.338916482611;1051.2798732867857;1053.5996321397972;1062.4156713807374;1064.1912146768511;890.4568213389826;914.131575003749;915.6062892956093;940.7365937537501;940.9414408790111;6381.936180638134;6444.871102577922;6501.414872661483;6561.671916404161;6573.441257493071;970.8301047316692;975.4439969217619;1016.2479764973866;1028.1825948371063;1029.8352263637933;3787.2046870157023;4090.550039495653;4209.726367786084;4233.491980962242;4298.570142985739;13219;13541.187528748307;13616.591502254949;13673.521426750016;13697.520586779416;13046.47814087445;13219.272939988394;13455.259960702255;13580.759174736058;13591.388387522586;8606.483610983236;8903.06517815633;9557.139857412727;9874.555644995993;10019.849702254473;6056.394360563909;6261.8747625046335;6322.430981211713;6488.513361498001;6574.3754343337305;9924.305298629026;10745.925407459192;11010;11259.718507037061;11298.60454884075;11579.652610421701;11906.761864762482;11925.165238433226;11937.761244775229;12055.336956467478;8292.626831792462;8367.95816020916;8395.034571024411;8434.156584341517;8481.83036339282;10120.746981325232;10190.388576685422;10196.541155648161;10278.537465814206;10292.742681433025;8711;8869.113088691338;8905.643774249216;8983.416077954913;9011.774705632411;7589.58257295854;8685.131486851264;8741.038485766434;8987.966383865678;9049;7727.652255648397;7770.572618506037;7845.764627061198;7847.9607601961625;7853.371730261451;5647;5650.208970744181;5721.971390143022;5782.884342313214;5811.4188581143235;5717.456841600041;5797.333306669619;6021.789237376671;6044.546659000681;6065.787697430569 16:41:16 INFO - PID 1637 | |4;prototype.html;347.72877155818463;377.4806404223004;382.54477172165105;387.83904679557986;399.57844474079843;4744.810207591697;5062.696238225709;5513.58648101392;5551.805686800963;6076.453119219275;4545.6818022738335;5854;5898.52811775058;5909.5567832412635;5996.760129594811;3676.779393236401;4013.9598604014022;4868.537488938545;4955.166588362293;4958.404991401019;4133.793310334487;4441.844535441261;4864.0515099555605;4931.852044438672;4986.87532811679;3979.6816254699697;4917.655764096497;4960.528749768766;4960.87597810054;4961.255811628266;4518.909621807578;4559.886002849922;4898.363212782316;4999.450060493343;5003.624728145403;3444.6383129771266;4537.978954735191;4543.363929049936;4576.496585375606;4583.220852455091;5364.275822763916;5820.621659592155;5920.690930537094;5923.141144534062;5960.724758588637;4771.6898401603785;5033.219850923113;5060.84817455477;5547.417521160301;5628.802991895264;6457.225132984072;6489;6495.285518592951;6498.512611554105;6676.432503237231;4260.297050986584;4911.312416261726;5051.6716413433005;5057.367829021372;5059.3422855028975;5780;5781.248437703071;6167.845803854894;6733.6432248713045;6932.549384290055;4604.447466304065;5091.592672586258;5227.764750586232;5248.737563121828;5270.841874743764;5350.933290699097;5354.464553544614;5369.812056578001;5373.931036550878;5377.333026761717;4966.751662416865;5437.688982182556;5458;5744.655320680772;5783.768649253982;5842.503387212135;5869.64782113066;6040.731446396306;6466.902996455057;6506.4469520091325;1706.7114328681766;1764.8087540909835;1821.8360347568782;1832.386150639524;1837.898915559657;1147.2657499200518;1183.408295852074;1254.9395760582292;1317.55727478411;1350.716349566602;5678.68767217807;6174.38256174379;6189.3076511717545;6189.6286222826775;6209.441150296495;5763.538916886639;6170.704152128013;6269.7178626961895;6528.640924749089;6720.260771315151;5888.352281249059;5910.468057874812;6134.098429486784;6196.915539780521;6208.658523781145;2827.9010234641687;3212.887548935823;3483.641379861856;3525.347810655037;3543.911402214965;6796.422304104207;6929.549579277432;7005.50961432705;7046.43628509718;7058.894056640968;5842.766289348463;6482.611043337415;6753.29090445506;6836.6923488443135;6881.724731010803;6705.625346803893;6972.477064220204;6997.615131167631;7019.543729657556;7047.119110111236;5567.498925096761;5772.191893135048;6641.402273795382;6682.3317668232785;6692.83267918306;6206.782762603468;6503.187101612299;6618.503612229006;6622.04685080673;6656.800295991128;4946.851594452172;6075.756969721162;6480.671462350113;6560.015997600207;6640.701168447528;4456.910861782681;5019.3976722793495;5249.451411833595;5263.447338029452;5265.2365407015;6428.903566446414;6607.372299631527;6622.834429139118;6642.3025582315095;6688.230853451915;5486.780528778964;5902.527797776082;6008.738164985402;6455.709493072729;6481.675916204076;5922.644641321534;6072.210612620508;6211.596246243979;6406.615603063831;6457.9960424537085;6334.4932405406535;6358.141650877073;6379.808605741835;6400;6434.388733070351;5904.232449781501;6214.223222097238;6501.934980650133;6547.377999090078;6596.5052621052655;5772.249607550992;6255.437010669061;6312.05319202105;6356.68216589178;6383.234011918414 16:41:16 INFO - PID 1637 | |5;yui.html;676.516290852041;699.9300069993002;714.4248879651878;723.5007844587232;814.6904176412962;14639.853601463983;15559.299831507567;15569.766453503207;15572.221388930537;15603.219839008047;15661.373545058184;16450.506484805446;16603.252853621587;16615.66768664626;16619.169041547906;806.4677312973439;843.161054750524;921.6037104045258;930.0792215706435;952.509457629318;922.6447817590242;950.4582388038821;955.5508910811907;957.25812495316;957.7461972577272;988.7330420786384;997.7954519323557;999.1507218863944;999.6701088640731;999.8950110238429;978.7063880835757;989.48546755687;990.8365119755304;993.4188499727704;994.2294721590753;633.3729607688401;731.0715391452878;744.5383862005538;744.7430636430423;751.5528260684883;16183.838161618469;16544.75182872258;16731.16344182786;16750.4137355192;16932.830671693373;12216.938915305367;14826.332815023243;14915;14986.550403487912;15222.391104355813;11464.140189485823;11585.246958947642;11737.471813768401;11746.119041071954;11953.163278570504;3740.663340299386;3820.102275965146;3840.961590384088;3922.058705910561;3943.3887747398912;79113;81071.18928810695;88355.16448355178;91349;110241.44879275633;10943.25920104262;11250.718732031764;11363.659090227306;11399.316041037398;11723.706907327385;19659.607146953495;24783.380415489755;24786.752132478443;24888.37779055538;24903.377415564395;7742.806429839299;7811.843763124706;7815.57014364204;7899;7900.130985591695;3701.777893326409;4202.936955945664;4330.566943305707;4359.716618419792;4450.554944505524;3515.402381595135;3557.8932632021083;3616.150204701893;3618;3618.5295911531334;638.9009703495966;639;640.8013515810114;650.2164891305965;658.9950325753265;618.072890664004;629.6505439481132;642.4661195640349;676.3270545806855;686.6017709728345;9930.304878658424;10149.594016239416;10168.389896606228;10209.846852297222;10326.48367581618;573.9926429116956;601.1133577972456;603.8792241551707;628.355935166458;636.2174525333866;4694.413198350207;4812.759362031955;4885.8045678172475;4906.460289368238;4917;95893;96694;96772.0322796763;100664.49667751761;101656;67256.6637166811;69179.65410172917;69430.3056969434;69528.3047169532;83052;67263.99999999903;68442.9733553997;68587.97118043134;69061.27346816269;70456;9515.381500202742;10671.679849604525;10744.140468762324;10814.644623145508;11039.668809935714;44770.53762042989;44823.32765008593;46516.53483465122;46969;47330;52470;57757.711211443675;59343.10985335137;60160.09759853693;60517.394826051175;12279.570215042431;13100.803487947498;13306;13372.732545348845;13870.237136957565;13786.172829630254;14153.07577285537;14171.149731016172;14225.359858806585;14430.278486075444;13114.475420983053;13346.933265333999;13378.732425351243;13433.529826456028;14202.289885505477;12907.250658787876;13236.669083272995;13259.66850828737;13450.26023568713;13977.301134943416;12354.691132721753;12361;12977.416016279101;13667.514783730483;13979.510717124851;10701.411422371844;10792.244542881923;10884.945575272073;11539.307641541534;11579.363135027317;9200.447973121367;9522.809543809224;10672.146228301563;10683.626073087406;10768.730781730519 16:41:16 INFO - PID 1637 | __end_tp_report 16:41:16 INFO - PID 1637 | __start_cc_report 16:41:16 INFO - PID 1637 | _x_x_mozilla_cycle_collect,435 16:41:16 INFO - PID 1637 | __end_cc_report 16:41:16 INFO - PID 1637 | __startTimestamp1489448476696__endTimestamp 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | ------- Summary: start ------- 16:41:16 INFO - PID 1637 | Number of tests: 6 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:5773.87 Median:6075.42 stddev:682.81 (11.2%) stddev-sans-first:637.58 16:41:16 INFO - PID 1637 | Values: 2589.7 2880.4 3414.7 3421.7 3441.5 5716.5 5733.1 5736.9 5769.2 5812.7 5773.3 5824.5 5852.4 5871.4 5952.1 5148.9 5186.8 5206.1 5280.3 5356.0 5325.0 5345.3 5348.5 5366.0 5370.8 5105.6 5140.4 5149.9 5152.6 5285.9 5164.8 5239.4 5251.3 5257.3 5274.2 5199.7 5217.0 5261.1 5269.3 5301.7 4735.1 5585.9 5773.2 5778.0 5831.5 6161.9 6162.4 6263.2 6273.8 6289.9 5500.7 6073.5 6280.9 6286.2 6286.3 5920.9 5963.9 5972.9 5974.7 6001.1 5272.5 6181.7 6249.6 6297.8 6309.5 6048.5 6111.8 6113.9 6133.4 6232.8 6236.6 6260.7 6293.6 6293.8 6296.5 6186.0 6282.2 6289.3 6290.4 6291.4 6103.8 6193.4 6208.5 6281.1 6285.7 4915.3 4968.5 5039.3 5074.4 5080.9 4494.5 4494.6 4497.8 4509.1 4514.8 4876.8 6108.9 6120.4 6146.1 6156.5 6172.7 6175.6 6180.0 6212.3 6246.0 6111.0 6114.0 6125.8 6128.2 6130.0 5558.8 5581.0 5585.0 5585.2 5591.6 6251.5 6306.1 6311.6 6475.5 6533.1 5116.6 5163.7 6257.5 6286.0 6292.8 6454.8 6493.3 6530.9 6539.4 6565.7 6073.0 6138.4 6273.3 6277.0 6317.9 6132.9 6157.8 6215.2 6235.2 6242.9 6124.0 6207.0 6221.3 6222.1 6224.1 6003.2 6009.8 6045.6 6061.8 6069.2 5020.5 5857.9 5960.6 6104.1 6129.3 6153.1 6207.5 6217.5 6221.1 6225.5 6074.1 6075.4 6082.4 6085.2 6094.4 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:54534.28 Median:31681.10 stddev:108756.00 (343.3%) stddev-sans-first:108985.82 16:41:16 INFO - PID 1637 | Values: 643.0 714.9 805.1 872.4 876.6 37399.8 38183.2 38284.0 38354.8 38456.8 37299.4 37715.4 37772.8 37778.0 37818.0 7625.4 7780.4 10743.6 10972.3 11015.1 10961.5 11042.8 11059.8 11121.7 11133.8 11141.2 11220.2 11251.6 11267.7 11285.0 11156.4 11228.1 11229.8 11235.0 11240.4 10931.0 11009.3 11014.3 11030.1 11033.3 38637.4 38646.0 38798.6 38822.6 38901.6 3817.2 3828.4 3830.0 3840.8 3846.4 26631.0 27711.3 27874.0 28003.0 28181.7 3124.2 3132.1 3161.0 3172.6 3218.8 271466.6 273073.0 277120.0 313686.0 314536.0 47788.8 47804.0 47847.7 47863.5 47864.0 49432.5 49676.3 49712.0 49790.8 49804.0 14219.4 14235.2 14254.4 14365.9 14399.7 12052.5 12062.5 12078.3 12110.8 12117.1 12397.4 12920.0 13760.6 13825.9 13886.7 5383.5 5956.0 6092.6 6120.5 6151.7 1085.4 1096.7 1106.9 1108.4 1170.9 24085.1 28435.0 29260.0 29612.9 29960.7 1065.6 1080.8 1090.4 1104.9 1108.2 12724.4 14067.1 14672.0 14967.6 14992.9 458428.0 464932.0 466975.0 467701.0 468175.0 55168.0 55644.7 56098.0 56183.4 56218.2 1385.2 1402.9 1434.8 1437.9 1459.0 24050.3 27952.9 28349.9 28783.3 28835.0 47094.1 49794.3 49971.8 50243.7 50344.0 377273.0 464974.0 466563.0 468404.0 469461.0 26639.1 27555.2 32128.0 33558.8 35653.0 35328.6 42307.6 42350.8 42505.4 44125.3 35159.9 35185.0 35497.0 36270.3 36438.8 34759.8 34967.3 35785.6 35886.9 35947.8 34353.8 34894.7 35267.0 35498.6 35682.0 27511.2 30164.4 31645.2 31717.0 31741.4 19578.3 22718.0 23757.8 23978.5 24340.1 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:41286.85 Median:22571.38 stddev:115972.97 (513.8%) stddev-sans-first:116257.58 16:41:16 INFO - PID 1637 | Values: 355.9 397.9 409.3 425.9 429.0 14240.9 20719.8 21010.0 21512.4 21549.2 21231.2 21309.6 21367.7 22460.2 22481.4 6409.7 6678.9 6735.8 6750.1 6757.0 6435.8 6506.9 6557.7 6612.2 6696.2 6638.6 6638.6 6654.5 6654.6 6658.7 6372.5 6544.9 6565.4 6594.3 6598.4 6306.6 6335.4 6410.4 6420.1 6437.4 26206.7 26369.5 26406.9 26594.1 26652.7 2855.4 2859.1 2868.7 2908.5 2916.5 15318.5 15982.9 15999.2 16439.4 16590.0 1732.0 1965.8 1997.3 2026.5 2030.9 127253.1 151217.0 159920.0 162008.0 162538.0 21913.9 22326.6 22513.4 22629.3 22630.9 34572.0 34577.0 34719.5 34850.2 34964.5 10106.6 10260.3 10352.8 10432.5 10652.8 7220.7 8096.6 8178.6 8287.2 8480.5 10243.4 10429.2 10520.9 10736.3 10752.6 4431.7 4510.6 4513.6 4544.8 4553.7 736.6 756.4 819.4 922.4 938.1 22349.6 22828.3 22956.8 23048.9 23102.0 844.5 908.9 951.2 959.0 982.6 11064.6 11930.6 11977.0 11984.7 11991.9 677704.0 686461.0 693554.0 704341.0 710480.0 106443.0 121580.0 140023.0 151276.0 157943.2 1319.0 1322.7 1364.6 1374.3 1376.3 21208.9 21281.3 21371.4 21616.5 21705.5 61046.7 61131.4 61320.0 64177.7 64600.0 90060.0 90159.5 90483.0 91064.5 91610.0 8389.5 8849.9 11421.8 11553.7 11616.7 12757.3 12802.4 12927.8 12958.5 13098.3 9030.4 10943.2 11072.4 11086.3 11334.9 10346.4 10449.5 10717.5 10721.4 10766.6 10761.8 11091.8 11141.8 11666.3 11766.9 11365.3 11455.5 11659.7 11702.0 11780.5 10985.5 11261.9 11324.4 11384.5 11457.5 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:6520.21 Median:3470.61 stddev:4029.63 (116.1%) stddev-sans-first:4022.65 16:41:16 INFO - PID 1637 | Values: 1411.6 1509.8 1536.5 1572.6 1591.0 10661.1 10671.8 10939.3 10961.8 11052.6 10830.8 11022.7 11040.9 11055.3 11093.8 2319.7 2362.9 2373.8 2378.5 2380.1 2318.5 2349.8 2360.4 2361.1 2361.7 1980.8 2270.1 2299.7 2301.6 2302.8 2300.4 2301.5 2318.6 2322.1 2322.8 2267.9 2296.5 2322.4 2327.8 2328.0 8201.7 9549.8 9892.9 10951.3 11069.1 4858.7 5665.3 5908.4 5915.3 5929.6 3122.3 3420.2 3521.0 3674.5 3719.2 1135.8 1165.1 1171.4 1176.5 1234.9 13530.8 13671.2 14565.9 15191.4 15193.4 4520.5 4564.7 4699.6 4707.6 4737.8 9971.8 11211.1 11373.4 11387.7 11392.8 5676.2 5700.0 5743.1 5743.5 5753.1 5095.3 5165.9 5227.7 5259.2 5276.4 3772.8 3855.1 3874.7 3939.5 3946.6 1049.3 1051.3 1053.6 1062.4 1064.2 890.5 914.1 915.6 940.7 940.9 6381.9 6444.9 6501.4 6561.7 6573.4 970.8 975.4 1016.2 1028.2 1029.8 3787.2 4090.6 4209.7 4233.5 4298.6 13219.0 13541.2 13616.6 13673.5 13697.5 13046.5 13219.3 13455.3 13580.8 13591.4 8606.5 8903.1 9557.1 9874.6 10019.8 6056.4 6261.9 6322.4 6488.5 6574.4 9924.3 10745.9 11010.0 11259.7 11298.6 11579.7 11906.8 11925.2 11937.8 12055.3 8292.6 8368.0 8395.0 8434.2 8481.8 10120.7 10190.4 10196.5 10278.5 10292.7 8711.0 8869.1 8905.6 8983.4 9011.8 7589.6 8685.1 8741.0 8988.0 9049.0 7727.7 7770.6 7845.8 7848.0 7853.4 5647.0 5650.2 5722.0 5782.9 5811.4 5717.5 5797.3 6021.8 6044.5 6065.8 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5342.14 Median:5831.56 stddev:1543.93 (26.5%) stddev-sans-first:1502.06 16:41:16 INFO - PID 1637 | Values: 347.7 377.5 382.5 387.8 399.6 4744.8 5062.7 5513.6 5551.8 6076.5 4545.7 5854.0 5898.5 5909.6 5996.8 3676.8 4014.0 4868.5 4955.2 4958.4 4133.8 4441.8 4864.1 4931.9 4986.9 3979.7 4917.7 4960.5 4960.9 4961.3 4518.9 4559.9 4898.4 4999.5 5003.6 3444.6 4538.0 4543.4 4576.5 4583.2 5364.3 5820.6 5920.7 5923.1 5960.7 4771.7 5033.2 5060.8 5547.4 5628.8 6457.2 6489.0 6495.3 6498.5 6676.4 4260.3 4911.3 5051.7 5057.4 5059.3 5780.0 5781.2 6167.8 6733.6 6932.5 4604.4 5091.6 5227.8 5248.7 5270.8 5350.9 5354.5 5369.8 5373.9 5377.3 4966.8 5437.7 5458.0 5744.7 5783.8 5842.5 5869.6 6040.7 6466.9 6506.4 1706.7 1764.8 1821.8 1832.4 1837.9 1147.3 1183.4 1254.9 1317.6 1350.7 5678.7 6174.4 6189.3 6189.6 6209.4 5763.5 6170.7 6269.7 6528.6 6720.3 5888.4 5910.5 6134.1 6196.9 6208.7 2827.9 3212.9 3483.6 3525.3 3543.9 6796.4 6929.5 7005.5 7046.4 7058.9 5842.8 6482.6 6753.3 6836.7 6881.7 6705.6 6972.5 6997.6 7019.5 7047.1 5567.5 5772.2 6641.4 6682.3 6692.8 6206.8 6503.2 6618.5 6622.0 6656.8 4946.9 6075.8 6480.7 6560.0 6640.7 4456.9 5019.4 5249.5 5263.4 5265.2 6428.9 6607.4 6622.8 6642.3 6688.2 5486.8 5902.5 6008.7 6455.7 6481.7 5922.6 6072.2 6211.6 6406.6 6458.0 6334.5 6358.1 6379.8 6400.0 6434.4 5904.2 6214.2 6501.9 6547.4 6596.5 5772.2 6255.4 6312.1 6356.7 6383.2 16:41:16 INFO - PID 1637 | 16:41:16 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:18982.72 Median:4266.75 stddev:25701.59 (602.4%) stddev-sans-first:25736.93 16:41:16 INFO - PID 1637 | Values: 676.5 699.9 714.4 723.5 814.7 14639.9 15559.3 15569.8 15572.2 15603.2 15661.4 16450.5 16603.3 16615.7 16619.2 806.5 843.2 921.6 930.1 952.5 922.6 950.5 955.6 957.3 957.7 988.7 997.8 999.2 999.7 999.9 978.7 989.5 990.8 993.4 994.2 633.4 731.1 744.5 744.7 751.6 16183.8 16544.8 16731.2 16750.4 16932.8 12216.9 14826.3 14915.0 14986.6 15222.4 11464.1 11585.2 11737.5 11746.1 11953.2 3740.7 3820.1 3841.0 3922.1 3943.4 79113.0 81071.2 88355.2 91349.0 110241.4 10943.3 11250.7 11363.7 11399.3 11723.7 19659.6 24783.4 24786.8 24888.4 24903.4 7742.8 7811.8 7815.6 7899.0 7900.1 3701.8 4202.9 4330.6 4359.7 4450.6 3515.4 3557.9 3616.2 3618.0 3618.5 638.9 639.0 640.8 650.2 659.0 618.1 629.7 642.5 676.3 686.6 9930.3 10149.6 10168.4 10209.8 10326.5 574.0 601.1 603.9 628.4 636.2 4694.4 4812.8 4885.8 4906.5 4917.0 95893.0 96694.0 96772.0 100664.5 101656.0 67256.7 69179.7 69430.3 69528.3 83052.0 67264.0 68443.0 68588.0 69061.3 70456.0 9515.4 10671.7 10744.1 10814.6 11039.7 44770.5 44823.3 46516.5 46969.0 47330.0 52470.0 57757.7 59343.1 60160.1 60517.4 12279.6 13100.8 13306.0 13372.7 13870.2 13786.2 14153.1 14171.1 14225.4 14430.3 13114.5 13346.9 13378.7 13433.5 14202.3 12907.3 13236.7 13259.7 13450.3 13977.3 12354.7 12361.0 12977.4 13667.5 13979.5 10701.4 10792.2 10884.9 11539.3 11579.4 9200.4 9522.8 10672.1 10683.6 10768.7 16:41:16 INFO - PID 1637 | -------- Summary: end -------- 16:41:16 INFO - PID 1637 | 16:41:17 INFO - TEST-INFO | 1637: exit 0 16:41:17 INFO - TEST-OK | dromaeo_css | took 1116349ms 16:41:17 INFO - TEST-START | kraken 16:41:17 INFO - operating with platform_type : mac_ 16:41:17 INFO - Initialising browser for kraken test... 16:41:17 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpEaaDvh/profile http://localhost:49235/getInfo.html) 16:41:20 INFO - PID 1650 | 2017-03-13 16:41:20.359 plugin-container[1651:10053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 16:41:20 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:41:20 INFO - PID 1650 | 2017-03-13 16:41:20.363 plugin-container[1651:10053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4713, name = 'com.apple.CFPasteboardClient' 16:41:20 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:41:20 INFO - PID 1650 | 2017-03-13 16:41:20.363 plugin-container[1651:10053] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:41:20 INFO - PID 1650 | __metrics Screen width/height:1600/1200 16:41:20 INFO - PID 1650 | colorDepth:24 16:41:20 INFO - PID 1650 | Browser inner width/height: 1024/689 16:41:20 INFO - PID 1650 | __metrics 16:41:20 ERROR - PID 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:41:21 INFO - TEST-INFO | 1650: exit 0 16:41:21 INFO - Browser initialized. 16:41:21 INFO - Running cycle 1/1 for kraken test... 16:41:21 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/tmpEaaDvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:23 INFO - PID 1652 | 2017-03-13 16:41:23.901 plugin-container[1653:10181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 16:41:23 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:41:23 INFO - PID 1652 | 2017-03-13 16:41:23.901 plugin-container[1653:10181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 16:41:23 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:41:23 INFO - PID 1652 | 2017-03-13 16:41:23.901 plugin-container[1653:10181] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:41:33 INFO - PID 1652 | RSS: Main: 228032512 16:41:33 INFO - PID 1652 | 16:41:36 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:37 INFO - PID 1652 | RSS: Main: 241623040 16:41:37 INFO - PID 1652 | 16:41:39 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 16:41:40 INFO - PID 1652 | RSS: Main: 250097664 16:41:40 INFO - PID 1652 | 16:41:43 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 16:41:44 INFO - PID 1652 | RSS: Main: 252690432 16:41:44 INFO - PID 1652 | 16:41:46 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 16:41:47 INFO - PID 1652 | RSS: Main: 254005248 16:41:47 INFO - PID 1652 | 16:41:49 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:49 INFO - PID 1652 | RSS: Main: 254308352 16:41:49 INFO - PID 1652 | 16:41:52 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:53 INFO - PID 1652 | RSS: Main: 260096000 16:41:53 INFO - PID 1652 | 16:41:56 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:57 INFO - PID 1652 | RSS: Main: 261517312 16:41:57 INFO - PID 1652 | 16:42:00 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 16:42:01 INFO - PID 1652 | RSS: Main: 261619712 16:42:01 INFO - PID 1652 | 16:42:02 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:03 INFO - PID 1652 | RSS: Main: 261238784 16:42:03 INFO - PID 1652 | 16:42:05 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:05 INFO - PID 1652 | RSS: Main: 261246976 16:42:05 INFO - PID 1652 | 16:42:08 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:08 INFO - PID 1652 | RSS: Main: 261312512 16:42:08 INFO - PID 1652 | 16:42:11 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:12 INFO - PID 1652 | RSS: Main: 261685248 16:42:12 INFO - PID 1652 | 16:42:15 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:16 INFO - PID 1652 | RSS: Main: 261455872 16:42:16 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 16:42:18 INFO - PID 1652 | RSS: Main: 263036928 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | __start_tp_report 16:42:18 INFO - PID 1652 | _x_x_mozilla_page_load 16:42:18 INFO - PID 1652 | _x_x_mozilla_page_load_details 16:42:18 INFO - PID 1652 | |i|pagename|runs| 16:42:18 INFO - PID 1652 | |0;ai-astar;112;123;120;119;121;120;120;151;149;156 16:42:18 INFO - PID 1652 | |1;audio-beat-detection;147;113;115;157;116;120;98;150;171;147 16:42:18 INFO - PID 1652 | |2;audio-dft;196;214;217;212;207;199;198;199;197;195 16:42:18 INFO - PID 1652 | |3;audio-fft;80;60;60;83;50;62;72;84;100;89 16:42:18 INFO - PID 1652 | |4;audio-oscillator;84;71;68;94;107;88;68;96;105;80 16:42:18 INFO - PID 1652 | |5;imaging-gaussian-blur;88;88;89;87;79;126;89;80;134;137 16:42:18 INFO - PID 1652 | |6;imaging-darkroom;96;97;96;136;100;153;132;96;97;99 16:42:18 INFO - PID 1652 | |7;imaging-desaturate;92;93;96;90;89;90;127;138;91;114 16:42:18 INFO - PID 1652 | |8;json-parse-financial;70;67;74;69;71;67;68;67;69;79 16:42:18 INFO - PID 1652 | |9;json-stringify-tinderbox;60;64;82;101;92;64;57;59;57;58 16:42:18 INFO - PID 1652 | |10;stanford-crypto-aes;85;84;83;84;88;86;84;85;85;87 16:42:18 INFO - PID 1652 | |11;stanford-crypto-ccm;141;159;130;148;162;150;154;154;196;144 16:42:18 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;190;189;188;186;187;181;188;192;210;243 16:42:18 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;70;68;72;76;100;84;66;70;66;75 16:42:18 INFO - PID 1652 | __end_tp_report 16:42:18 INFO - PID 1652 | __start_cc_report 16:42:18 INFO - PID 1652 | _x_x_mozilla_cycle_collect,994 16:42:18 INFO - PID 1652 | __end_cc_report 16:42:18 INFO - PID 1652 | __startTimestamp1489448538341__endTimestamp 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | ------- Summary: start ------- 16:42:18 INFO - PID 1652 | Number of tests: 14 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:129.10 Median:122.00 stddev:16.14 (13.2%) stddev-sans-first:15.89 16:42:18 INFO - PID 1652 | Values: 112.0 123.0 120.0 119.0 121.0 120.0 120.0 151.0 149.0 156.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:148.50 stddev:23.82 (16.0%) stddev-sans-first:24.75 16:42:18 INFO - PID 1652 | Values: 147.0 113.0 115.0 157.0 116.0 120.0 98.0 150.0 171.0 147.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:203.40 Median:203.00 stddev:8.29 (4.1%) stddev-sans-first:8.35 16:42:18 INFO - PID 1652 | Values: 196.0 214.0 217.0 212.0 207.0 199.0 198.0 199.0 197.0 195.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:74.00 Median:76.00 stddev:15.76 (20.7%) stddev-sans-first:16.56 16:42:18 INFO - PID 1652 | Values: 80.0 60.0 60.0 83.0 50.0 62.0 72.0 84.0 100.0 89.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:82.00 stddev:14.46 (17.6%) stddev-sans-first:15.32 16:42:18 INFO - PID 1652 | Values: 84.0 71.0 68.0 94.0 107.0 88.0 68.0 96.0 105.0 80.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:87.50 stddev:22.95 (26.2%) stddev-sans-first:23.95 16:42:18 INFO - PID 1652 | Values: 88.0 88.0 89.0 87.0 79.0 126.0 89.0 80.0 134.0 137.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:110.20 Median:96.00 stddev:21.49 (22.4%) stddev-sans-first:22.17 16:42:18 INFO - PID 1652 | Values: 96.0 97.0 96.0 136.0 100.0 153.0 132.0 96.0 97.0 99.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:90.50 stddev:17.83 (19.7%) stddev-sans-first:18.54 16:42:18 INFO - PID 1652 | Values: 92.0 93.0 96.0 90.0 89.0 90.0 127.0 138.0 91.0 114.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:70.10 Median:69.50 stddev:3.81 (5.5%) stddev-sans-first:4.04 16:42:18 INFO - PID 1652 | Values: 70.0 67.0 74.0 69.0 71.0 67.0 68.0 67.0 69.0 79.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:62.00 stddev:16.19 (26.1%) stddev-sans-first:16.82 16:42:18 INFO - PID 1652 | Values: 60.0 64.0 82.0 101.0 92.0 64.0 57.0 59.0 57.0 58.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.52 (1.8%) stddev-sans-first:1.62 16:42:18 INFO - PID 1652 | Values: 85.0 84.0 83.0 84.0 88.0 86.0 84.0 85.0 85.0 87.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:154.00 stddev:17.48 (11.3%) stddev-sans-first:17.91 16:42:18 INFO - PID 1652 | Values: 141.0 159.0 130.0 148.0 162.0 150.0 154.0 154.0 196.0 144.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:189.50 stddev:18.37 (9.7%) stddev-sans-first:19.38 16:42:18 INFO - PID 1652 | Values: 190.0 189.0 188.0 186.0 187.0 181.0 188.0 192.0 210.0 243.0 16:42:18 INFO - PID 1652 | 16:42:18 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:71.00 stddev:10.41 (14.7%) stddev-sans-first:10.91 16:42:18 INFO - PID 1652 | Values: 70.0 68.0 72.0 76.0 100.0 84.0 66.0 70.0 66.0 75.0 16:42:18 INFO - PID 1652 | -------- Summary: end -------- 16:42:18 INFO - PID 1652 | 16:42:19 INFO - TEST-INFO | 1652: exit 0 16:42:19 INFO - TEST-OK | kraken | took 61906ms 16:42:19 INFO - SUITE-END | took 1178s 16:42:19 INFO - Completed test suite (00:19:38) 16:42:19 INFO - javascript benchmark 16:42:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7817.2664977560225, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.663343765311, 2880.438314528667, 3414.6926776590103, 3421.6749408806154, 3441.518187453755, 5716.514096301819, 5733.054046082397, 5736.913946290803, 5769.192313076167, 5812.738426770806, 5773.278340207474, 5824.534037277018, 5852.4440178183, 5871.383504732005, 5952.136940143688, 5148.948510514884, 5186.818461353853, 5206.088934436478, 5280.313559237294, 5355.973220133894, 5325.0, 5345.278387417688, 5348.491893270133, 5366.007288651593, 5370.785168593252, 5105.591552675795, 5140.383154021504, 5149.871253218699, 5152.587792976553, 5285.8942821143555, 5164.767585458663, 5239.449857764918, 5251.317328747276, 5257.316548848626, 5274.208868669692, 5199.688018718889, 5216.973915130438, 5261.1319132343115, 5269.2886460327745, 5301.6818990860675, 4735.12400205963, 5585.888282234332, 5773.191753154561, 5777.959967205901, 5831.5334773218465, 6161.876762464771, 6162.352952939922, 6263.217097862767, 6273.843153921142, 6289.937100628981, 5500.669959802424, 6073.511989562541, 6280.905786413207, 6286.245650521967, 6286.308506064329, 5920.851978700523, 5963.910541341883, 5972.910406343822, 5974.731137098841, 6001.129836173817, 5272.499112584298, 6181.690915454209, 6249.562530622813, 6297.842553936188, 6309.526785491014, 6048.546359023091, 6111.816645500553, 6113.908291375633, 6133.3866613339205, 6232.781852635227, 6236.563440559208, 6260.7495700171485, 6293.590916590407, 6293.779717709858, 6296.5277604178955, 6186.041163619646, 6282.1519094921605, 6289.308176100625, 6290.370962903765, 6291.370862913672, 6103.822585931194, 6193.411625895533, 6208.534359923024, 6281.057841323838, 6285.748570057147, 4915.311856340115, 4968.478309777493, 5039.319691841628, 5074.391073071255, 5080.898382032413, 4494.483134439582, 4494.5730155635165, 4497.820087196541, 4509.143262780061, 4514.796834142471, 4876.756162191876, 6108.908366374508, 6120.418560236771, 6146.078088286793, 6156.538259630545, 6172.660503672251, 6175.62946223228, 6179.969100154471, 6212.254529456494, 6246.0, 6111.04482360895, 6113.962834745988, 6125.784909797739, 6128.203333566607, 6129.970128114947, 5558.833235002957, 5580.972095139579, 5585.0, 5585.218069470277, 5591.552675786009, 6251.499880009497, 6306.085617585516, 6311.621302721851, 6475.4819614430735, 6533.085368048477, 5116.616253780907, 5163.66436181647, 6257.4681152102585, 6286.0, 6292.811215663537, 6454.806355809334, 6493.253275873335, 6530.902036469552, 6539.444147247537, 6565.671716414256, 6072.969635151796, 6138.357744607992, 6273.278572964167, 6276.968615156895, 6317.873642527215, 6132.936844521141, 6157.84605384869, 6215.160953271251, 6235.189425374672, 6242.875142497215, 6124.0, 6206.968965155145, 6221.3156552778255, 6222.128901953821, 6224.06639004153, 6003.189569408074, 6009.849753756191, 6045.576809623284, 6061.848453788691, 6069.150318955261, 5020.548150666312, 5857.853553661193, 5960.582759206987, 6104.053871649901, 6129.267100814889, 6153.1270356686155, 6207.503399727921, 6217.4715149212825, 6221.09794079865, 6225.533085018551, 6074.149619053424, 6075.422834830684, 6082.36135205797, 6085.2393450818645, 6094.39056094387], "value": 5728.313988200309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.9678516074197, 714.885618301072, 805.0500409516768, 872.3936863879602, 876.62743334083, 37399.81300093499, 38183.236335273345, 38284.0, 38354.80822595886, 38456.80771596142, 37299.4405083924, 37715.43426848593, 37772.81113594435, 37778.0, 37818.0, 7625.389968802482, 7780.377569794431, 10743.62397316094, 10972.286801357926, 11015.063719583844, 10961.451927403637, 11042.834357484644, 11059.834102488468, 11121.666350009473, 11133.832992505118, 11141.164412669043, 11220.158488113384, 11251.60619378322, 11267.718307042307, 11284.984351408371, 11156.442177891113, 11228.101751859831, 11229.775404491946, 11234.988851003367, 11240.381779002151, 10931.01620854119, 11009.339439633648, 11014.339139651647, 11030.06244469221, 11033.282836615675, 38637.42043869344, 38646.0, 38798.612013879785, 38822.611773882185, 38901.610983890365, 3817.1793064491267, 3828.3874580067054, 3829.9808500957597, 3840.8079596020366, 3846.3845784674318, 26631.0, 27711.307217319525, 27874.0, 28003.0198943036, 28181.718182818113, 3124.172094394987, 3132.0916934089087, 3160.984195079033, 3172.619285685709, 3218.7746857719967, 271466.6426667854, 273073.0, 277120.0, 313686.0, 314536.0, 47788.761056195195, 47804.043919121425, 47847.65066445385, 47863.521364786604, 47864.0, 49432.50567494351, 49676.274279429184, 49712.0, 49790.751046244535, 49804.0039199214, 14219.431222751182, 14235.217063061424, 14254.3585538651, 14365.856341436662, 14399.712005760035, 12052.457639406248, 12062.457189426497, 12078.27530348182, 12110.757784844254, 12117.091218158497, 12397.442115104843, 12920.0, 13760.587182384344, 13825.861741382658, 13886.722265554632, 5383.461653834664, 5956.047032474783, 6092.603980741238, 6120.479759220516, 6151.72317245716, 1085.3976043296047, 1096.6984079378235, 1106.856108705863, 1108.3737688206138, 1170.8653504847052, 24085.061095390272, 28435.00477483278, 29259.97590084337, 29612.851935740615, 29960.70039299579, 1065.5737704918095, 1080.7733222792187, 1090.3675867996542, 1104.86741591008, 1108.1910205549993, 12724.363781810873, 14067.085639433404, 14672.0, 14967.625809354635, 14992.850071499146, 458428.0, 464932.0, 466975.0, 467701.0, 468175.0, 55168.0, 55644.721776390856, 56098.0, 56183.43816561864, 56218.15672764912, 1385.1827421821174, 1402.9438822446987, 1434.777609470513, 1437.9065360751517, 1458.9927050364681, 24050.27849164528, 27952.860235698692, 28349.866005359556, 28783.280417989718, 28835.0, 47094.1162353502, 49794.25308620446, 49971.75014124906, 50243.74878125586, 50343.993120138126, 377273.0, 464974.0, 466563.0, 468404.0, 469461.0, 26639.067632632767, 27555.17334479969, 32128.0, 33558.832205838815, 35652.969497591956, 35328.64671353254, 42307.576924231595, 42350.788246059805, 42505.36241956435, 44125.33811992758, 35159.94520164399, 35185.0, 35497.0, 36270.274594507435, 36438.81780591186, 34759.82620086883, 34967.30065398627, 35785.64214357823, 35886.923392298275, 35947.82026089853, 34353.828230858686, 34894.65105349015, 35267.0, 35498.645013550566, 35682.0, 27511.17466476009, 30164.396712065198, 31645.20886977844, 31717.0, 31741.36517269688, 19578.314758983368, 22718.0, 23757.812109394807, 23978.52042959096, 24340.148094816595], "value": 18908.50560295151, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.8629927477921, 397.93036218661763, 409.2960108613186, 425.94462719846416, 428.97047086991216, 14240.857591424083, 20719.792802071974, 21010.0, 21512.38657100716, 21549.24577639783, 21231.15075396982, 21309.57380852382, 21367.67948480774, 22460.213892513766, 22481.437964050867, 6409.711562979665, 6678.933210667904, 6735.764248251312, 6750.088738020353, 6757.0, 6435.8391040223905, 6506.934930650704, 6557.737690492375, 6612.206535215781, 6696.1629796275465, 6638.634875081869, 6638.634875081869, 6654.534182607219, 6654.600723956554, 6658.6670666466725, 6372.522060845432, 6544.934550654504, 6565.441937435324, 6594.340565943391, 6598.439132673729, 6306.621602703853, 6335.429811316957, 6410.423061924449, 6420.0690899819265, 6437.356264373525, 26206.73793262062, 26369.494897984852, 26406.943722251086, 26594.069207577835, 26652.73347266541, 2855.4003659231585, 2859.0850927703145, 2868.6557613086356, 2908.5346344584977, 2916.47503449379, 15318.463853765064, 15982.881198316123, 15999.20003999807, 16439.424620138358, 16590.004599724056, 1731.9521689377998, 1965.7542807149107, 1997.3308941504613, 2026.5136367271896, 2030.8883011434366, 127253.09120363202, 151217.0, 159920.0, 162008.0, 162538.0, 21913.890430548065, 22326.55346893053, 22513.437164070703, 22629.321120366087, 22630.886845565667, 34572.0, 34577.0, 34719.479207811906, 34850.166481686996, 34964.47553286703, 10106.595736170471, 10260.333078349884, 10352.792944141074, 10432.478376081317, 10652.786944261226, 7220.74727384539, 8096.583097957834, 8178.550179740052, 8287.171282871785, 8480.533570653673, 10243.38539687621, 10429.165666746641, 10520.894791052144, 10736.315921019745, 10752.623658171926, 4431.667624928079, 4510.624259600853, 4513.6233448797775, 4544.818207271738, 4553.704009239389, 736.5543845973216, 756.3986630628664, 819.3936486999578, 922.4327038871046, 938.1181689212119, 22349.553008940056, 22828.346268299585, 22956.770432295463, 23048.88475557645, 23102.0, 844.4890841041205, 908.8545832666874, 951.1582249709057, 958.9664361747444, 982.597135174575, 11064.61692288464, 11930.642080737593, 11977.0, 11984.700382490333, 11991.880081199251, 677704.0, 686461.0, 693554.0, 704341.0, 710480.0, 106443.0, 121580.0, 140023.0, 151276.0, 157943.21028394785, 1318.9934050329687, 1322.6825561865082, 1364.5565191312862, 1374.2579007336126, 1376.256821316478, 21208.893955530122, 21281.27577673932, 21371.35885923425, 21616.459588510414, 21705.457363566038, 61046.694766525885, 61131.39593883527, 61320.0, 64177.67911160414, 64600.0, 90060.0, 90159.54920225356, 90483.0, 91064.5446772762, 91610.0, 8389.496630201964, 8849.867251991354, 11421.771564568828, 11553.653390398302, 11616.709582260512, 12757.298348590917, 12802.423890924745, 12927.806082908575, 12958.481660733465, 13098.345082746015, 9030.36787424874, 10943.179261555257, 11072.39101849406, 11086.334819910831, 11334.886651133384, 10346.430946298025, 10449.529771160163, 10717.517711702836, 10721.356718596597, 10766.623168189075, 10761.784764304826, 11091.779904210693, 11141.83287250708, 11666.300021998708, 11766.88233117658, 11365.31808091517, 11455.541778328774, 11659.708507287385, 11702.0, 11780.528778849093, 10985.505652245509, 11261.887381126084, 11324.433778311217, 11384.48769805344, 11457.541698331974], "value": 11537.876188718934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.5694713112503, 1509.7508911029674, 1536.5236776599254, 1572.5911263071598, 1590.976135357969, 10661.093807026393, 10671.78656426872, 10939.28894621849, 10961.835572466409, 11052.613158539452, 10830.837537436924, 11022.724431889186, 11040.944795276013, 11055.336679799218, 11093.8335924961, 2319.675245465636, 2362.8582285062953, 2373.821963352747, 2378.5480758655885, 2380.059876348841, 2318.53629274145, 2349.753275906031, 2360.433495960974, 2361.067378385537, 2361.7047869016374, 1980.762308522972, 2270.137347807839, 2299.655051742235, 2301.551197516485, 2302.838801283911, 2300.3559003479054, 2301.5051763870847, 2318.5594736999915, 2322.0827773029728, 2322.8257880658934, 2267.8774006866706, 2296.517731276434, 2322.419395151212, 2327.813774898004, 2327.976720232793, 8201.671933122669, 9549.761255968588, 9892.851607225897, 10951.288166269167, 11069.114470842313, 4858.659893807435, 5665.348484924204, 5908.409159084057, 5915.290165180163, 5929.644221346733, 3122.2506598416444, 3420.2133509292753, 3521.0, 3674.5223120994365, 3719.237556300952, 1135.8239472881717, 1165.0912288414966, 1171.420147027227, 1176.452949378543, 1234.9320787356692, 13530.797038044437, 13671.17972921628, 14565.854341456556, 15191.392344306214, 15193.392264309414, 4520.457545094544, 4564.657650676212, 4699.647526435531, 4707.576318131316, 4737.763111844394, 9971.750706232257, 11211.103111751041, 11373.431328433546, 11387.715307117389, 11392.829107563393, 5676.176954341598, 5700.00249956256, 5743.0811070228565, 5743.54051675865, 5753.108268218432, 5095.261187127846, 5165.948340516622, 5227.686338819683, 5259.184826351921, 5276.445973172838, 3772.773633581994, 3855.132595166065, 3874.7093967952515, 3939.4878665773267, 3946.625070618287, 1049.338916482611, 1051.2798732867857, 1053.5996321397972, 1062.4156713807374, 1064.1912146768511, 890.4568213389826, 914.131575003749, 915.6062892956093, 940.7365937537501, 940.9414408790111, 6381.936180638134, 6444.871102577922, 6501.414872661483, 6561.671916404161, 6573.441257493071, 970.8301047316692, 975.4439969217619, 1016.2479764973866, 1028.1825948371063, 1029.8352263637933, 3787.2046870157023, 4090.550039495653, 4209.726367786084, 4233.491980962242, 4298.570142985739, 13219.0, 13541.187528748307, 13616.591502254949, 13673.521426750016, 13697.520586779416, 13046.47814087445, 13219.272939988394, 13455.259960702255, 13580.759174736058, 13591.388387522586, 8606.483610983236, 8903.06517815633, 9557.139857412727, 9874.555644995993, 10019.849702254473, 6056.394360563909, 6261.8747625046335, 6322.430981211713, 6488.513361498001, 6574.3754343337305, 9924.305298629026, 10745.925407459192, 11010.0, 11259.718507037061, 11298.60454884075, 11579.652610421701, 11906.761864762482, 11925.165238433226, 11937.761244775229, 12055.336956467478, 8292.626831792462, 8367.95816020916, 8395.034571024411, 8434.156584341517, 8481.83036339282, 10120.746981325232, 10190.388576685422, 10196.541155648161, 10278.537465814206, 10292.742681433025, 8711.0, 8869.113088691338, 8905.643774249216, 8983.416077954913, 9011.774705632411, 7589.58257295854, 8685.131486851264, 8741.038485766434, 8987.966383865678, 9049.0, 7727.652255648397, 7770.572618506037, 7845.764627061198, 7847.9607601961625, 7853.371730261451, 5647.0, 5650.208970744181, 5721.971390143022, 5782.884342313214, 5811.4188581143235, 5717.456841600041, 5797.333306669619, 6021.789237376671, 6044.546659000681, 6065.787697430569], "value": 5005.501353263229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.72877155818463, 377.4806404223004, 382.54477172165105, 387.83904679557986, 399.57844474079843, 4744.810207591697, 5062.696238225709, 5513.58648101392, 5551.805686800963, 6076.453119219275, 4545.6818022738335, 5854.0, 5898.52811775058, 5909.5567832412635, 5996.760129594811, 3676.779393236401, 4013.9598604014022, 4868.537488938545, 4955.166588362293, 4958.404991401019, 4133.793310334487, 4441.844535441261, 4864.0515099555605, 4931.852044438672, 4986.87532811679, 3979.6816254699697, 4917.655764096497, 4960.528749768766, 4960.87597810054, 4961.255811628266, 4518.909621807578, 4559.886002849922, 4898.363212782316, 4999.450060493343, 5003.624728145403, 3444.6383129771266, 4537.978954735191, 4543.363929049936, 4576.496585375606, 4583.220852455091, 5364.275822763916, 5820.621659592155, 5920.690930537094, 5923.141144534062, 5960.724758588637, 4771.6898401603785, 5033.219850923113, 5060.84817455477, 5547.417521160301, 5628.802991895264, 6457.225132984072, 6489.0, 6495.285518592951, 6498.512611554105, 6676.432503237231, 4260.297050986584, 4911.312416261726, 5051.6716413433005, 5057.367829021372, 5059.3422855028975, 5780.0, 5781.248437703071, 6167.845803854894, 6733.6432248713045, 6932.549384290055, 4604.447466304065, 5091.592672586258, 5227.764750586232, 5248.737563121828, 5270.841874743764, 5350.933290699097, 5354.464553544614, 5369.812056578001, 5373.931036550878, 5377.333026761717, 4966.751662416865, 5437.688982182556, 5458.0, 5744.655320680772, 5783.768649253982, 5842.503387212135, 5869.64782113066, 6040.731446396306, 6466.902996455057, 6506.4469520091325, 1706.7114328681766, 1764.8087540909835, 1821.8360347568782, 1832.386150639524, 1837.898915559657, 1147.2657499200518, 1183.408295852074, 1254.9395760582292, 1317.55727478411, 1350.716349566602, 5678.68767217807, 6174.38256174379, 6189.3076511717545, 6189.6286222826775, 6209.441150296495, 5763.538916886639, 6170.704152128013, 6269.7178626961895, 6528.640924749089, 6720.260771315151, 5888.352281249059, 5910.468057874812, 6134.098429486784, 6196.915539780521, 6208.658523781145, 2827.9010234641687, 3212.887548935823, 3483.641379861856, 3525.347810655037, 3543.911402214965, 6796.422304104207, 6929.549579277432, 7005.50961432705, 7046.43628509718, 7058.894056640968, 5842.766289348463, 6482.611043337415, 6753.29090445506, 6836.6923488443135, 6881.724731010803, 6705.625346803893, 6972.477064220204, 6997.615131167631, 7019.543729657556, 7047.119110111236, 5567.498925096761, 5772.191893135048, 6641.402273795382, 6682.3317668232785, 6692.83267918306, 6206.782762603468, 6503.187101612299, 6618.503612229006, 6622.04685080673, 6656.800295991128, 4946.851594452172, 6075.756969721162, 6480.671462350113, 6560.015997600207, 6640.701168447528, 4456.910861782681, 5019.3976722793495, 5249.451411833595, 5263.447338029452, 5265.2365407015, 6428.903566446414, 6607.372299631527, 6622.834429139118, 6642.3025582315095, 6688.230853451915, 5486.780528778964, 5902.527797776082, 6008.738164985402, 6455.709493072729, 6481.675916204076, 5922.644641321534, 6072.210612620508, 6211.596246243979, 6406.615603063831, 6457.9960424537085, 6334.4932405406535, 6358.141650877073, 6379.808605741835, 6400.0, 6434.388733070351, 5904.232449781501, 6214.223222097238, 6501.934980650133, 6547.377999090078, 6596.5052621052655, 5772.249607550992, 6255.437010669061, 6312.05319202105, 6356.68216589178, 6383.234011918414], "value": 4873.852043508796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.516290852041, 699.9300069993002, 714.4248879651878, 723.5007844587232, 814.6904176412962, 14639.853601463983, 15559.299831507567, 15569.766453503207, 15572.221388930537, 15603.219839008047, 15661.373545058184, 16450.506484805446, 16603.252853621587, 16615.66768664626, 16619.169041547906, 806.4677312973439, 843.161054750524, 921.6037104045258, 930.0792215706435, 952.509457629318, 922.6447817590242, 950.4582388038821, 955.5508910811907, 957.25812495316, 957.7461972577272, 988.7330420786384, 997.7954519323557, 999.1507218863944, 999.6701088640731, 999.8950110238429, 978.7063880835757, 989.48546755687, 990.8365119755304, 993.4188499727704, 994.2294721590753, 633.3729607688401, 731.0715391452878, 744.5383862005538, 744.7430636430423, 751.5528260684883, 16183.838161618469, 16544.75182872258, 16731.16344182786, 16750.4137355192, 16932.830671693373, 12216.938915305367, 14826.332815023243, 14915.0, 14986.550403487912, 15222.391104355813, 11464.140189485823, 11585.246958947642, 11737.471813768401, 11746.119041071954, 11953.163278570504, 3740.663340299386, 3820.102275965146, 3840.961590384088, 3922.058705910561, 3943.3887747398912, 79113.0, 81071.18928810695, 88355.16448355178, 91349.0, 110241.44879275633, 10943.25920104262, 11250.718732031764, 11363.659090227306, 11399.316041037398, 11723.706907327385, 19659.607146953495, 24783.380415489755, 24786.752132478443, 24888.37779055538, 24903.377415564395, 7742.806429839299, 7811.843763124706, 7815.57014364204, 7899.0, 7900.130985591695, 3701.777893326409, 4202.936955945664, 4330.566943305707, 4359.716618419792, 4450.554944505524, 3515.402381595135, 3557.8932632021083, 3616.150204701893, 3618.0, 3618.5295911531334, 638.9009703495966, 639.0, 640.8013515810114, 650.2164891305965, 658.9950325753265, 618.072890664004, 629.6505439481132, 642.4661195640349, 676.3270545806855, 686.6017709728345, 9930.304878658424, 10149.594016239416, 10168.389896606228, 10209.846852297222, 10326.48367581618, 573.9926429116956, 601.1133577972456, 603.8792241551707, 628.355935166458, 636.2174525333866, 4694.413198350207, 4812.759362031955, 4885.8045678172475, 4906.460289368238, 4917.0, 95893.0, 96694.0, 96772.0322796763, 100664.49667751761, 101656.0, 67256.6637166811, 69179.65410172917, 69430.3056969434, 69528.3047169532, 83052.0, 67263.99999999903, 68442.9733553997, 68587.97118043134, 69061.27346816269, 70456.0, 9515.381500202742, 10671.679849604525, 10744.140468762324, 10814.644623145508, 11039.668809935714, 44770.53762042989, 44823.32765008593, 46516.53483465122, 46969.0, 47330.0, 52470.0, 57757.711211443675, 59343.10985335137, 60160.09759853693, 60517.394826051175, 12279.570215042431, 13100.803487947498, 13306.0, 13372.732545348845, 13870.237136957565, 13786.172829630254, 14153.07577285537, 14171.149731016172, 14225.359858806585, 14430.278486075444, 13114.475420983053, 13346.933265333999, 13378.732425351243, 13433.529826456028, 14202.289885505477, 12907.250658787876, 13236.669083272995, 13259.66850828737, 13450.26023568713, 13977.301134943416, 12354.691132721753, 12361.0, 12977.416016279101, 13667.514783730483, 13979.510717124851, 10701.411422371844, 10792.244542881923, 10884.945575272073, 11539.307641541534, 11579.363135027317, 9200.447973121367, 9522.809543809224, 10672.146228301563, 10683.626073087406, 10768.730781730519], "value": 7484.498563157057, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 123.0, 120.0, 119.0, 121.0, 120.0, 120.0, 151.0, 149.0, 156.0], "value": 129.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 115.0, 157.0, 116.0, 120.0, 98.0, 150.0, 171.0, 147.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 214.0, 217.0, 212.0, 207.0, 199.0, 198.0, 199.0, 197.0, 195.0], "value": 203.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 83.0, 50.0, 62.0, 72.0, 84.0, 100.0, 89.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 68.0, 94.0, 107.0, 88.0, 68.0, 96.0, 105.0, 80.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 87.0, 79.0, 126.0, 89.0, 80.0, 134.0, 137.0], "value": 99.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 136.0, 100.0, 153.0, 132.0, 96.0, 97.0, 99.0], "value": 110.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 96.0, 90.0, 89.0, 90.0, 127.0, 138.0, 91.0, 114.0], "value": 102.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 74.0, 69.0, 71.0, 67.0, 68.0, 67.0, 69.0, 79.0], "value": 70.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 82.0, 101.0, 92.0, 64.0, 57.0, 59.0, 57.0, 58.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 88.0, 86.0, 84.0, 85.0, 85.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 159.0, 130.0, 148.0, 162.0, 150.0, 154.0, 154.0, 196.0, 144.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 189.0, 188.0, 186.0, 187.0, 181.0, 188.0, 192.0, 210.0, 243.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 72.0, 76.0, 100.0, 84.0, 66.0, 70.0, 66.0, 75.0], "value": 74.7, "unit": "score"}]}]} 16:42:19 INFO - Return code: 0 16:42:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:42:19 ERROR - # TBPL SUCCESS # 16:42:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:42:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:42:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:42:19 INFO - 2017-03-13 16:42:19.683 screenresolution[1657:10577] starting screenresolution argv=screenresolution get 16:42:19 INFO - 2017-03-13 16:42:19.686 screenresolution[1657:10577] Display 0: 1600x1200x32@60 16:42:19 INFO - 2017-03-13 16:42:19.692 screenresolution[1658:10581] starting screenresolution argv=screenresolution list 16:42:19 INFO - Available Modes on Display 0 16:42:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:42:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:42:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:42:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:42:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:42:19 INFO - Intel Iris: 16:42:19 INFO - Chipset Model: Intel Iris 16:42:19 INFO - Type: GPU 16:42:19 INFO - Bus: Built-In 16:42:19 INFO - VRAM (Dynamic, Max): 1536 MB 16:42:19 INFO - Vendor: Intel (0x8086) 16:42:19 INFO - Device ID: 0x0a2e 16:42:19 INFO - Revision ID: 0x0009 16:42:19 INFO - Displays: 16:42:19 INFO - Display: 16:42:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:42:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:42:19 INFO - Display Serial Number: 1600x1200 60 16:42:19 INFO - Main Display: Yes 16:42:19 INFO - Mirror: Off 16:42:19 INFO - Online: Yes 16:42:19 INFO - Rotation: Supported 16:42:19 INFO - Return code: 0 16:42:19 INFO - Running post-action listener: _resource_record_post_action 16:42:19 INFO - [mozharness: 2017-03-13 23:42:19.937886Z] Finished run-tests step (success) 16:42:19 INFO - Running post-run listener: _resource_record_post_run 16:42:20 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38791680; Write bytes: 517097472; Read time: 251; Write time: 1630 16:42:20 INFO - TinderboxPrint: CPU usage
54.2% 16:42:20 INFO - TinderboxPrint: I/O read bytes / time
38,791,680 / 251 16:42:20 INFO - TinderboxPrint: I/O write bytes / time
517,097,472 / 1,630 16:42:20 INFO - TinderboxPrint: CPU idle
2,195.4 (45.8%) 16:42:20 INFO - TinderboxPrint: CPU system
962.1 (20.1%) 16:42:20 INFO - TinderboxPrint: CPU user
1,640.2 (34.2%) 16:42:20 INFO - TinderboxPrint: Swap in / out
249,245,696 / 0 16:42:20 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203434496; Write bytes: 202168320; Read time: 15717; Write time: 420 16:42:20 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36964864; Write bytes: 302180352; Read time: 234; Write time: 1167 16:42:20 INFO - Running post-run listener: _upload_blobber_files 16:42:20 INFO - Blob upload gear active. 16:42:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:42:20 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 16:42:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:42:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:42:20 INFO - (blobuploader) - INFO - Open directory for files ... 16:42:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:42:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:21 INFO - (blobuploader) - INFO - Done attempting. 16:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:42:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:22 INFO - (blobuploader) - INFO - Done attempting. 16:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:23 INFO - (blobuploader) - INFO - Done attempting. 16:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:42:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:25 INFO - (blobuploader) - INFO - Done attempting. 16:42:25 INFO - (blobuploader) - INFO - Iteration through files over. 16:42:25 INFO - Return code: 0 16:42:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:42:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:42:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e15a821da9b0bd274b0d73ce8cb3c518b60092bb11e0ed6eb4eec20237d46bd33bcb947cb840de3230c277ebc39011d73ffb1f53224b6e0d27a6a6dd909cdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa58681bffff6be4eaa1f2ddfc413f8136c1772a58961fbd3d97cc899aede9ad9ffffb40a603083967b1cb6d7a43661dfeb73283c9288fd21e64c53ca82e874d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6b1d3bf4f78a9df2c8a4d491ea3b64b32f6aca1c545ff542756070b7028f37060bd4a977b1f53c35826bc6d41fedce61affc07ae59692760fe4515be36fae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d170bdc03da8003de3f6fd0eeb157279d2b920ca11038893914ac5923ecf2ed3d7ceb3e21f88a5392fdc3006a914d36dc8035f20188370e0b9eceae86f89e9a0"} 16:42:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:42:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:42:25 INFO - Contents: 16:42:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e15a821da9b0bd274b0d73ce8cb3c518b60092bb11e0ed6eb4eec20237d46bd33bcb947cb840de3230c277ebc39011d73ffb1f53224b6e0d27a6a6dd909cdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa58681bffff6be4eaa1f2ddfc413f8136c1772a58961fbd3d97cc899aede9ad9ffffb40a603083967b1cb6d7a43661dfeb73283c9288fd21e64c53ca82e874d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6b1d3bf4f78a9df2c8a4d491ea3b64b32f6aca1c545ff542756070b7028f37060bd4a977b1f53c35826bc6d41fedce61affc07ae59692760fe4515be36fae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d170bdc03da8003de3f6fd0eeb157279d2b920ca11038893914ac5923ecf2ed3d7ceb3e21f88a5392fdc3006a914d36dc8035f20188370e0b9eceae86f89e9a0"} 16:42:25 INFO - Running post-run listener: copy_logs_to_upload_dir 16:42:25 INFO - Copying logs to upload dir... 16:42:25 INFO - mkdir: /builds/slave/test/build/upload/logs 16:42:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.713352 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-13 16:42:25.959482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 16:42:25.962931) ========= 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.RFN7zCysNS/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.GkcF5AkZjR/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e15a821da9b0bd274b0d73ce8cb3c518b60092bb11e0ed6eb4eec20237d46bd33bcb947cb840de3230c277ebc39011d73ffb1f53224b6e0d27a6a6dd909cdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa58681bffff6be4eaa1f2ddfc413f8136c1772a58961fbd3d97cc899aede9ad9ffffb40a603083967b1cb6d7a43661dfeb73283c9288fd21e64c53ca82e874d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6b1d3bf4f78a9df2c8a4d491ea3b64b32f6aca1c545ff542756070b7028f37060bd4a977b1f53c35826bc6d41fedce61affc07ae59692760fe4515be36fae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d170bdc03da8003de3f6fd0eeb157279d2b920ca11038893914ac5923ecf2ed3d7ceb3e21f88a5392fdc3006a914d36dc8035f20188370e0b9eceae86f89e9a0"} build_url:https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/Cq7GxnR5Syub47uE-y11qg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e15a821da9b0bd274b0d73ce8cb3c518b60092bb11e0ed6eb4eec20237d46bd33bcb947cb840de3230c277ebc39011d73ffb1f53224b6e0d27a6a6dd909cdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa58681bffff6be4eaa1f2ddfc413f8136c1772a58961fbd3d97cc899aede9ad9ffffb40a603083967b1cb6d7a43661dfeb73283c9288fd21e64c53ca82e874d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6b1d3bf4f78a9df2c8a4d491ea3b64b32f6aca1c545ff542756070b7028f37060bd4a977b1f53c35826bc6d41fedce61affc07ae59692760fe4515be36fae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d170bdc03da8003de3f6fd0eeb157279d2b920ca11038893914ac5923ecf2ed3d7ceb3e21f88a5392fdc3006a914d36dc8035f20188370e0b9eceae86f89e9a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 16:42:25.998060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:42:25.998384) ========= 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.RFN7zCysNS/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.GkcF5AkZjR/Listeners TMPDIR=/var/folders/m1/k6zf3gmj55ngzdrqbcq3628800000w/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.005030 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 16:42:26.047301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 16:42:26.047627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 16:42:26.047955) ========= ========= Total master_lag: 0.18 =========