builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0236 starttime: 1489679695.49 results: success (0) buildid: 20170316073537 builduid: 3e86817038b0449cab4f6b6ee3ee5869 revision: 3ea221e3ebbb5d604da5ff94ac122bbaf08170b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.488932) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.489915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.490618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.519519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.520226) ========= 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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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-16 08:54:55-- 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.7M=0.001s 2017-03-16 08:54:55 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.220511 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.770581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.771383) ========= 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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.026918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:55.824864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 08:54:55.825639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ea221e3ebbb5d604da5ff94ac122bbaf08170b5 --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 3ea221e3ebbb5d604da5ff94ac122bbaf08170b5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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-16 08:54:55,932 truncating revision to first 12 chars 2017-03-16 08:54:55,932 Setting DEBUG logging. 2017-03-16 08:54:55,932 attempt 1/10 2017-03-16 08:54:55,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ea221e3ebbb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 08:54:57,002 unpacking tar archive at: mozilla-central-3ea221e3ebbb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345476 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 08:54:57.197221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:57.197970) ========= script_repo_revision: 3ea221e3ebbb5d604da5ff94ac122bbaf08170b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:57.198835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:57.199503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 08:54:57.221694) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-16 08:54:57.222412) ========= /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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:54:57 INFO - MultiFileLogger online at 20170316 08:54:57 in /builds/slave/test 08:54:57 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 08:54:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:57 INFO - {'append_to_log': False, 08:54:57 INFO - 'base_work_dir': '/builds/slave/test', 08:54:57 INFO - 'blob_upload_branch': 'Firefox', 08:54:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:57 INFO - 'branch': 'Firefox', 08:54:57 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:57 INFO - 'config_files': ('talos/mac_config.py',), 08:54:57 INFO - 'default_actions': ('clobber', 08:54:57 INFO - 'read-buildbot-config', 08:54:57 INFO - 'download-and-extract', 08:54:57 INFO - 'populate-webroot', 08:54:57 INFO - 'create-virtualenv', 08:54:57 INFO - 'install', 08:54:57 INFO - 'run-tests'), 08:54:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:57 INFO - 'download_minidump_stackwalk': True, 08:54:57 INFO - 'download_symbols': 'ondemand', 08:54:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:57 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:57 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:57 INFO - 'gecko_profile': False, 08:54:57 INFO - 'gecko_profile_interval': 0, 08:54:57 INFO - 'installer_path': 'installer.exe', 08:54:57 INFO - 'log_level': 'info', 08:54:57 INFO - 'log_name': 'talos', 08:54:57 INFO - 'log_to_console': True, 08:54:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:54:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:54:57 INFO - 'opt_config_files': (), 08:54:57 INFO - 'pip_index': False, 08:54:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:54:57 INFO - 'cmd': ('bash', 08:54:57 INFO - '-c', 08:54:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:54:57 INFO - 'enabled': True, 08:54:57 INFO - 'halt_on_failure': False, 08:54:57 INFO - 'name': 'check_screen_resolution'},), 08:54:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:54:57 INFO - 'cmd': ('bash', 08:54:57 INFO - '-c', 08:54:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:54:57 INFO - 'enabled': True, 08:54:57 INFO - 'halt_on_failure': False, 08:54:57 INFO - 'name': 'check_screen_resolution'},), 08:54:57 INFO - 'run_cmd_checks_enabled': True, 08:54:57 INFO - 'suite': 'dromaeojs-e10s', 08:54:57 INFO - 'system_bits': '32', 08:54:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:57 INFO - 'title': 't-yosemite-r7-0236', 08:54:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:57 INFO - 'use_talos_json': True, 08:54:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:57 INFO - 'work_dir': 'build'} 08:54:57 INFO - [mozharness: 2017-03-16 15:54:57.422317Z] Running clobber step. 08:54:57 INFO - Running pre-action listener: _resource_record_pre_action 08:54:57 INFO - Running main action method: clobber 08:54:57 INFO - rmtree: /builds/slave/test/build 08:54:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:59 INFO - Running post-action listener: _resource_record_post_action 08:54:59 INFO - [mozharness: 2017-03-16 15:54:59.766183Z] Finished clobber step (success) 08:54:59 INFO - [mozharness: 2017-03-16 15:54:59.766334Z] Running read-buildbot-config step. 08:54:59 INFO - Running pre-action listener: _resource_record_pre_action 08:54:59 INFO - Running main action method: read_buildbot_config 08:54:59 INFO - Using buildbot properties: 08:54:59 INFO - { 08:54:59 INFO - "project": "", 08:54:59 INFO - "product": "firefox", 08:54:59 INFO - "script_repo_revision": "production", 08:54:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:54:59 INFO - "repository": "", 08:54:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:54:59 INFO - "buildid": "20170316073537", 08:54:59 INFO - "pgo_build": "False", 08:54:59 INFO - "basedir": "/builds/slave/test", 08:54:59 INFO - "buildnumber": 177, 08:54:59 INFO - "slavename": "t-yosemite-r7-0236", 08:54:59 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:54:59 INFO - "platform": "yosemite_r7", 08:54:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:54:59 INFO - "branch": "mozilla-central", 08:54:59 INFO - "repo_path": "mozilla-central", 08:54:59 INFO - "revision": "3ea221e3ebbb5d604da5ff94ac122bbaf08170b5", 08:54:59 INFO - "stage_platform": "macosx64", 08:54:59 INFO - "builduid": "3e86817038b0449cab4f6b6ee3ee5869", 08:54:59 INFO - "slavebuilddir": "test" 08:54:59 INFO - } 08:54:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:54:59 INFO - Running post-action listener: _resource_record_post_action 08:54:59 INFO - [mozharness: 2017-03-16 15:54:59.769490Z] Finished read-buildbot-config step (success) 08:54:59 INFO - [mozharness: 2017-03-16 15:54:59.769602Z] Running download-and-extract step. 08:54:59 INFO - Running pre-action listener: _resource_record_pre_action 08:54:59 INFO - Running main action method: download_and_extract 08:54:59 INFO - mkdir: /builds/slave/test/build/tests 08:54: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')]} 08:54:59 INFO - trying https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:54:59 INFO - Downloading https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/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 08:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/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 08:55:01 INFO - Downloaded 1325 bytes. 08:55:01 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:55:01 INFO - Using the following test package requirements: 08:55:01 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 08:55:01 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:55:01 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:55:01 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:55:01 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'jsshell-mac.zip'], 08:55:01 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:55:01 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:55:01 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:55:01 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:55:01 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:55:01 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:01 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:55:01 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:55:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:55:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:55:01 INFO - Fetch https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:55:02 INFO - Expected file size: 52473123 08:55:02 INFO - Obtained file size: 52473123 08:55:18 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 08:55:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:55:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:55:18 INFO - Fetch https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:55:20 INFO - Expected file size: 52473123 08:55:20 INFO - Obtained file size: 52473123 08:55:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:55:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:55:36 INFO - Fetch https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:55:37 INFO - Expected file size: 14404452 08:55:37 INFO - Obtained file size: 14404452 08:55:37 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')]} 08:55:37 INFO - trying https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:55:37 INFO - Downloading https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/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 08:55:39 INFO - Downloaded 75097507 bytes. 08:55:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:55:39 INFO - mkdir: /builds/slave/test/properties 08:55:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:39 INFO - Contents: 08:55:39 INFO - build_url:https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:55:40 INFO - Running post-action listener: _resource_record_post_action 08:55:40 INFO - Running post-action listener: set_extra_try_arguments 08:55:40 INFO - [mozharness: 2017-03-16 15:55:40.301494Z] Finished download-and-extract step (success) 08:55:40 INFO - [mozharness: 2017-03-16 15:55:40.301645Z] Running populate-webroot step. 08:55:40 INFO - Running pre-action listener: _resource_record_pre_action 08:55:40 INFO - Running main action method: populate_webroot 08:55:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:40 INFO - '--tppagecycles', 08:55:40 INFO - '7'], 08:55:40 INFO - 'tests': ['tsvgm']}}, 08:55:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:55:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:55:40 INFO - 'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:55:40 INFO - 'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['damp', 'tps']}, 08:55:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:55:40 INFO - 'tests': ['damp', 'tps']}, 08:55:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['dromaeo_dom']}, 08:55:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['basic_compositor_video']}, 08:55:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:55:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['a11yr', 08:55:40 INFO - 'ts_paint', 08:55:40 INFO - 'tpaint', 08:55:40 INFO - 'sessionrestore', 08:55:40 INFO - 'sessionrestore_no_auto_restore', 08:55:40 INFO - 'tabpaint']}, 08:55:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:40 INFO - 'ts_paint', 08:55:40 INFO - 'tpaint', 08:55:40 INFO - 'sessionrestore', 08:55:40 INFO - 'sessionrestore_no_auto_restore', 08:55:40 INFO - 'tabpaint']}, 08:55:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:40 INFO - 'ts_paint', 08:55:40 INFO - 'tpaint', 08:55:40 INFO - 'sessionrestore', 08:55:40 INFO - 'sessionrestore_no_auto_restore', 08:55:40 INFO - 'tabpaint']}, 08:55:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:40 INFO - 'ts_paint', 08:55:40 INFO - 'tpaint', 08:55:40 INFO - 'sessionrestore', 08:55:40 INFO - 'sessionrestore_no_auto_restore', 08:55:40 INFO - 'tabpaint']}, 08:55:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['a11yr', 08:55:40 INFO - 'ts_paint', 08:55:40 INFO - 'tpaint', 08:55:40 INFO - 'sessionrestore', 08:55:40 INFO - 'sessionrestore_no_auto_restore', 08:55:40 INFO - 'tabpaint']}, 08:55:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['a11yr', 08:55:40 INFO - 'ts_paint', 08:55:40 INFO - 'tpaint', 08:55:40 INFO - 'sessionrestore', 08:55:40 INFO - 'sessionrestore_no_auto_restore', 08:55:40 INFO - 'tabpaint']}, 08:55:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['tsvgx', 08:55:40 INFO - 'tsvgr_opacity', 08:55:40 INFO - 'tart', 08:55:40 INFO - 'tscrollx', 08:55:40 INFO - 'cart', 08:55:40 INFO - 'tsvg_static']}, 08:55:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:40 INFO - 'tsvgr_opacity', 08:55:40 INFO - 'tart', 08:55:40 INFO - 'tscrollx', 08:55:40 INFO - 'cart', 08:55:40 INFO - 'tsvg_static']}, 08:55:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:55:40 INFO - 'talos_options': ['--disable-e10s'], 08:55:40 INFO - 'tests': ['tp5o']}, 08:55:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:55:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:55:40 INFO - 'talos_options': ['--disable-e10s', 08:55:40 INFO - '--xperf_path', 08:55:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:40 INFO - 'tests': ['tp5n']}, 08:55:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:55:40 INFO - 'talos_options': ['--xperf_path', 08:55:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:40 INFO - 'tests': ['tp5n']}}, 08:55:40 INFO - 'talos.zip': {'path': '', 08:55:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:40 INFO - Running post-action listener: _resource_record_post_action 08:55:40 INFO - [mozharness: 2017-03-16 15:55:40.320285Z] Finished populate-webroot step (success) 08:55:40 INFO - [mozharness: 2017-03-16 15:55:40.320394Z] Running create-virtualenv step. 08:55:40 INFO - Running pre-action listener: _resource_record_pre_action 08:55:40 INFO - Running main action method: create_virtualenv 08:55:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:40 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 08:55:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:40 INFO - Using real prefix '/tools/python27' 08:55:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:44 INFO - Installing pip.................done. 08:55:44 INFO - Return code: 0 08:55:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:55:44 INFO - Reading from file tmpfile_stdout 08:55:44 INFO - Output received: 08:55:44 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) 08:55:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:44 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:55:44 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 08:55:44 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 08:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:44 INFO - 'HOME': '/Users/cltbld', 08:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:44 INFO - 'LOGNAME': 'cltbld', 08:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:44 INFO - 'MOZ_NO_REMOTE': '1', 08:55:44 INFO - 'NO_EM_RESTART': '1', 08:55:44 INFO - 'PAGER': '/bin/cat', 08:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:44 INFO - 'PWD': '/builds/slave/test', 08:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:44 INFO - 'SHELL': '/bin/bash', 08:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:55:44 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:44 INFO - 'USER': 'cltbld', 08:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:44 INFO - 'XPC_FLAGS': '0x0', 08:55:44 INFO - 'XPC_SERVICE_NAME': '0', 08:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:44 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 08:55:44 INFO - Cleaning up... 08:55:44 INFO - Return code: 0 08:55:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:44 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:55:44 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 08:55:44 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 08:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:44 INFO - 'HOME': '/Users/cltbld', 08:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:44 INFO - 'LOGNAME': 'cltbld', 08:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:44 INFO - 'MOZ_NO_REMOTE': '1', 08:55:44 INFO - 'NO_EM_RESTART': '1', 08:55:44 INFO - 'PAGER': '/bin/cat', 08:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:44 INFO - 'PWD': '/builds/slave/test', 08:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:44 INFO - 'SHELL': '/bin/bash', 08:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:55:44 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:44 INFO - 'USER': 'cltbld', 08:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:44 INFO - 'XPC_FLAGS': '0x0', 08:55:44 INFO - 'XPC_SERVICE_NAME': '0', 08:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:44 INFO - Downloading/unpacking psutil>=3.1.1 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:48 INFO - Installing collected packages: psutil 08:55:48 INFO - Running setup.py install for psutil 08:55:48 INFO - building 'psutil._psutil_osx' extension 08:55:48 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 08:55:48 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 08:55:49 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 08:55:49 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 08:55:49 INFO - building 'psutil._psutil_posix' extension 08:55:49 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 08:55:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:55:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:55:49 INFO - ^ 08:55:49 INFO - 1 warning generated. 08:55:49 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 08:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:49 INFO - Successfully installed psutil 08:55:49 INFO - Cleaning up... 08:55:49 INFO - Return code: 0 08:55:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:49 INFO - 'HOME': '/Users/cltbld', 08:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:49 INFO - 'LOGNAME': 'cltbld', 08:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:49 INFO - 'MOZ_NO_REMOTE': '1', 08:55:49 INFO - 'NO_EM_RESTART': '1', 08:55:49 INFO - 'PAGER': '/bin/cat', 08:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:49 INFO - 'PWD': '/builds/slave/test', 08:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:49 INFO - 'SHELL': '/bin/bash', 08:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:55:49 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:49 INFO - 'USER': 'cltbld', 08:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:49 INFO - 'XPC_FLAGS': '0x0', 08:55:49 INFO - 'XPC_SERVICE_NAME': '0', 08:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:55:52 INFO - Installing collected packages: mozsystemmonitor 08:55:52 INFO - Running setup.py install for mozsystemmonitor 08:55:52 INFO - Successfully installed mozsystemmonitor 08:55:52 INFO - Cleaning up... 08:55:52 INFO - Return code: 0 08:55:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:55:52 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')]} 08:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:53 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:55:53 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 08:55:53 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 08:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:53 INFO - 'HOME': '/Users/cltbld', 08:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:53 INFO - 'LOGNAME': 'cltbld', 08:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:53 INFO - 'MOZ_NO_REMOTE': '1', 08:55:53 INFO - 'NO_EM_RESTART': '1', 08:55:53 INFO - 'PAGER': '/bin/cat', 08:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:53 INFO - 'PWD': '/builds/slave/test', 08:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:53 INFO - 'SHELL': '/bin/bash', 08:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:55:53 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:53 INFO - 'USER': 'cltbld', 08:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:53 INFO - 'XPC_FLAGS': '0x0', 08:55:53 INFO - 'XPC_SERVICE_NAME': '0', 08:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:55:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:55:57 INFO - warning: no files found matching '*.txt' 08:55:57 INFO - no previously-included directories found matching 'build' 08:55:57 INFO - no previously-included directories found matching 'dist' 08:55:57 INFO - no previously-included directories found matching '.git*' 08:55:57 INFO - Installing collected packages: jsonschema, functools32 08:55:57 INFO - Running setup.py install for functools32 08:55:57 INFO - warning: no files found matching '*.txt' 08:55:57 INFO - no previously-included directories found matching 'build' 08:55:57 INFO - no previously-included directories found matching 'dist' 08:55:57 INFO - no previously-included directories found matching '.git*' 08:55:57 INFO - Successfully installed jsonschema functools32 08:55:57 INFO - Cleaning up... 08:55:57 INFO - Return code: 0 08:55:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:57 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:55:57 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 08:55:57 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 08:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:57 INFO - 'HOME': '/Users/cltbld', 08:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:57 INFO - 'LOGNAME': 'cltbld', 08:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:57 INFO - 'MOZ_NO_REMOTE': '1', 08:55:57 INFO - 'NO_EM_RESTART': '1', 08:55:57 INFO - 'PAGER': '/bin/cat', 08:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:57 INFO - 'PWD': '/builds/slave/test', 08:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:57 INFO - 'SHELL': '/bin/bash', 08:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:55:57 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:57 INFO - 'USER': 'cltbld', 08:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:57 INFO - 'XPC_FLAGS': '0x0', 08:55:57 INFO - 'XPC_SERVICE_NAME': '0', 08:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:55:57 INFO - Cleaning up... 08:55:57 INFO - Return code: 0 08:55:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:57 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:55:57 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 08:55:57 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 08:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:57 INFO - 'HOME': '/Users/cltbld', 08:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:57 INFO - 'LOGNAME': 'cltbld', 08:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:57 INFO - 'MOZ_NO_REMOTE': '1', 08:55:57 INFO - 'NO_EM_RESTART': '1', 08:55:57 INFO - 'PAGER': '/bin/cat', 08:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:57 INFO - 'PWD': '/builds/slave/test', 08:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:57 INFO - 'SHELL': '/bin/bash', 08:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:55:57 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:57 INFO - 'USER': 'cltbld', 08:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:57 INFO - 'XPC_FLAGS': '0x0', 08:55:57 INFO - 'XPC_SERVICE_NAME': '0', 08:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:55:58 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 08:55:58 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 08:55:58 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 08:55:58 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 08:55:58 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 08:55:58 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 08:56:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:00 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 08:56:00 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 08:56:00 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 08:56:00 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 08:56:00 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 08:56:00 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 08:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:02 INFO - Downloading docopt-0.6.1.tar.gz 08:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:02 INFO - Running setup.py install for blobuploader 08:56:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:02 INFO - Running setup.py install for requests 08:56:02 INFO - Running setup.py install for docopt 08:56:02 INFO - Successfully installed blobuploader requests docopt 08:56:02 INFO - Cleaning up... 08:56:03 INFO - Return code: 0 08:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:03 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:56:03 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 08:56:03 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 08:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:03 INFO - 'HOME': '/Users/cltbld', 08:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:03 INFO - 'LOGNAME': 'cltbld', 08:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:03 INFO - 'MOZ_NO_REMOTE': '1', 08:56:03 INFO - 'NO_EM_RESTART': '1', 08:56:03 INFO - 'PAGER': '/bin/cat', 08:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:03 INFO - 'PWD': '/builds/slave/test', 08:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:03 INFO - 'SHELL': '/bin/bash', 08:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:56:03 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:03 INFO - 'USER': 'cltbld', 08:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:03 INFO - 'XPC_FLAGS': '0x0', 08:56:03 INFO - 'XPC_SERVICE_NAME': '0', 08:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:03 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-BcBEaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:03 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-vv9hvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:03 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-8TjYqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:03 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-G1Yfx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:03 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-s1KiCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:03 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-01cgqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:03 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-mV_OqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-33NTG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-I6gRx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-RyRtbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-ReGkZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-xDreV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-af8Zv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-Q7msc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-aaecZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-JuUe3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:04 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-9DvMUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:05 INFO - Running setup.py install for manifestparser 08:56:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:05 INFO - Running setup.py install for mozcrash 08:56:05 INFO - Running setup.py install for mozdebug 08:56:05 INFO - Running setup.py install for mozdevice 08:56:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:05 INFO - Running setup.py install for mozfile 08:56:05 INFO - Running setup.py install for mozhttpd 08:56:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:05 INFO - Running setup.py install for mozinfo 08:56:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for mozInstall 08:56:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for mozleak 08:56:06 INFO - Running setup.py install for mozlog 08:56:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for moznetwork 08:56:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:06 INFO - Running setup.py install for mozprocess 08:56:06 INFO - Running setup.py install for mozprofile 08:56:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Running setup.py install for mozrunner 08:56:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Running setup.py install for mozscreenshot 08:56:07 INFO - Running setup.py install for moztest 08:56:07 INFO - Running setup.py install for mozversion 08:56:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:07 INFO - Cleaning up... 08:56:07 INFO - Return code: 0 08:56:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:07 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:56:07 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 08:56:07 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 08:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:07 INFO - 'HOME': '/Users/cltbld', 08:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:07 INFO - 'LOGNAME': 'cltbld', 08:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:07 INFO - 'MOZ_NO_REMOTE': '1', 08:56:07 INFO - 'NO_EM_RESTART': '1', 08:56:07 INFO - 'PAGER': '/bin/cat', 08:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:07 INFO - 'PWD': '/builds/slave/test', 08:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:07 INFO - 'SHELL': '/bin/bash', 08:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:56:07 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:07 INFO - 'USER': 'cltbld', 08:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:07 INFO - 'XPC_FLAGS': '0x0', 08:56:07 INFO - 'XPC_SERVICE_NAME': '0', 08:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:07 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-WQAdGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-jVHvBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-cxWJk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-qhJ_pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-O_j5Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-3g9M4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-zwuuL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-AzdFDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-uvy0LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:08 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)) 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:08 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-ov8x4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:09 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-NTfnnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:09 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-tEeWdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:09 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-DEkqcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:09 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-znDHD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:09 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-5Tawei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:09 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-Psnu3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:09 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)) 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:09 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-5SieYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:09 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)) 08:56:09 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)) 08:56:09 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)) 08:56:09 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)) 08:56:09 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)) 08:56:09 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)) 08:56:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:12 INFO - Downloading blessings-1.6.tar.gz 08:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:12 INFO - Installing collected packages: blessings 08:56:12 INFO - Running setup.py install for blessings 08:56:12 INFO - Successfully installed blessings 08:56:12 INFO - Cleaning up... 08:56:12 INFO - Return code: 0 08:56:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:13 INFO - Reading from file tmpfile_stdout 08:56:13 INFO - Current package versions: 08:56:13 INFO - blessings == 1.6 08:56:13 INFO - blobuploader == 1.2.4 08:56:13 INFO - docopt == 0.6.1 08:56:13 INFO - functools32 == 3.2.3-2 08:56:13 INFO - jsonschema == 2.5.1 08:56:13 INFO - manifestparser == 1.1 08:56:13 INFO - mozInstall == 1.12 08:56:13 INFO - mozcrash == 1.0 08:56:13 INFO - mozdebug == 0.1 08:56:13 INFO - mozdevice == 0.49 08:56:13 INFO - mozfile == 1.2 08:56:13 INFO - mozhttpd == 0.7 08:56:13 INFO - mozinfo == 0.9 08:56:13 INFO - mozleak == 0.1 08:56:13 INFO - mozlog == 3.4 08:56:13 INFO - moznetwork == 0.27 08:56:13 INFO - mozprocess == 0.25 08:56:13 INFO - mozprofile == 0.28 08:56:13 INFO - mozrunner == 6.13 08:56:13 INFO - mozscreenshot == 0.1 08:56:13 INFO - mozsystemmonitor == 0.3 08:56:13 INFO - moztest == 0.8 08:56:13 INFO - mozversion == 1.4 08:56:13 INFO - psutil == 3.1.1 08:56:13 INFO - requests == 1.2.3 08:56:13 INFO - wsgiref == 0.1.2 08:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:13 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:56:13 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 08:56:13 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 08:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:13 INFO - 'HOME': '/Users/cltbld', 08:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:13 INFO - 'LOGNAME': 'cltbld', 08:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:13 INFO - 'MOZ_NO_REMOTE': '1', 08:56:13 INFO - 'NO_EM_RESTART': '1', 08:56:13 INFO - 'PAGER': '/bin/cat', 08:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:13 INFO - 'PWD': '/builds/slave/test', 08:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:13 INFO - 'SHELL': '/bin/bash', 08:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:56:13 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:13 INFO - 'USER': 'cltbld', 08:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:13 INFO - 'XPC_FLAGS': '0x0', 08:56:13 INFO - 'XPC_SERVICE_NAME': '0', 08:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 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)) 08:56:13 INFO - Cleaning up... 08:56:13 INFO - Return code: 0 08:56:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56: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')]} 08:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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')]} 08:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:13 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 0x109365b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109368768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb089d7fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, '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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:56:13 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 08:56:13 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 08:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:13 INFO - 'HOME': '/Users/cltbld', 08:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:13 INFO - 'LOGNAME': 'cltbld', 08:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:13 INFO - 'MOZ_NO_REMOTE': '1', 08:56:13 INFO - 'NO_EM_RESTART': '1', 08:56:13 INFO - 'PAGER': '/bin/cat', 08:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:13 INFO - 'PWD': '/builds/slave/test', 08:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:13 INFO - 'SHELL': '/bin/bash', 08:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:56:13 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:13 INFO - 'USER': 'cltbld', 08:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:13 INFO - 'XPC_FLAGS': '0x0', 08:56:13 INFO - 'XPC_SERVICE_NAME': '0', 08:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:13 INFO - Cleaning up... 08:56:13 INFO - Return code: 0 08:56:13 INFO - Running post-action listener: _resource_record_post_action 08:56:13 INFO - Running post-action listener: _start_resource_monitoring 08:56:13 INFO - Starting resource monitoring. 08:56:13 INFO - [mozharness: 2017-03-16 15:56:13.662074Z] Finished create-virtualenv step (success) 08:56:13 INFO - [mozharness: 2017-03-16 15:56:13.663052Z] Running install step. 08:56:13 INFO - Running pre-action listener: _resource_record_pre_action 08:56:13 INFO - Running main action method: install 08:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:13 INFO - Reading from file tmpfile_stdout 08:56:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:14 INFO - Reading from file tmpfile_stdout 08:56:14 INFO - Output received: 08:56:14 INFO - Usage: mozinstall [options] installer 08:56:14 INFO - Options: 08:56:14 INFO - -h, --help show this help message and exit 08:56:14 INFO - -d DEST, --destination=DEST 08:56:14 INFO - Directory to install application into. [default: 08:56:14 INFO - "/builds/slave/test"] 08:56:14 INFO - --app=APP Application being installed. [default: firefox] 08:56:14 INFO - mkdir: /builds/slave/test/build/application 08:56:14 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'] 08:56:14 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 08:56:34 INFO - Reading from file tmpfile_stdout 08:56:34 INFO - Output received: 08:56:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:56:34 INFO - Running post-action listener: _resource_record_post_action 08:56:34 INFO - [mozharness: 2017-03-16 15:56:34.344771Z] Finished install step (success) 08:56:34 INFO - [mozharness: 2017-03-16 15:56:34.344904Z] Running run-tests step. 08:56:34 INFO - Running pre-action listener: _resource_record_pre_action 08:56:34 INFO - Running main action method: run_tests 08:56:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:34 INFO - 2017-03-16 08:56:34.359 screenresolution[1627:7525] starting screenresolution argv=screenresolution get 08:56:34 INFO - 2017-03-16 08:56:34.362 screenresolution[1627:7525] Display 0: 1600x1200x32@60 08:56:34 INFO - 2017-03-16 08:56:34.367 screenresolution[1628:7528] starting screenresolution argv=screenresolution list 08:56:34 INFO - Available Modes on Display 0 08:56:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:34 INFO - Intel Iris: 08:56:34 INFO - Chipset Model: Intel Iris 08:56:34 INFO - Type: GPU 08:56:34 INFO - Bus: Built-In 08:56:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:34 INFO - Vendor: Intel (0x8086) 08:56:34 INFO - Device ID: 0x0a2e 08:56:34 INFO - Revision ID: 0x0009 08:56:34 INFO - Displays: 08:56:34 INFO - Display: 08:56:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:34 INFO - Display Serial Number: 1600x1200 60 08:56:34 INFO - Main Display: Yes 08:56:34 INFO - Mirror: Off 08:56:34 INFO - Online: Yes 08:56:34 INFO - Rotation: Supported 08:56:34 INFO - Return code: 0 08:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:34 INFO - Python 2.7.3 08:56:34 INFO - Return code: 0 08:56:34 INFO - grabbing minidump binary from tooltool 08:56:34 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')]} 08:56:34 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 0x109143d30>, '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 0x10906adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109138be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:34 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 08:56:34 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 08:56:34 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 08:56:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:34 INFO - Return code: 0 08:56:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:56:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:34 INFO - ENV: RUST_BACKTRACE is now 1 08:56:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:56:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:34 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/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0236', '--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 08:56:34 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/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0236 --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 08:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w0Nvdjtr4H/Render', 08:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:34 INFO - 'HOME': '/Users/cltbld', 08:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:34 INFO - 'LOGNAME': 'cltbld', 08:56:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:34 INFO - 'MOZ_NO_REMOTE': '1', 08:56:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:34 INFO - 'NO_EM_RESTART': '1', 08:56:34 INFO - 'PAGER': '/bin/cat', 08:56:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:34 INFO - 'PWD': '/builds/slave/test', 08:56:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:34 INFO - 'RUST_BACKTRACE': '1', 08:56:34 INFO - 'SHELL': '/bin/bash', 08:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y6NFs5qt58/Listeners', 08:56:34 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:34 INFO - 'USER': 'cltbld', 08:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:34 INFO - 'XPC_FLAGS': '0x0', 08:56:34 INFO - 'XPC_SERVICE_NAME': '0', 08:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:34 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/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0236', '--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 08:56:34 INFO - mozversion application_buildid: 20170316073537 08:56:34 INFO - mozversion application_changeset: 3ea221e3ebbb5d604da5ff94ac122bbaf08170b5 08:56:34 INFO - mozversion application_display_name: Nightly 08:56:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:34 INFO - mozversion application_name: Firefox 08:56:34 INFO - mozversion application_remotingname: firefox 08:56:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:56:34 INFO - mozversion application_vendor: Mozilla 08:56:34 INFO - mozversion application_version: 55.0a1 08:56:34 INFO - mozversion platform_buildid: 20170316073537 08:56:34 INFO - mozversion platform_changeset: 3ea221e3ebbb5d604da5ff94ac122bbaf08170b5 08:56:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:56:34 INFO - mozversion platform_version: 55.0a1 08:56:34 INFO - using testdate: 1489679794 08:56:34 INFO - actual date: 1489679794 08:56:34 INFO - starting webserver on 'localhost:49241' 08:56:34 INFO - SUITE-START | Running 2 tests 08:56:34 INFO - TEST-START | dromaeo_css 08:56:34 INFO - operating with platform_type : mac_ 08:56:34 INFO - Initialising browser for dromaeo_css test... 08:56:34 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpAlQu_5/profile http://localhost:49241/getInfo.html) 08:56:37 INFO - PID 1638 | 2017-03-16 08:56:37.930 plugin-container[1640:7704] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a53, name = 'com.apple.tsm.portname' 08:56:37 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:37 INFO - PID 1638 | 2017-03-16 08:56:37.932 plugin-container[1640:7704] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 08:56:37 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:37 INFO - PID 1638 | 2017-03-16 08:56:37.932 plugin-container[1640:7704] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:56:38 INFO - PID 1638 | __metrics Screen width/height:1600/1200 08:56:38 INFO - PID 1638 | colorDepth:24 08:56:38 INFO - PID 1638 | Browser inner width/height: 1024/689 08:56:38 INFO - PID 1638 | __metrics 08:56:38 ERROR - PID 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:56:38 INFO - TEST-INFO | 1638: exit 0 08:56:38 INFO - Browser initialized. 08:56:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:38 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpAlQu_5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:41 INFO - PID 1641 | 2017-03-16 08:56:41.388 plugin-container[1642:7832] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 08:56:41 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:41 INFO - PID 1641 | 2017-03-16 08:56:41.388 plugin-container[1642:7832] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 08:56:41 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:41 INFO - PID 1641 | 2017-03-16 08:56:41.388 plugin-container[1642:7832] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:56:51 INFO - PID 1641 | RSS: Main: 228024320 08:56:51 INFO - PID 1641 | 08:59:54 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:59:56 INFO - PID 1641 | RSS: Main: 251400192 08:59:56 INFO - PID 1641 | 09:01:39 INFO - PID 1641 | ************************* 09:01:39 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 09:01:39 INFO - PID 1641 | 09:01:39 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:01:39 INFO - PID 1641 | Full stack: 09:01:39 INFO - PID 1641 | ************************* 09:02:58 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:02:59 INFO - PID 1641 | RSS: Main: 259383296 09:02:59 INFO - PID 1641 | 09:06:01 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:06:02 INFO - PID 1641 | RSS: Main: 271265792 09:06:02 INFO - PID 1641 | 09:09:04 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:09:04 INFO - PID 1641 | RSS: Main: 264204288 09:09:04 INFO - PID 1641 | 09:12:07 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:12:08 INFO - PID 1641 | RSS: Main: 276094976 09:12:08 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:15:11 INFO - PID 1641 | RSS: Main: 270856192 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | __start_tp_report 09:15:11 INFO - PID 1641 | _x_x_mozilla_page_load 09:15:11 INFO - PID 1641 | _x_x_mozilla_page_load_details 09:15:11 INFO - PID 1641 | |i|pagename|runs| 09:15:11 INFO - PID 1641 | |0;dojo.html;3416.1971936594896;3426.400379933513;3469.358168738782;3474.114100904269;3475.0269924421173;4304.827806887721;5811;5943.673097979615;5999.250093738283;6008.038713805792;4306.72006319589;5401.4328495508;5762.222100016496;5802.274715660543;5803.680797556132;5339.332583427072;5383;5387.24578559002;5388.299521062257;5484.8354549363585;5317.361916569997;5457.126859702448;5465.836024919259;5472.480114389126;5480.890382192354;5416.729163541827;5478.04134276502;5487.2317875497465;5488.9725551372385;5505.146702261156;5231.581473482112;5296.205569164617;5304.575633949275;5307.2835167252315;5436.429174936614;5155.865709543894;5239.266502689627;5308.442613525602;5324.787008519655;5330.333708286465;4510.345999830039;5251.317328747276;5771.787924535811;5904.5571582131515;5934.732937017845;5595.020871347539;6001.66990815505;6337.6831158442355;6346.524010699216;6351.523635727339;5824.922389357982;6102.328743838174;6261.7182226799905;6327.778527751507;6429.549931504796;6105.914670190187;6106.664133472702;6130.3369889931655;6138.728093731984;6158.7228574714245;5949.8397812426165;6552.770653027121;6595.208574971034;6627.635480048547;6650.46796256308;6215.316315205324;6228.875422491525;6229.314775374705;6260.060990851318;6262.436380725665;6336.144620476269;6392.968035159794;6414.967925160345;6417.807465776034;6479.1901012373455;5056.342675452168;5377.7580008899695;6293.30773614902;6319.462845658079;6349.238091428966;6192.783252586138;6217.368539157735;6280.591761535486;6328.873422531524;6353;4616.446026476844;4859.586935110485;5081.491850814963;5117.948820511821;5135.255387968724;4587.816487340536;4597.908041839211;4603.470600880874;4605.631549476034;4652.069586082797;6197.070439434121;6198.690065496708;6217.347178546278;6219.906701399483;6231.501479881598;6255.280642726145;6339.714712837934;6353.269374021954;6376;6402.071699603532;6079.190768710056;6194.5044396448175;6203.751849925952;6214.067889816473;6225.221847269091;5674.092145256822;5690.2033715279895;5700.714964251771;5705.74324155414;5715.31416230055;6339.461145802474;6342.714577843916;6543.967280163569;6569.737210511717;6730.158730158731;6408.9038664421005;6436.420722135031;6441.806745797634;6442.387973142544;6447.742090316335;5654.547636189012;6433;6479.416852483299;6631.005349197466;6642.501812363996;5929.140274660236;6103.610425594382;6249.25008998923;6292.182016337847;6326.746930122928;5027.818462661345;6235.438810507076;6265;6349.07938348946;6395.872082558416;4878.56092951636;6296.212973378328;6301.40136687014;6317.147185129948;6318.968405157945;6260.780872669435;6295.937040629535;6316.242050953915;6322.494200464043;6329.778457753957;5344.572434205332;5961.642301461926;6110.57225994194;6114.38856114385;6122.571420000557;6215.564910456224;6244.344343843831;6268.216472940882;6271.341509141657;6300.369963003663;6176.227971503562;6197.1324014638885;6223;6266.122742815918;6271.31015588294 09:15:11 INFO - PID 1641 | |1;ext.html;359.7625567125696;732.1470486882782;786.3826895886729;799.780060483367;831.9958400207998;36049.91850244493;36951;37004.81497592515;37009.334579943934;37015;38172.66395676152;38592.61407385925;38693.03267418309;38696.61303386965;38757.22485550287;8930.106989301083;9154.450732956011;9252.491112988782;10732.034116929475;11029.83455248172;11041.558337666524;11136.387498687609;11141.220114591983;11172.497237624326;11175.385353805577;11089;11127.942845429712;11164.330140191574;11196.552137914474;11197.216194866322;11100.944495277512;11152.944235278772;11164.720881977933;11184.273022253528;11199.992000719974;10971.890281097167;11038.724031899186;11060.502277397536;11072.224944253905;11117.72205694856;32061;38962.41556376657;39098.41352379688;39116.804415978026;39173;3899.161680238762;3920.2551515212017;3920.3923391874305;3926.332523471017;3933.5869733677837;27888;28047.878084876582;28224.87100515977;28523.714762852313;29099.56350654742;3183.267848394882;3184.7292980096718;3210.678932106794;3277.3936821687826;3334.333133373335;252005;255006;276984.23015769786;355156;355453;47032.294515582296;47062.117515299;47151;47171.764141179076;47303;49143.01713965701;49218.75390623024;49336;49372.51882443533;49418.25872611914;14228.004039717327;14366.425342986164;14643.780343294646;14669.92665036668;14693.706125877636;12012.939935300443;12024.098192635587;12035.217710848767;12035.699107522207;12042.09684273683;11551;11797.115216358636;13278.7385198406;13880.51418200358;13891.235982021086;5215.6609820361555;5524.1989911462615;5698.458646428583;6130.509559235251;6179.69101544921;1050.6007717067619;1119.283658458587;1121.899029087386;1127.21095233337;1160.5879912630894;25830.354241143745;26300.605490917653;26352.341191469983;26374.20877373682;26534.734652653227;1228.299869074619;1228.784962631536;1229.1150371732338;1241.2366394667215;1291.5802364231474;11276.774464510829;12422.130450868533;13523.526676566273;13611;13686.384112714952;449637;451132.48867511563;451807.4819251831;451837;453482;56979.14531282034;57013.42986570081;57131;57140.42859571351;57239;1413.8232720909887;1466.8166479190102;1470.4559313054237;1471.9852801472061;1486.6877955629222;25007.624885626366;25287;25877.353066173495;26044.73955260423;26401.471970560866;45707;45772.31341529946;45841.54158458373;45926.54073459223;45954.54045459503;442778;442962;444179;445870;446468;31466.370672585963;31978.680213198502;32055.358892821547;32066.679333206368;33314.5002824953;40655.59344406636;41883.7905810469;42774.35838462488;44173.67478975636;44394.890127747065;33515.329693406486;35550.51146419726;35870.282594348486;36574.634253657125;36733.63266367302;34844.65155348516;35134.82432587923;36162.63837361698;36280.63719362773;36348.45477317895;35449.645503544634;35685.64314356823;35762.284754304244;36411;36614.8169259152;29872.701272986993;31502.21244468815;31509.527357089202;31511.21221969469;31670.524942125427;23871.403214919766;24063;24081.638775418032;24088.15691450791;24229.63655545133 09:15:11 INFO - PID 1641 | |2;jquery.html;374.25523208814457;404.80973942247135;413.37167505391824;417.1261207769723;433.75059340879005;21136.365909022734;21156.682649760227;22005.559888802236;22740.65889011662;22961.311160665166;21379;21832.454188645293;22181;22627.660585091195;22752.8862355688;6597.307282735315;6636.7345306187935;6845.212800527928;6902.965485172567;6907.551009184387;6499.350064993487;6689.7658581949645;6699.263081061104;6703.463722902156;6712.630805305706;7521;7942.4837385570045;7953.880691789628;7954.403419743513;7970.282674559288;7633.885491717601;7859.882101768478;7904.920950790504;7975.72084977023;8006;7529.284717951786;7756.806079847993;7782.844343113163;7782.844343113163;7806.921930780676;27678.584821227698;28207;28248;28362.432751345063;28372.85813570919;3259.9022029339158;3294.456414691573;3368.326334733063;3427.143214196451;3484.5992710838323;15722.978006429545;16398.26207820651;16902.07038612876;16923.492295231164;17275.654486910193;1738.75657407963;1863.4689113602694;1987.6720341143694;2005.4986253436641;2079.4073688998715;149487;155473;156172;156895;158606;17514.649707006043;21851.890740546194;22272.66364018164;22550.21074262393;22993.54012919732;28783.71216287852;29238.26904327409;36426.635733642855;36487.27025459529;36617.267654646756;10477.795053568785;10551.894481055244;10600.25798194119;10724.195685323632;10877.510512026978;8531.701390451304;8543.102974187745;8590.269827064769;8666.78333041679;8668.219860212612;10649.751825693238;10882.183836212158;10925.180611454172;11041.282316649393;11105.000549950542;3766.51391194568;4424.805302568288;4520.095980803787;4528.750918699503;4569.702969307051;830.683366863516;874.4845720204742;887.6538150121457;895.2077411490748;906.2613969614742;20923;22649.094036238366;23041.539169216856;23045.654315185286;23288.65067023996;908.4549270437817;910.9954450227839;939.8308304505255;942.5522876633544;943.0852073488705;8923.196912277926;11425.028872545761;11661.766764664659;11992.100592455601;12310.384480775925;585445;586763;593892;649915;692374;112106;115778;141201;142264;142802;1222.4376786678229;1255.3785875991443;1308.3654427602605;1309.312610879277;1310.593715948059;19129.33047343336;21033.684494732897;21612.89193554085;21649.59277646948;21704.96130541694;61757.69121154366;61950;63631.36368636254;63703.725925482155;66227;66861;85175;86412.56793716243;86480.27039459301;86681;12064.276143431422;12124.33316167584;12466.937665311616;12507.93746031264;12580.056495762672;13703.794443083561;13868.583942481742;13932.373043212878;14171.503997360043;14177.432902683777;6210.503159747119;10717.9464102679;11599.942000289944;11763.588274410355;12043.397830108635;10158.136558392323;11723.765524689628;11808.232464889754;11957.581484647995;12135.75728485443;11177.552897883994;12059.21615095016;12184.147109702235;12218.572349967708;12221.083418743452;12027.15809893299;12049.156559040783;12087.637370878887;12313.938430307791;12318.260904345769;10485.475726213506;10772.676819695422;11525.827112593486;11873.16887817879;11943.522259109539 09:15:11 INFO - PID 1641 | |3;mootools.html;1466.1642863567768;1587.2857214253588;1587.849154330339;1591.291875115574;1614.3784642912478;10376.273660843735;10829.566817327297;10861.294015888972;10910.61812836551;11306.038986686142;9985.800283994335;10609.469526523682;10944.069754070913;11122.165837562176;11188.720281992953;2268.739095004079;2310.9537809243807;2312.560613483441;2315.016118149788;2319.3621754017613;2272.397814579138;2285.9771402285933;2296.3570200343847;2314.733805612351;2315.7568455312203;1903.0009245146339;2252.00911598896;2266.29744779119;2266.478709896725;2275.943101422461;2167.0789914286365;2233.073274591051;2236.888155592222;2240.4174914522177;2249.853759505627;1902.5529000684828;2261.6155253606926;2265;2265.558216147852;2267.7845604667696;10731.356118632906;10824.945875270652;10839.295445795999;10840.6205782798;10868.021878030937;5474.589405794582;5728.198052272685;5738;5747.453991870766;5767.740451679684;2794.441111777632;2966.9406611867857;3077.984610076958;3197.712205901457;3261.951070733941;1079.7786453776957;1081.6592773276393;1101.8126918423807;1115.1357697784201;1120.2494328799642;12660.366981650881;15030.32363543643;15045.699086018329;15406.22968851553;15437.459688910834;3684.465752465931;4402.779861006937;4521.005378816655;4521.864344069683;4531.207038768268;11465.942670286595;11560.710982225512;11563.190576659721;11582.536698532133;11703.180777345504;5532.114861622202;5539.335279766454;5583.804566840141;5593.46862048113;5604.495595396434;4882.12121818069;5038.622103342264;5080.49195080489;5106.66806657566;5115.590752739772;3659.2315613720884;3709.350863598859;3761.1725420407465;3769.5853456119803;3810.3712887373827;958.2621381536178;963.6530848894392;963.889152747429;965.9372140810965;967.3373738988815;806.5644551941886;912.7946212102224;947.8009617980164;967.9516024198762;985.4579981010415;6297.1813664223355;6549.541532092803;6576.210854697371;6624.735010599522;6768.221654509696;952.2905435450633;995.690666773191;1003.844404117363;1019.3170575714289;1019.7858449725641;3834.482344883405;4153.107081977329;4158.293090174678;4215.262329092397;4279.7218180818145;12995.220286782824;13394.93302533481;13428.328583570783;13434.93282533581;13443.462261509625;11763.941180294214;12821.551245706356;13212.867871321163;13265.801012984813;13348.6662833428;8508.27679647237;9751.561179746928;9877.357971731815;9990.15083717892;10089.344192627455;5154.407243166934;6668.366505182;6757.155355580552;6818.045473633596;6821.863562728817;8727.389082764399;11505;11593.6521904343;12025.518979240733;12041.638750837488;11673.12451566119;11785.882141178821;12107.273563586214;12151.696207594881;12263.080268979684;9200.585973631069;9230.123138301851;9238.584263708015;9253.814923701622;9426.963034066384;10141.340812847142;10161.898381016095;10166.135878450414;10269.178465722875;10270.537825797708;9041.909580904106;9089.909100908906;9134.31492638068;9147.0852914708;9152.4966126861;8350.41547091722;8410.116937721696;8525.658973641233;8591.355648326526;8647.351448641251;7617.352525035434;7903;7964.721234756756;8013.318867896294;8028.43800933929;5096.898062038813;5850.619709718854;5919.733611987384;5988.820335389945;6015.157877897185;5005;5908.911366329595;5963.940360596339;6113.327533971171;6148 09:15:11 INFO - PID 1641 | |4;prototype.html;317.4064499386148;336.3777012526825;371.9572249191344;383.1742594708404;394.4891365681443;5868.442497962697;5916.285016506264;5996.130561068642;6072.483838873695;6101.511879049676;5754.280714910637;5906.05503119501;5926.851828704284;5928.940710592893;5936.257967754031;4185.414042034117;4692.389989301386;4722.50413706561;4851.63612729045;4865.3675022247235;4818.7831547580445;4839.661223714342;4866.440359358666;4872.171730805771;4876.731779752112;3743.962560374402;4510.594046535811;4595.448546174463;4865.708057516543;4878.048780487807;4118.972555171947;4311.28863737483;4553.476350219701;4684.992726563788;4727.527247275245;4418.381426600278;4418.889527761799;4441.555844415532;4453.710508816949;4457.710248833815;4567.748773817439;5645.15322701594;5698;5712.8857422851725;5720.113382425689;5119.8208062717995;5232.450592687751;5414.0763987446735;5525.917111243334;5698.91720573094;4956;6284.491721986736;6335.271443783978;6350.110984462132;6389;4767.213409787416;4977.552020318189;5000.874978125539;5011.747063234191;5011.924821127686;6382.989353357592;6494.675266236716;6552.246491653474;6694.93305066948;6728.798136055926;4937.35814344133;5091.134507133796;5096.694198348111;5096.770645320969;5097.541221290027;4865.683730557503;5211.609129315317;5227.712475813791;5233.764480598382;5242.5281724644965;4665;5245.213218017251;5357.571394288448;5503.2020357048805;5595.804146854841;5737.627054241461;6309.116723658692;6324.778632747832;6339.302676705559;6361.745530178741;1528.4650372369804;1719.7764290642388;1789.74943507909;1796.2365994452305;1823.4165067178642;1145.0381679389352;1175.3241885915634;1325.562564353761;1330.1021810278023;1350.8514063453013;5606.6916319602;5691.922448306338;5812.157237200667;5896.351401345849;5952.434518720715;6069.2716873975405;6140.263168419819;6494.512911531654;6518.902216466757;6535.477161827042;4783.736894470838;4792.904141917212;5183.663061900965;5580.173150225026;5893.469587737124;2991.1176203019727;3294.7528935329947;3394.1514621344663;3427.3316703242626;3454.3436747017986;6724.394804467622;6731.865362692719;6769.830754231184;6805.693743781541;6844.384005439435;5009.44896061433;5561.749721262553;5591.580631452657;5965.194698715704;6655.500837437212;6145.846353841011;6384.170057892445;6746.291639377893;6808.183018037867;6824.7952561423235;6369.426751592379;6524.804255872142;6580.934190658224;6592.76925307612;6597.835054123493;5227.712475813714;5692.516136128475;5815.447532484407;6457;6458.870822583616;5860.677662728591;6547.934520654732;6659.4006539411685;6741.325867413219;6763.7632682855865;4446.866594002185;4638.373819534319;5102.43873173958;5116.820911268088;5119;6207.282465326294;6311.526635502264;6442.840288748071;6497.772577959749;6501.512386570931;6256.99888017915;6262.968685156545;6301;6321.557490975588;6335.683215839282;5199.870003249949;5355.303810504765;5862;6161.5686901918225;6361.7137228823885;6096.908546371897;6114.57197996136;6127.387261273837;6132.570720049732;6141.723622437091;6071.360732602261;6261.874762504815;6305.148804911279;6305.432511073842;6316.873662526816;5570.86072848182;6026.457618814327;6102.176206212104;6119.173911521888;6119.388061193845 09:15:11 INFO - PID 1641 | |5;yui.html;627.6359711367407;695.4828389609484;760.9201033891442;811.6712731343806;827.1769589258688;12214.511419543218;15753.369865205377;16393.836061639395;16418.097004664753;16521.421750238744;15018.324175412105;15351.462698805544;15360.692786144271;15369.923150384233;15872.444464443746;934.3693007220116;954.6515521834515;962.5668449197854;969.0261287406147;969.5491596407669;935.0789472369711;966.3235734985503;970.7039352997333;975.5707488704983;976.5849513956575;1021.6985989133186;1022.1669339488293;1022.3150489172273;1023.3194925374617;1024.119257438606;1012.711377257478;1014.523174108168;1015.0002247785925;1015.9898401016006;1019.1846522781819;744.7765670298888;755.7090520149727;756.9205233450464;758.1735907860403;758.518340853562;16127.354905803753;16445.424410145588;16578.253978570992;16825.15874206285;17077.7438338425;13498.325083745773;14697.191654459;14833.480828170963;14901.627459313495;15072.518533619017;11692.356920369377;11730.472128754227;11761.705957351049;12027.759444811143;12156.51373945041;3637;3672.9632703672887;3715.498407714951;3795.5635101963353;3804.8478060877533;64097.29837503748;110276;116981.83018169795;118219.40890295494;121030;11383.43082845871;11470.655880323604;11476.770464590662;11481.540738370539;11738.295702257892;24606.761707550275;24963.251102466955;25151.748482515308;25152.11967581126;25221.117260895782;6983.930160698328;7913.089994650573;7964.8805267921025;8062.7581172564915;8184.263416292562;4211.936820947627;4264.1471705659;4310.83775438668;4322.675799315064;4414.889627759268;3186.2990142168687;3223.17808958714;3250.398676244902;3271.607407111162;3276;568.7469076261107;570.361195461078;582.3884920833108;587.3451102021215;589.3487696095838;671.425930829134;672.324314064372;695.8990946312756;712.3944647049966;733.886247631618;9602;9870.111689947938;9971.501424928725;10128.54421551032;10204.336718113298;600.8077415227173;634.2294112653149;647.5887811239802;665.9567128136656;671.7514519627769;3842.442845787345;4222.472190976128;4704.29435584665;4709.599684026896;4721.575058244705;89794.30617081498;104402.4779876111;108261.45869270603;109602.45198773955;109875;63112;94385.5842162368;94644;97331;98617.01382986078;69396.65301673459;76368.9999999989;81732;82383.94040149044;82512.58743706363;9290.535473226177;9295.024022477543;9396.765080873032;9458.621655133718;9513.952430237805;35877.28245435129;48538.9034151409;48556.27165592448;48631.75684121557;49830.25254621256;50349.496505035946;62395.688021561415;63915;64834;64984.675076626205;11584.652460426201;11848.940755296167;11863.822042669195;11926.821097683714;12047.879521204675;12468.376581171087;12666.87333126657;12697.174683645533;12758.74482510326;12798.360081996048;11576.189666723249;12110.273383597012;12258.30317330186;12268.570600028956;12293.815592766294;11475.885241147482;11582.478788454708;11857.762844742885;12169.178607667129;12481.188722732993;11526.711832204262;11600.535978560763;11646.767064658829;11897.821532676844;11913.987311078656;8348.534718642244;9534.427934323963;9785.168260697636;9871.703848884545;10457.006584374472;8142.959285203536;8863;9694.46680432583;9857.901420985698;9864.457454840052 09:15:11 INFO - PID 1641 | __end_tp_report 09:15:11 INFO - PID 1641 | __start_cc_report 09:15:11 INFO - PID 1641 | _x_x_mozilla_cycle_collect,429 09:15:11 INFO - PID 1641 | __end_cc_report 09:15:11 INFO - PID 1641 | __startTimestamp1489680911443__endTimestamp 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | ------- Summary: start ------- 09:15:11 INFO - PID 1641 | Number of tests: 6 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | [#0] dojo.html Cycles:165 Average:5844.60 Median:6158.72 stddev:690.80 (11.2%) stddev-sans-first:666.14 09:15:11 INFO - PID 1641 | Values: 3416.2 3426.4 3469.4 3474.1 3475.0 4304.8 5811.0 5943.7 5999.3 6008.0 4306.7 5401.4 5762.2 5802.3 5803.7 5339.3 5383.0 5387.2 5388.3 5484.8 5317.4 5457.1 5465.8 5472.5 5480.9 5416.7 5478.0 5487.2 5489.0 5505.1 5231.6 5296.2 5304.6 5307.3 5436.4 5155.9 5239.3 5308.4 5324.8 5330.3 4510.3 5251.3 5771.8 5904.6 5934.7 5595.0 6001.7 6337.7 6346.5 6351.5 5824.9 6102.3 6261.7 6327.8 6429.5 6105.9 6106.7 6130.3 6138.7 6158.7 5949.8 6552.8 6595.2 6627.6 6650.5 6215.3 6228.9 6229.3 6260.1 6262.4 6336.1 6393.0 6415.0 6417.8 6479.2 5056.3 5377.8 6293.3 6319.5 6349.2 6192.8 6217.4 6280.6 6328.9 6353.0 4616.4 4859.6 5081.5 5117.9 5135.3 4587.8 4597.9 4603.5 4605.6 4652.1 6197.1 6198.7 6217.3 6219.9 6231.5 6255.3 6339.7 6353.3 6376.0 6402.1 6079.2 6194.5 6203.8 6214.1 6225.2 5674.1 5690.2 5700.7 5705.7 5715.3 6339.5 6342.7 6544.0 6569.7 6730.2 6408.9 6436.4 6441.8 6442.4 6447.7 5654.5 6433.0 6479.4 6631.0 6642.5 5929.1 6103.6 6249.3 6292.2 6326.7 5027.8 6235.4 6265.0 6349.1 6395.9 4878.6 6296.2 6301.4 6317.1 6319.0 6260.8 6295.9 6316.2 6322.5 6329.8 5344.6 5961.6 6110.6 6114.4 6122.6 6215.6 6244.3 6268.2 6271.3 6300.4 6176.2 6197.1 6223.0 6266.1 6271.3 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | [#1] ext.html Cycles:180 Average:54151.97 Median:32063.84 stddev:107472.41 (335.2%) stddev-sans-first:107698.01 09:15:11 INFO - PID 1641 | Values: 359.8 732.1 786.4 799.8 832.0 36049.9 36951.0 37004.8 37009.3 37015.0 38172.7 38592.6 38693.0 38696.6 38757.2 8930.1 9154.5 9252.5 10732.0 11029.8 11041.6 11136.4 11141.2 11172.5 11175.4 11089.0 11127.9 11164.3 11196.6 11197.2 11100.9 11152.9 11164.7 11184.3 11200.0 10971.9 11038.7 11060.5 11072.2 11117.7 32061.0 38962.4 39098.4 39116.8 39173.0 3899.2 3920.3 3920.4 3926.3 3933.6 27888.0 28047.9 28224.9 28523.7 29099.6 3183.3 3184.7 3210.7 3277.4 3334.3 252005.0 255006.0 276984.2 355156.0 355453.0 47032.3 47062.1 47151.0 47171.8 47303.0 49143.0 49218.8 49336.0 49372.5 49418.3 14228.0 14366.4 14643.8 14669.9 14693.7 12012.9 12024.1 12035.2 12035.7 12042.1 11551.0 11797.1 13278.7 13880.5 13891.2 5215.7 5524.2 5698.5 6130.5 6179.7 1050.6 1119.3 1121.9 1127.2 1160.6 25830.4 26300.6 26352.3 26374.2 26534.7 1228.3 1228.8 1229.1 1241.2 1291.6 11276.8 12422.1 13523.5 13611.0 13686.4 449637.0 451132.5 451807.5 451837.0 453482.0 56979.1 57013.4 57131.0 57140.4 57239.0 1413.8 1466.8 1470.5 1472.0 1486.7 25007.6 25287.0 25877.4 26044.7 26401.5 45707.0 45772.3 45841.5 45926.5 45954.5 442778.0 442962.0 444179.0 445870.0 446468.0 31466.4 31978.7 32055.4 32066.7 33314.5 40655.6 41883.8 42774.4 44173.7 44394.9 33515.3 35550.5 35870.3 36574.6 36733.6 34844.7 35134.8 36162.6 36280.6 36348.5 35449.6 35685.6 35762.3 36411.0 36614.8 29872.7 31502.2 31509.5 31511.2 31670.5 23871.4 24063.0 24081.6 24088.2 24229.6 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | [#2] jquery.html Cycles:180 Average:39345.76 Median:22694.88 stddev:104540.19 (460.6%) stddev-sans-first:104792.50 09:15:11 INFO - PID 1641 | Values: 374.3 404.8 413.4 417.1 433.8 21136.4 21156.7 22005.6 22740.7 22961.3 21379.0 21832.5 22181.0 22627.7 22752.9 6597.3 6636.7 6845.2 6903.0 6907.6 6499.4 6689.8 6699.3 6703.5 6712.6 7521.0 7942.5 7953.9 7954.4 7970.3 7633.9 7859.9 7904.9 7975.7 8006.0 7529.3 7756.8 7782.8 7782.8 7806.9 27678.6 28207.0 28248.0 28362.4 28372.9 3259.9 3294.5 3368.3 3427.1 3484.6 15723.0 16398.3 16902.1 16923.5 17275.7 1738.8 1863.5 1987.7 2005.5 2079.4 149487.0 155473.0 156172.0 156895.0 158606.0 17514.6 21851.9 22272.7 22550.2 22993.5 28783.7 29238.3 36426.6 36487.3 36617.3 10477.8 10551.9 10600.3 10724.2 10877.5 8531.7 8543.1 8590.3 8666.8 8668.2 10649.8 10882.2 10925.2 11041.3 11105.0 3766.5 4424.8 4520.1 4528.8 4569.7 830.7 874.5 887.7 895.2 906.3 20923.0 22649.1 23041.5 23045.7 23288.7 908.5 911.0 939.8 942.6 943.1 8923.2 11425.0 11661.8 11992.1 12310.4 585445.0 586763.0 593892.0 649915.0 692374.0 112106.0 115778.0 141201.0 142264.0 142802.0 1222.4 1255.4 1308.4 1309.3 1310.6 19129.3 21033.7 21612.9 21649.6 21705.0 61757.7 61950.0 63631.4 63703.7 66227.0 66861.0 85175.0 86412.6 86480.3 86681.0 12064.3 12124.3 12466.9 12507.9 12580.1 13703.8 13868.6 13932.4 14171.5 14177.4 6210.5 10717.9 11599.9 11763.6 12043.4 10158.1 11723.8 11808.2 11957.6 12135.8 11177.6 12059.2 12184.1 12218.6 12221.1 12027.2 12049.2 12087.6 12313.9 12318.3 10485.5 10772.7 11525.8 11873.2 11943.5 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | [#3] mootools.html Cycles:180 Average:6547.79 Median:3229.83 stddev:4120.96 (127.6%) stddev-sans-first:4114.84 09:15:11 INFO - PID 1641 | Values: 1466.2 1587.3 1587.8 1591.3 1614.4 10376.3 10829.6 10861.3 10910.6 11306.0 9985.8 10609.5 10944.1 11122.2 11188.7 2268.7 2311.0 2312.6 2315.0 2319.4 2272.4 2286.0 2296.4 2314.7 2315.8 1903.0 2252.0 2266.3 2266.5 2275.9 2167.1 2233.1 2236.9 2240.4 2249.9 1902.6 2261.6 2265.0 2265.6 2267.8 10731.4 10824.9 10839.3 10840.6 10868.0 5474.6 5728.2 5738.0 5747.5 5767.7 2794.4 2966.9 3078.0 3197.7 3262.0 1079.8 1081.7 1101.8 1115.1 1120.2 12660.4 15030.3 15045.7 15406.2 15437.5 3684.5 4402.8 4521.0 4521.9 4531.2 11465.9 11560.7 11563.2 11582.5 11703.2 5532.1 5539.3 5583.8 5593.5 5604.5 4882.1 5038.6 5080.5 5106.7 5115.6 3659.2 3709.4 3761.2 3769.6 3810.4 958.3 963.7 963.9 965.9 967.3 806.6 912.8 947.8 968.0 985.5 6297.2 6549.5 6576.2 6624.7 6768.2 952.3 995.7 1003.8 1019.3 1019.8 3834.5 4153.1 4158.3 4215.3 4279.7 12995.2 13394.9 13428.3 13434.9 13443.5 11763.9 12821.6 13212.9 13265.8 13348.7 8508.3 9751.6 9877.4 9990.2 10089.3 5154.4 6668.4 6757.2 6818.0 6821.9 8727.4 11505.0 11593.7 12025.5 12041.6 11673.1 11785.9 12107.3 12151.7 12263.1 9200.6 9230.1 9238.6 9253.8 9427.0 10141.3 10161.9 10166.1 10269.2 10270.5 9041.9 9089.9 9134.3 9147.1 9152.5 8350.4 8410.1 8525.7 8591.4 8647.4 7617.4 7903.0 7964.7 8013.3 8028.4 5096.9 5850.6 5919.7 5988.8 6015.2 5005.0 5908.9 5963.9 6113.3 6148.0 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | [#4] prototype.html Cycles:180 Average:5246.49 Median:5695.26 stddev:1493.32 (26.2%) stddev-sans-first:1450.96 09:15:11 INFO - PID 1641 | Values: 317.4 336.4 372.0 383.2 394.5 5868.4 5916.3 5996.1 6072.5 6101.5 5754.3 5906.1 5926.9 5928.9 5936.3 4185.4 4692.4 4722.5 4851.6 4865.4 4818.8 4839.7 4866.4 4872.2 4876.7 3744.0 4510.6 4595.4 4865.7 4878.0 4119.0 4311.3 4553.5 4685.0 4727.5 4418.4 4418.9 4441.6 4453.7 4457.7 4567.7 5645.2 5698.0 5712.9 5720.1 5119.8 5232.5 5414.1 5525.9 5698.9 4956.0 6284.5 6335.3 6350.1 6389.0 4767.2 4977.6 5000.9 5011.7 5011.9 6383.0 6494.7 6552.2 6694.9 6728.8 4937.4 5091.1 5096.7 5096.8 5097.5 4865.7 5211.6 5227.7 5233.8 5242.5 4665.0 5245.2 5357.6 5503.2 5595.8 5737.6 6309.1 6324.8 6339.3 6361.7 1528.5 1719.8 1789.7 1796.2 1823.4 1145.0 1175.3 1325.6 1330.1 1350.9 5606.7 5691.9 5812.2 5896.4 5952.4 6069.3 6140.3 6494.5 6518.9 6535.5 4783.7 4792.9 5183.7 5580.2 5893.5 2991.1 3294.8 3394.2 3427.3 3454.3 6724.4 6731.9 6769.8 6805.7 6844.4 5009.4 5561.7 5591.6 5965.2 6655.5 6145.8 6384.2 6746.3 6808.2 6824.8 6369.4 6524.8 6580.9 6592.8 6597.8 5227.7 5692.5 5815.4 6457.0 6458.9 5860.7 6547.9 6659.4 6741.3 6763.8 4446.9 4638.4 5102.4 5116.8 5119.0 6207.3 6311.5 6442.8 6497.8 6501.5 6257.0 6263.0 6301.0 6321.6 6335.7 5199.9 5355.3 5862.0 6161.6 6361.7 6096.9 6114.6 6127.4 6132.6 6141.7 6071.4 6261.9 6305.1 6305.4 6316.9 5570.9 6026.5 6102.2 6119.2 6119.4 09:15:11 INFO - PID 1641 | 09:15:11 INFO - PID 1641 | [#5] yui.html Cycles:180 Average:20168.50 Median:3800.21 stddev:29648.73 (780.2%) stddev-sans-first:29695.59 09:15:11 INFO - PID 1641 | Values: 627.6 695.5 760.9 811.7 827.2 12214.5 15753.4 16393.8 16418.1 16521.4 15018.3 15351.5 15360.7 15369.9 15872.4 934.4 954.7 962.6 969.0 969.5 935.1 966.3 970.7 975.6 976.6 1021.7 1022.2 1022.3 1023.3 1024.1 1012.7 1014.5 1015.0 1016.0 1019.2 744.8 755.7 756.9 758.2 758.5 16127.4 16445.4 16578.3 16825.2 17077.7 13498.3 14697.2 14833.5 14901.6 15072.5 11692.4 11730.5 11761.7 12027.8 12156.5 3637.0 3673.0 3715.5 3795.6 3804.8 64097.3 110276.0 116981.8 118219.4 121030.0 11383.4 11470.7 11476.8 11481.5 11738.3 24606.8 24963.3 25151.7 25152.1 25221.1 6983.9 7913.1 7964.9 8062.8 8184.3 4211.9 4264.1 4310.8 4322.7 4414.9 3186.3 3223.2 3250.4 3271.6 3276.0 568.7 570.4 582.4 587.3 589.3 671.4 672.3 695.9 712.4 733.9 9602.0 9870.1 9971.5 10128.5 10204.3 600.8 634.2 647.6 666.0 671.8 3842.4 4222.5 4704.3 4709.6 4721.6 89794.3 104402.5 108261.5 109602.5 109875.0 63112.0 94385.6 94644.0 97331.0 98617.0 69396.7 76369.0 81732.0 82383.9 82512.6 9290.5 9295.0 9396.8 9458.6 9514.0 35877.3 48538.9 48556.3 48631.8 49830.3 50349.5 62395.7 63915.0 64834.0 64984.7 11584.7 11848.9 11863.8 11926.8 12047.9 12468.4 12666.9 12697.2 12758.7 12798.4 11576.2 12110.3 12258.3 12268.6 12293.8 11475.9 11582.5 11857.8 12169.2 12481.2 11526.7 11600.5 11646.8 11897.8 11914.0 8348.5 9534.4 9785.2 9871.7 10457.0 8143.0 8863.0 9694.5 9857.9 9864.5 09:15:11 INFO - PID 1641 | -------- Summary: end -------- 09:15:11 INFO - PID 1641 | 09:15:12 INFO - TEST-INFO | 1641: exit 0 09:15:12 INFO - TEST-OK | dromaeo_css | took 1117211ms 09:15:12 INFO - TEST-START | kraken 09:15:12 INFO - operating with platform_type : mac_ 09:15:12 INFO - Initialising browser for kraken test... 09:15:12 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpZg167r/profile http://localhost:49241/getInfo.html) 09:15:15 INFO - PID 1654 | 2017-03-16 09:15:15.207 plugin-container[1655:10315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 09:15:15 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:15 INFO - PID 1654 | 2017-03-16 09:15:15.210 plugin-container[1655:10315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 09:15:15 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:15 INFO - PID 1654 | 2017-03-16 09:15:15.210 plugin-container[1655:10315] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:15:15 INFO - PID 1654 | __metrics Screen width/height:1600/1200 09:15:15 INFO - PID 1654 | colorDepth:24 09:15:15 INFO - PID 1654 | Browser inner width/height: 1024/689 09:15:15 INFO - PID 1654 | __metrics 09:15:15 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:15:16 INFO - TEST-INFO | 1654: exit 0 09:15:16 INFO - Browser initialized. 09:15:16 INFO - Running cycle 1/1 for kraken test... 09:15:16 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpZg167r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:18 INFO - PID 1656 | 2017-03-16 09:15:18.678 plugin-container[1657:10433] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 09:15:18 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:18 INFO - PID 1656 | 2017-03-16 09:15:18.679 plugin-container[1657:10433] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 09:15:18 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:18 INFO - PID 1656 | 2017-03-16 09:15:18.679 plugin-container[1657:10433] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:15:28 INFO - PID 1656 | RSS: Main: 227348480 09:15:28 INFO - PID 1656 | 09:15:31 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:15:32 INFO - PID 1656 | RSS: Main: 241377280 09:15:32 INFO - PID 1656 | 09:15:34 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:15:35 INFO - PID 1656 | RSS: Main: 249950208 09:15:35 INFO - PID 1656 | 09:15:38 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:15:39 INFO - PID 1656 | RSS: Main: 252616704 09:15:39 INFO - PID 1656 | 09:15:41 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:15:42 INFO - PID 1656 | RSS: Main: 253833216 09:15:42 INFO - PID 1656 | 09:15:44 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:15:44 INFO - PID 1656 | RSS: Main: 254492672 09:15:44 INFO - PID 1656 | 09:15:47 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:15:48 INFO - PID 1656 | RSS: Main: 259739648 09:15:48 INFO - PID 1656 | 09:15:51 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:15:52 INFO - PID 1656 | RSS: Main: 260087808 09:15:52 INFO - PID 1656 | 09:15:55 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:15:56 INFO - PID 1656 | RSS: Main: 261357568 09:15:56 INFO - PID 1656 | 09:15:57 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:15:58 INFO - PID 1656 | RSS: Main: 261042176 09:15:58 INFO - PID 1656 | 09:16:00 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:01 INFO - PID 1656 | RSS: Main: 261058560 09:16:01 INFO - PID 1656 | 09:16:03 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:03 INFO - PID 1656 | RSS: Main: 261091328 09:16:03 INFO - PID 1656 | 09:16:06 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:07 INFO - PID 1656 | RSS: Main: 261480448 09:16:07 INFO - PID 1656 | 09:16:10 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:11 INFO - PID 1656 | RSS: Main: 261193728 09:16:11 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:16:13 INFO - PID 1656 | RSS: Main: 262787072 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | __start_tp_report 09:16:13 INFO - PID 1656 | _x_x_mozilla_page_load 09:16:13 INFO - PID 1656 | _x_x_mozilla_page_load_details 09:16:13 INFO - PID 1656 | |i|pagename|runs| 09:16:13 INFO - PID 1656 | |0;ai-astar;107;124;121;119;121;122;119;121;134;173 09:16:13 INFO - PID 1656 | |1;audio-beat-detection;149;116;119;158;115;117;114;117;134;113 09:16:13 INFO - PID 1656 | |2;audio-dft;235;253;212;278;222;198;199;190;194;192 09:16:13 INFO - PID 1656 | |3;audio-fft;84;63;87;114;83;66;59;59;77;71 09:16:13 INFO - PID 1656 | |4;audio-oscillator;84;70;85;70;71;71;85;71;72;82 09:16:13 INFO - PID 1656 | |5;imaging-gaussian-blur;82;138;90;91;91;89;106;90;90;90 09:16:13 INFO - PID 1656 | |6;imaging-darkroom;98;99;121;155;98;99;99;96;144;154 09:16:13 INFO - PID 1656 | |7;imaging-desaturate;122;90;91;90;93;81;149;146;93;139 09:16:13 INFO - PID 1656 | |8;json-parse-financial;67;68;66;68;69;87;100;80;68;67 09:16:13 INFO - PID 1656 | |9;json-stringify-tinderbox;56;58;65;80;96;85;61;59;60;59 09:16:13 INFO - PID 1656 | |10;stanford-crypto-aes;85;83;85;86;85;84;83;84;83;85 09:16:13 INFO - PID 1656 | |11;stanford-crypto-ccm;160;158;162;143;143;150;142;141;181;142 09:16:13 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;192;189;184;182;226;219;190;236;183;187 09:16:13 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;71;70;67;68;70;62;99;104;72;72 09:16:13 INFO - PID 1656 | __end_tp_report 09:16:13 INFO - PID 1656 | __start_cc_report 09:16:13 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1000 09:16:13 INFO - PID 1656 | __end_cc_report 09:16:13 INFO - PID 1656 | __startTimestamp1489680973411__endTimestamp 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | ------- Summary: start ------- 09:16:13 INFO - PID 1656 | Number of tests: 14 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:126.10 Median:121.50 stddev:17.72 (14.6%) stddev-sans-first:17.40 09:16:13 INFO - PID 1656 | Values: 107.0 124.0 121.0 119.0 121.0 122.0 119.0 121.0 134.0 173.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:118.00 stddev:16.18 (13.7%) stddev-sans-first:14.69 09:16:13 INFO - PID 1656 | Values: 149.0 116.0 119.0 158.0 115.0 117.0 114.0 117.0 134.0 113.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:217.30 Median:217.00 stddev:29.74 (13.7%) stddev-sans-first:30.84 09:16:13 INFO - PID 1656 | Values: 235.0 253.0 212.0 278.0 222.0 198.0 199.0 190.0 194.0 192.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:76.30 Median:74.00 stddev:16.83 (22.7%) stddev-sans-first:17.62 09:16:13 INFO - PID 1656 | Values: 84.0 63.0 87.0 114.0 83.0 66.0 59.0 59.0 77.0 71.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:77.00 stddev:6.87 (8.9%) stddev-sans-first:6.67 09:16:13 INFO - PID 1656 | Values: 84.0 70.0 85.0 70.0 71.0 71.0 85.0 71.0 72.0 82.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:90.00 stddev:15.99 (17.8%) stddev-sans-first:16.18 09:16:13 INFO - PID 1656 | Values: 82.0 138.0 90.0 91.0 91.0 89.0 106.0 90.0 90.0 90.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:116.30 Median:98.00 stddev:25.14 (25.7%) stddev-sans-first:25.78 09:16:13 INFO - PID 1656 | Values: 98.0 99.0 121.0 155.0 98.0 99.0 99.0 96.0 144.0 154.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:109.40 Median:90.00 stddev:26.62 (29.6%) stddev-sans-first:27.84 09:16:13 INFO - PID 1656 | Values: 122.0 90.0 91.0 90.0 93.0 81.0 149.0 146.0 93.0 139.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:74.00 Median:68.00 stddev:11.43 (16.8%) stddev-sans-first:11.84 09:16:13 INFO - PID 1656 | Values: 67.0 68.0 66.0 68.0 69.0 87.0 100.0 80.0 68.0 67.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:63.00 stddev:13.92 (22.1%) stddev-sans-first:14.09 09:16:13 INFO - PID 1656 | Values: 56.0 58.0 65.0 80.0 96.0 85.0 61.0 59.0 60.0 59.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:1.06 (1.2%) stddev-sans-first:1.09 09:16:13 INFO - PID 1656 | Values: 85.0 83.0 85.0 86.0 85.0 84.0 83.0 84.0 83.0 85.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:154.00 stddev:13.03 (8.5%) stddev-sans-first:13.51 09:16:13 INFO - PID 1656 | Values: 160.0 158.0 162.0 143.0 143.0 150.0 142.0 141.0 181.0 142.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.80 Median:191.00 stddev:20.12 (10.5%) stddev-sans-first:21.18 09:16:13 INFO - PID 1656 | Values: 192.0 189.0 184.0 182.0 226.0 219.0 190.0 236.0 183.0 187.0 09:16:13 INFO - PID 1656 | 09:16:13 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:70.50 stddev:14.07 (20.0%) stddev-sans-first:14.82 09:16:13 INFO - PID 1656 | Values: 71.0 70.0 67.0 68.0 70.0 62.0 99.0 104.0 72.0 72.0 09:16:13 INFO - PID 1656 | -------- Summary: end -------- 09:16:13 INFO - PID 1656 | 09:16:14 INFO - TEST-INFO | 1656: exit 0 09:16:14 INFO - TEST-OK | kraken | took 62217ms 09:16:14 INFO - SUITE-END | took 1179s 09:16:14 INFO - Completed test suite (00:19:39) 09:16:14 INFO - javascript benchmark 09:16:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7828.712431005636, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.1971936594896, 3426.400379933513, 3469.358168738782, 3474.114100904269, 3475.0269924421173, 4304.827806887721, 5811.0, 5943.673097979615, 5999.250093738283, 6008.038713805792, 4306.72006319589, 5401.4328495508, 5762.222100016496, 5802.274715660543, 5803.680797556132, 5339.332583427072, 5383.0, 5387.24578559002, 5388.299521062257, 5484.8354549363585, 5317.361916569997, 5457.126859702448, 5465.836024919259, 5472.480114389126, 5480.890382192354, 5416.729163541827, 5478.04134276502, 5487.2317875497465, 5488.9725551372385, 5505.146702261156, 5231.581473482112, 5296.205569164617, 5304.575633949275, 5307.2835167252315, 5436.429174936614, 5155.865709543894, 5239.266502689627, 5308.442613525602, 5324.787008519655, 5330.333708286465, 4510.345999830039, 5251.317328747276, 5771.787924535811, 5904.5571582131515, 5934.732937017845, 5595.020871347539, 6001.66990815505, 6337.6831158442355, 6346.524010699216, 6351.523635727339, 5824.922389357982, 6102.328743838174, 6261.7182226799905, 6327.778527751507, 6429.549931504796, 6105.914670190187, 6106.664133472702, 6130.3369889931655, 6138.728093731984, 6158.7228574714245, 5949.8397812426165, 6552.770653027121, 6595.208574971034, 6627.635480048547, 6650.46796256308, 6215.316315205324, 6228.875422491525, 6229.314775374705, 6260.060990851318, 6262.436380725665, 6336.144620476269, 6392.968035159794, 6414.967925160345, 6417.807465776034, 6479.1901012373455, 5056.342675452168, 5377.7580008899695, 6293.30773614902, 6319.462845658079, 6349.238091428966, 6192.783252586138, 6217.368539157735, 6280.591761535486, 6328.873422531524, 6353.0, 4616.446026476844, 4859.586935110485, 5081.491850814963, 5117.948820511821, 5135.255387968724, 4587.816487340536, 4597.908041839211, 4603.470600880874, 4605.631549476034, 4652.069586082797, 6197.070439434121, 6198.690065496708, 6217.347178546278, 6219.906701399483, 6231.501479881598, 6255.280642726145, 6339.714712837934, 6353.269374021954, 6376.0, 6402.071699603532, 6079.190768710056, 6194.5044396448175, 6203.751849925952, 6214.067889816473, 6225.221847269091, 5674.092145256822, 5690.2033715279895, 5700.714964251771, 5705.74324155414, 5715.31416230055, 6339.461145802474, 6342.714577843916, 6543.967280163569, 6569.737210511717, 6730.158730158731, 6408.9038664421005, 6436.420722135031, 6441.806745797634, 6442.387973142544, 6447.742090316335, 5654.547636189012, 6433.0, 6479.416852483299, 6631.005349197466, 6642.501812363996, 5929.140274660236, 6103.610425594382, 6249.25008998923, 6292.182016337847, 6326.746930122928, 5027.818462661345, 6235.438810507076, 6265.0, 6349.07938348946, 6395.872082558416, 4878.56092951636, 6296.212973378328, 6301.40136687014, 6317.147185129948, 6318.968405157945, 6260.780872669435, 6295.937040629535, 6316.242050953915, 6322.494200464043, 6329.778457753957, 5344.572434205332, 5961.642301461926, 6110.57225994194, 6114.38856114385, 6122.571420000557, 6215.564910456224, 6244.344343843831, 6268.216472940882, 6271.341509141657, 6300.369963003663, 6176.227971503562, 6197.1324014638885, 6223.0, 6266.122742815918, 6271.31015588294], "value": 5804.112299406293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.7625567125696, 732.1470486882782, 786.3826895886729, 799.780060483367, 831.9958400207998, 36049.91850244493, 36951.0, 37004.81497592515, 37009.334579943934, 37015.0, 38172.66395676152, 38592.61407385925, 38693.03267418309, 38696.61303386965, 38757.22485550287, 8930.106989301083, 9154.450732956011, 9252.491112988782, 10732.034116929475, 11029.83455248172, 11041.558337666524, 11136.387498687609, 11141.220114591983, 11172.497237624326, 11175.385353805577, 11089.0, 11127.942845429712, 11164.330140191574, 11196.552137914474, 11197.216194866322, 11100.944495277512, 11152.944235278772, 11164.720881977933, 11184.273022253528, 11199.992000719974, 10971.890281097167, 11038.724031899186, 11060.502277397536, 11072.224944253905, 11117.72205694856, 32061.0, 38962.41556376657, 39098.41352379688, 39116.804415978026, 39173.0, 3899.161680238762, 3920.2551515212017, 3920.3923391874305, 3926.332523471017, 3933.5869733677837, 27888.0, 28047.878084876582, 28224.87100515977, 28523.714762852313, 29099.56350654742, 3183.267848394882, 3184.7292980096718, 3210.678932106794, 3277.3936821687826, 3334.333133373335, 252005.0, 255006.0, 276984.23015769786, 355156.0, 355453.0, 47032.294515582296, 47062.117515299, 47151.0, 47171.764141179076, 47303.0, 49143.01713965701, 49218.75390623024, 49336.0, 49372.51882443533, 49418.25872611914, 14228.004039717327, 14366.425342986164, 14643.780343294646, 14669.92665036668, 14693.706125877636, 12012.939935300443, 12024.098192635587, 12035.217710848767, 12035.699107522207, 12042.09684273683, 11551.0, 11797.115216358636, 13278.7385198406, 13880.51418200358, 13891.235982021086, 5215.6609820361555, 5524.1989911462615, 5698.458646428583, 6130.509559235251, 6179.69101544921, 1050.6007717067619, 1119.283658458587, 1121.899029087386, 1127.21095233337, 1160.5879912630894, 25830.354241143745, 26300.605490917653, 26352.341191469983, 26374.20877373682, 26534.734652653227, 1228.299869074619, 1228.784962631536, 1229.1150371732338, 1241.2366394667215, 1291.5802364231474, 11276.774464510829, 12422.130450868533, 13523.526676566273, 13611.0, 13686.384112714952, 449637.0, 451132.48867511563, 451807.4819251831, 451837.0, 453482.0, 56979.14531282034, 57013.42986570081, 57131.0, 57140.42859571351, 57239.0, 1413.8232720909887, 1466.8166479190102, 1470.4559313054237, 1471.9852801472061, 1486.6877955629222, 25007.624885626366, 25287.0, 25877.353066173495, 26044.73955260423, 26401.471970560866, 45707.0, 45772.31341529946, 45841.54158458373, 45926.54073459223, 45954.54045459503, 442778.0, 442962.0, 444179.0, 445870.0, 446468.0, 31466.370672585963, 31978.680213198502, 32055.358892821547, 32066.679333206368, 33314.5002824953, 40655.59344406636, 41883.7905810469, 42774.35838462488, 44173.67478975636, 44394.890127747065, 33515.329693406486, 35550.51146419726, 35870.282594348486, 36574.634253657125, 36733.63266367302, 34844.65155348516, 35134.82432587923, 36162.63837361698, 36280.63719362773, 36348.45477317895, 35449.645503544634, 35685.64314356823, 35762.284754304244, 36411.0, 36614.8169259152, 29872.701272986993, 31502.21244468815, 31509.527357089202, 31511.21221969469, 31670.524942125427, 23871.403214919766, 24063.0, 24081.638775418032, 24088.15691450791, 24229.63655545133], "value": 18846.201058131734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.25523208814457, 404.80973942247135, 413.37167505391824, 417.1261207769723, 433.75059340879005, 21136.365909022734, 21156.682649760227, 22005.559888802236, 22740.65889011662, 22961.311160665166, 21379.0, 21832.454188645293, 22181.0, 22627.660585091195, 22752.8862355688, 6597.307282735315, 6636.7345306187935, 6845.212800527928, 6902.965485172567, 6907.551009184387, 6499.350064993487, 6689.7658581949645, 6699.263081061104, 6703.463722902156, 6712.630805305706, 7521.0, 7942.4837385570045, 7953.880691789628, 7954.403419743513, 7970.282674559288, 7633.885491717601, 7859.882101768478, 7904.920950790504, 7975.72084977023, 8006.0, 7529.284717951786, 7756.806079847993, 7782.844343113163, 7782.844343113163, 7806.921930780676, 27678.584821227698, 28207.0, 28248.0, 28362.432751345063, 28372.85813570919, 3259.9022029339158, 3294.456414691573, 3368.326334733063, 3427.143214196451, 3484.5992710838323, 15722.978006429545, 16398.26207820651, 16902.07038612876, 16923.492295231164, 17275.654486910193, 1738.75657407963, 1863.4689113602694, 1987.6720341143694, 2005.4986253436641, 2079.4073688998715, 149487.0, 155473.0, 156172.0, 156895.0, 158606.0, 17514.649707006043, 21851.890740546194, 22272.66364018164, 22550.21074262393, 22993.54012919732, 28783.71216287852, 29238.26904327409, 36426.635733642855, 36487.27025459529, 36617.267654646756, 10477.795053568785, 10551.894481055244, 10600.25798194119, 10724.195685323632, 10877.510512026978, 8531.701390451304, 8543.102974187745, 8590.269827064769, 8666.78333041679, 8668.219860212612, 10649.751825693238, 10882.183836212158, 10925.180611454172, 11041.282316649393, 11105.000549950542, 3766.51391194568, 4424.805302568288, 4520.095980803787, 4528.750918699503, 4569.702969307051, 830.683366863516, 874.4845720204742, 887.6538150121457, 895.2077411490748, 906.2613969614742, 20923.0, 22649.094036238366, 23041.539169216856, 23045.654315185286, 23288.65067023996, 908.4549270437817, 910.9954450227839, 939.8308304505255, 942.5522876633544, 943.0852073488705, 8923.196912277926, 11425.028872545761, 11661.766764664659, 11992.100592455601, 12310.384480775925, 585445.0, 586763.0, 593892.0, 649915.0, 692374.0, 112106.0, 115778.0, 141201.0, 142264.0, 142802.0, 1222.4376786678229, 1255.3785875991443, 1308.3654427602605, 1309.312610879277, 1310.593715948059, 19129.33047343336, 21033.684494732897, 21612.89193554085, 21649.59277646948, 21704.96130541694, 61757.69121154366, 61950.0, 63631.36368636254, 63703.725925482155, 66227.0, 66861.0, 85175.0, 86412.56793716243, 86480.27039459301, 86681.0, 12064.276143431422, 12124.33316167584, 12466.937665311616, 12507.93746031264, 12580.056495762672, 13703.794443083561, 13868.583942481742, 13932.373043212878, 14171.503997360043, 14177.432902683777, 6210.503159747119, 10717.9464102679, 11599.942000289944, 11763.588274410355, 12043.397830108635, 10158.136558392323, 11723.765524689628, 11808.232464889754, 11957.581484647995, 12135.75728485443, 11177.552897883994, 12059.21615095016, 12184.147109702235, 12218.572349967708, 12221.083418743452, 12027.15809893299, 12049.156559040783, 12087.637370878887, 12313.938430307791, 12318.260904345769, 10485.475726213506, 10772.676819695422, 11525.827112593486, 11873.16887817879, 11943.522259109539], "value": 11901.38773920821, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.1642863567768, 1587.2857214253588, 1587.849154330339, 1591.291875115574, 1614.3784642912478, 10376.273660843735, 10829.566817327297, 10861.294015888972, 10910.61812836551, 11306.038986686142, 9985.800283994335, 10609.469526523682, 10944.069754070913, 11122.165837562176, 11188.720281992953, 2268.739095004079, 2310.9537809243807, 2312.560613483441, 2315.016118149788, 2319.3621754017613, 2272.397814579138, 2285.9771402285933, 2296.3570200343847, 2314.733805612351, 2315.7568455312203, 1903.0009245146339, 2252.00911598896, 2266.29744779119, 2266.478709896725, 2275.943101422461, 2167.0789914286365, 2233.073274591051, 2236.888155592222, 2240.4174914522177, 2249.853759505627, 1902.5529000684828, 2261.6155253606926, 2265.0, 2265.558216147852, 2267.7845604667696, 10731.356118632906, 10824.945875270652, 10839.295445795999, 10840.6205782798, 10868.021878030937, 5474.589405794582, 5728.198052272685, 5738.0, 5747.453991870766, 5767.740451679684, 2794.441111777632, 2966.9406611867857, 3077.984610076958, 3197.712205901457, 3261.951070733941, 1079.7786453776957, 1081.6592773276393, 1101.8126918423807, 1115.1357697784201, 1120.2494328799642, 12660.366981650881, 15030.32363543643, 15045.699086018329, 15406.22968851553, 15437.459688910834, 3684.465752465931, 4402.779861006937, 4521.005378816655, 4521.864344069683, 4531.207038768268, 11465.942670286595, 11560.710982225512, 11563.190576659721, 11582.536698532133, 11703.180777345504, 5532.114861622202, 5539.335279766454, 5583.804566840141, 5593.46862048113, 5604.495595396434, 4882.12121818069, 5038.622103342264, 5080.49195080489, 5106.66806657566, 5115.590752739772, 3659.2315613720884, 3709.350863598859, 3761.1725420407465, 3769.5853456119803, 3810.3712887373827, 958.2621381536178, 963.6530848894392, 963.889152747429, 965.9372140810965, 967.3373738988815, 806.5644551941886, 912.7946212102224, 947.8009617980164, 967.9516024198762, 985.4579981010415, 6297.1813664223355, 6549.541532092803, 6576.210854697371, 6624.735010599522, 6768.221654509696, 952.2905435450633, 995.690666773191, 1003.844404117363, 1019.3170575714289, 1019.7858449725641, 3834.482344883405, 4153.107081977329, 4158.293090174678, 4215.262329092397, 4279.7218180818145, 12995.220286782824, 13394.93302533481, 13428.328583570783, 13434.93282533581, 13443.462261509625, 11763.941180294214, 12821.551245706356, 13212.867871321163, 13265.801012984813, 13348.6662833428, 8508.27679647237, 9751.561179746928, 9877.357971731815, 9990.15083717892, 10089.344192627455, 5154.407243166934, 6668.366505182, 6757.155355580552, 6818.045473633596, 6821.863562728817, 8727.389082764399, 11505.0, 11593.6521904343, 12025.518979240733, 12041.638750837488, 11673.12451566119, 11785.882141178821, 12107.273563586214, 12151.696207594881, 12263.080268979684, 9200.585973631069, 9230.123138301851, 9238.584263708015, 9253.814923701622, 9426.963034066384, 10141.340812847142, 10161.898381016095, 10166.135878450414, 10269.178465722875, 10270.537825797708, 9041.909580904106, 9089.909100908906, 9134.31492638068, 9147.0852914708, 9152.4966126861, 8350.41547091722, 8410.116937721696, 8525.658973641233, 8591.355648326526, 8647.351448641251, 7617.352525035434, 7903.0, 7964.721234756756, 8013.318867896294, 8028.43800933929, 5096.898062038813, 5850.619709718854, 5919.733611987384, 5988.820335389945, 6015.157877897185, 5005.0, 5908.911366329595, 5963.940360596339, 6113.327533971171, 6148.0], "value": 4964.792788958779, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.4064499386148, 336.3777012526825, 371.9572249191344, 383.1742594708404, 394.4891365681443, 5868.442497962697, 5916.285016506264, 5996.130561068642, 6072.483838873695, 6101.511879049676, 5754.280714910637, 5906.05503119501, 5926.851828704284, 5928.940710592893, 5936.257967754031, 4185.414042034117, 4692.389989301386, 4722.50413706561, 4851.63612729045, 4865.3675022247235, 4818.7831547580445, 4839.661223714342, 4866.440359358666, 4872.171730805771, 4876.731779752112, 3743.962560374402, 4510.594046535811, 4595.448546174463, 4865.708057516543, 4878.048780487807, 4118.972555171947, 4311.28863737483, 4553.476350219701, 4684.992726563788, 4727.527247275245, 4418.381426600278, 4418.889527761799, 4441.555844415532, 4453.710508816949, 4457.710248833815, 4567.748773817439, 5645.15322701594, 5698.0, 5712.8857422851725, 5720.113382425689, 5119.8208062717995, 5232.450592687751, 5414.0763987446735, 5525.917111243334, 5698.91720573094, 4956.0, 6284.491721986736, 6335.271443783978, 6350.110984462132, 6389.0, 4767.213409787416, 4977.552020318189, 5000.874978125539, 5011.747063234191, 5011.924821127686, 6382.989353357592, 6494.675266236716, 6552.246491653474, 6694.93305066948, 6728.798136055926, 4937.35814344133, 5091.134507133796, 5096.694198348111, 5096.770645320969, 5097.541221290027, 4865.683730557503, 5211.609129315317, 5227.712475813791, 5233.764480598382, 5242.5281724644965, 4665.0, 5245.213218017251, 5357.571394288448, 5503.2020357048805, 5595.804146854841, 5737.627054241461, 6309.116723658692, 6324.778632747832, 6339.302676705559, 6361.745530178741, 1528.4650372369804, 1719.7764290642388, 1789.74943507909, 1796.2365994452305, 1823.4165067178642, 1145.0381679389352, 1175.3241885915634, 1325.562564353761, 1330.1021810278023, 1350.8514063453013, 5606.6916319602, 5691.922448306338, 5812.157237200667, 5896.351401345849, 5952.434518720715, 6069.2716873975405, 6140.263168419819, 6494.512911531654, 6518.902216466757, 6535.477161827042, 4783.736894470838, 4792.904141917212, 5183.663061900965, 5580.173150225026, 5893.469587737124, 2991.1176203019727, 3294.7528935329947, 3394.1514621344663, 3427.3316703242626, 3454.3436747017986, 6724.394804467622, 6731.865362692719, 6769.830754231184, 6805.693743781541, 6844.384005439435, 5009.44896061433, 5561.749721262553, 5591.580631452657, 5965.194698715704, 6655.500837437212, 6145.846353841011, 6384.170057892445, 6746.291639377893, 6808.183018037867, 6824.7952561423235, 6369.426751592379, 6524.804255872142, 6580.934190658224, 6592.76925307612, 6597.835054123493, 5227.712475813714, 5692.516136128475, 5815.447532484407, 6457.0, 6458.870822583616, 5860.677662728591, 6547.934520654732, 6659.4006539411685, 6741.325867413219, 6763.7632682855865, 4446.866594002185, 4638.373819534319, 5102.43873173958, 5116.820911268088, 5119.0, 6207.282465326294, 6311.526635502264, 6442.840288748071, 6497.772577959749, 6501.512386570931, 6256.99888017915, 6262.968685156545, 6301.0, 6321.557490975588, 6335.683215839282, 5199.870003249949, 5355.303810504765, 5862.0, 6161.5686901918225, 6361.7137228823885, 6096.908546371897, 6114.57197996136, 6127.387261273837, 6132.570720049732, 6141.723622437091, 6071.360732602261, 6261.874762504815, 6305.148804911279, 6305.432511073842, 6316.873662526816, 5570.86072848182, 6026.457618814327, 6102.176206212104, 6119.173911521888, 6119.388061193845], "value": 4788.172141108498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.6359711367407, 695.4828389609484, 760.9201033891442, 811.6712731343806, 827.1769589258688, 12214.511419543218, 15753.369865205377, 16393.836061639395, 16418.097004664753, 16521.421750238744, 15018.324175412105, 15351.462698805544, 15360.692786144271, 15369.923150384233, 15872.444464443746, 934.3693007220116, 954.6515521834515, 962.5668449197854, 969.0261287406147, 969.5491596407669, 935.0789472369711, 966.3235734985503, 970.7039352997333, 975.5707488704983, 976.5849513956575, 1021.6985989133186, 1022.1669339488293, 1022.3150489172273, 1023.3194925374617, 1024.119257438606, 1012.711377257478, 1014.523174108168, 1015.0002247785925, 1015.9898401016006, 1019.1846522781819, 744.7765670298888, 755.7090520149727, 756.9205233450464, 758.1735907860403, 758.518340853562, 16127.354905803753, 16445.424410145588, 16578.253978570992, 16825.15874206285, 17077.7438338425, 13498.325083745773, 14697.191654459, 14833.480828170963, 14901.627459313495, 15072.518533619017, 11692.356920369377, 11730.472128754227, 11761.705957351049, 12027.759444811143, 12156.51373945041, 3637.0, 3672.9632703672887, 3715.498407714951, 3795.5635101963353, 3804.8478060877533, 64097.29837503748, 110276.0, 116981.83018169795, 118219.40890295494, 121030.0, 11383.43082845871, 11470.655880323604, 11476.770464590662, 11481.540738370539, 11738.295702257892, 24606.761707550275, 24963.251102466955, 25151.748482515308, 25152.11967581126, 25221.117260895782, 6983.930160698328, 7913.089994650573, 7964.8805267921025, 8062.7581172564915, 8184.263416292562, 4211.936820947627, 4264.1471705659, 4310.83775438668, 4322.675799315064, 4414.889627759268, 3186.2990142168687, 3223.17808958714, 3250.398676244902, 3271.607407111162, 3276.0, 568.7469076261107, 570.361195461078, 582.3884920833108, 587.3451102021215, 589.3487696095838, 671.425930829134, 672.324314064372, 695.8990946312756, 712.3944647049966, 733.886247631618, 9602.0, 9870.111689947938, 9971.501424928725, 10128.54421551032, 10204.336718113298, 600.8077415227173, 634.2294112653149, 647.5887811239802, 665.9567128136656, 671.7514519627769, 3842.442845787345, 4222.472190976128, 4704.29435584665, 4709.599684026896, 4721.575058244705, 89794.30617081498, 104402.4779876111, 108261.45869270603, 109602.45198773955, 109875.0, 63112.0, 94385.5842162368, 94644.0, 97331.0, 98617.01382986078, 69396.65301673459, 76368.9999999989, 81732.0, 82383.94040149044, 82512.58743706363, 9290.535473226177, 9295.024022477543, 9396.765080873032, 9458.621655133718, 9513.952430237805, 35877.28245435129, 48538.9034151409, 48556.27165592448, 48631.75684121557, 49830.25254621256, 50349.496505035946, 62395.688021561415, 63915.0, 64834.0, 64984.675076626205, 11584.652460426201, 11848.940755296167, 11863.822042669195, 11926.821097683714, 12047.879521204675, 12468.376581171087, 12666.87333126657, 12697.174683645533, 12758.74482510326, 12798.360081996048, 11576.189666723249, 12110.273383597012, 12258.30317330186, 12268.570600028956, 12293.815592766294, 11475.885241147482, 11582.478788454708, 11857.762844742885, 12169.178607667129, 12481.188722732993, 11526.711832204262, 11600.535978560763, 11646.767064658829, 11897.821532676844, 11913.987311078656, 8348.534718642244, 9534.427934323963, 9785.168260697636, 9871.703848884545, 10457.006584374472, 8142.959285203536, 8863.0, 9694.46680432583, 9857.901420985698, 9864.457454840052], "value": 7438.337223481255, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 124.0, 121.0, 119.0, 121.0, 122.0, 119.0, 121.0, 134.0, 173.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 119.0, 158.0, 115.0, 117.0, 114.0, 117.0, 134.0, 113.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [235.0, 253.0, 212.0, 278.0, 222.0, 198.0, 199.0, 190.0, 194.0, 192.0], "value": 217.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 63.0, 87.0, 114.0, 83.0, 66.0, 59.0, 59.0, 77.0, 71.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 85.0, 70.0, 71.0, 71.0, 85.0, 71.0, 72.0, 82.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 138.0, 90.0, 91.0, 91.0, 89.0, 106.0, 90.0, 90.0, 90.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 121.0, 155.0, 98.0, 99.0, 99.0, 96.0, 144.0, 154.0], "value": 116.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 90.0, 91.0, 90.0, 93.0, 81.0, 149.0, 146.0, 93.0, 139.0], "value": 109.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 68.0, 69.0, 87.0, 100.0, 80.0, 68.0, 67.0], "value": 74.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 65.0, 80.0, 96.0, 85.0, 61.0, 59.0, 60.0, 59.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 85.0, 86.0, 85.0, 84.0, 83.0, 84.0, 83.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 162.0, 143.0, 143.0, 150.0, 142.0, 141.0, 181.0, 142.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 189.0, 184.0, 182.0, 226.0, 219.0, 190.0, 236.0, 183.0, 187.0], "value": 198.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 67.0, 68.0, 70.0, 62.0, 99.0, 104.0, 72.0, 72.0], "value": 75.5, "unit": "score"}]}]} 09:16:14 INFO - Return code: 0 09:16:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:14 ERROR - # TBPL SUCCESS # 09:16:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:14 INFO - 2017-03-16 09:16:14.736 screenresolution[1661:10820] starting screenresolution argv=screenresolution get 09:16:14 INFO - 2017-03-16 09:16:14.739 screenresolution[1661:10820] Display 0: 1600x1200x32@60 09:16:14 INFO - 2017-03-16 09:16:14.746 screenresolution[1662:10823] starting screenresolution argv=screenresolution list 09:16:14 INFO - Available Modes on Display 0 09:16:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:14 INFO - Intel Iris: 09:16:14 INFO - Chipset Model: Intel Iris 09:16:14 INFO - Type: GPU 09:16:14 INFO - Bus: Built-In 09:16:14 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:14 INFO - Vendor: Intel (0x8086) 09:16:14 INFO - Device ID: 0x0a2e 09:16:14 INFO - Revision ID: 0x0009 09:16:14 INFO - Displays: 09:16:14 INFO - Display: 09:16:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:14 INFO - Display Serial Number: 1600x1200 60 09:16:14 INFO - Main Display: Yes 09:16:14 INFO - Mirror: Off 09:16:14 INFO - Online: Yes 09:16:14 INFO - Rotation: Supported 09:16:14 INFO - Return code: 0 09:16:14 INFO - Running post-action listener: _resource_record_post_action 09:16:14 INFO - [mozharness: 2017-03-16 16:16:14.987124Z] Finished run-tests step (success) 09:16:14 INFO - Running post-run listener: _resource_record_post_run 09:16:15 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39574016; Write bytes: 514204672; Read time: 253; Write time: 1624 09:16:15 INFO - TinderboxPrint: CPU usage
54.2% 09:16:15 INFO - TinderboxPrint: I/O read bytes / time
39,574,016 / 253 09:16:15 INFO - TinderboxPrint: I/O write bytes / time
514,204,672 / 1,624 09:16:15 INFO - TinderboxPrint: CPU idle
2,197.6 (45.8%) 09:16:15 INFO - TinderboxPrint: CPU system
966.9 (20.1%) 09:16:15 INFO - TinderboxPrint: CPU user
1,637.2 (34.1%) 09:16:15 INFO - TinderboxPrint: Swap in / out
249,032,704 / 0 09:16:15 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203653632; Write bytes: 203393024; Read time: 15626; Write time: 458 09:16:15 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 38599168; Write bytes: 300870656; Read time: 240; Write time: 1132 09:16:15 INFO - Running post-run listener: _upload_blobber_files 09:16:15 INFO - Blob upload gear active. 09:16:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:16:15 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:16 INFO - (blobuploader) - INFO - Done attempting. 09:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:17 INFO - (blobuploader) - INFO - Done attempting. 09:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:18 INFO - (blobuploader) - INFO - Done attempting. 09:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:21 INFO - (blobuploader) - INFO - Done attempting. 09:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:21 INFO - Return code: 0 09:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bee6429b85ea210e1df95cc6d6749c4e643881c71be47afecfab7849c9fe47386dad311edb41b93daa9dcaec1f0b10eccc1ba512f688f8af40d4f4e9891bee3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4340f1dd480c405c6104f41f34ceddd227acdfde29003e823e92e146dc53c26dfa565bdd77aaee05a0a86fa22e4626510141a6e5e0fccbc35f3651d4b9f43c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b92ba310622f716fb6f598e7ebb18142f4bcabb92f1d8a9d548abf854f276cc9274689cdd17206c90fb49d891a749c8f5ff77dae60a6ae7b38e14a76aaa14669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274b5b5200174d0fd3edf25ffc3642da7afa478eb1c879b4f20d22402df27f3026e53c76ea1c44ba4e21686a6a3c562ab4123fca53330edf64dc009bd61dcfa"} 09:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:21 INFO - Contents: 09:16:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bee6429b85ea210e1df95cc6d6749c4e643881c71be47afecfab7849c9fe47386dad311edb41b93daa9dcaec1f0b10eccc1ba512f688f8af40d4f4e9891bee3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4340f1dd480c405c6104f41f34ceddd227acdfde29003e823e92e146dc53c26dfa565bdd77aaee05a0a86fa22e4626510141a6e5e0fccbc35f3651d4b9f43c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b92ba310622f716fb6f598e7ebb18142f4bcabb92f1d8a9d548abf854f276cc9274689cdd17206c90fb49d891a749c8f5ff77dae60a6ae7b38e14a76aaa14669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274b5b5200174d0fd3edf25ffc3642da7afa478eb1c879b4f20d22402df27f3026e53c76ea1c44ba4e21686a6a3c562ab4123fca53330edf64dc009bd61dcfa"} 09:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:21 INFO - Copying logs to upload dir... 09:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.047463 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-16 09:16:21.317541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 09:16:21.321344) ========= 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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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/bee6429b85ea210e1df95cc6d6749c4e643881c71be47afecfab7849c9fe47386dad311edb41b93daa9dcaec1f0b10eccc1ba512f688f8af40d4f4e9891bee3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4340f1dd480c405c6104f41f34ceddd227acdfde29003e823e92e146dc53c26dfa565bdd77aaee05a0a86fa22e4626510141a6e5e0fccbc35f3651d4b9f43c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b92ba310622f716fb6f598e7ebb18142f4bcabb92f1d8a9d548abf854f276cc9274689cdd17206c90fb49d891a749c8f5ff77dae60a6ae7b38e14a76aaa14669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274b5b5200174d0fd3edf25ffc3642da7afa478eb1c879b4f20d22402df27f3026e53c76ea1c44ba4e21686a6a3c562ab4123fca53330edf64dc009bd61dcfa"} build_url:https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/CZzdSNxyR8GI6LWcksEK0Q/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/bee6429b85ea210e1df95cc6d6749c4e643881c71be47afecfab7849c9fe47386dad311edb41b93daa9dcaec1f0b10eccc1ba512f688f8af40d4f4e9891bee3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4340f1dd480c405c6104f41f34ceddd227acdfde29003e823e92e146dc53c26dfa565bdd77aaee05a0a86fa22e4626510141a6e5e0fccbc35f3651d4b9f43c4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b92ba310622f716fb6f598e7ebb18142f4bcabb92f1d8a9d548abf854f276cc9274689cdd17206c90fb49d891a749c8f5ff77dae60a6ae7b38e14a76aaa14669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274b5b5200174d0fd3edf25ffc3642da7afa478eb1c879b4f20d22402df27f3026e53c76ea1c44ba4e21686a6a3c562ab4123fca53330edf64dc009bd61dcfa"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 09:16:21.364217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 09:16:21.364989) ========= 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.w0Nvdjtr4H/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.Y6NFs5qt58/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.005045 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 09:16:21.418940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 09:16:21.419714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 09:16:21.420443) ========= ========= Total master_lag: 0.21 =========