builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0039 starttime: 1486744822.08 results: success (0) buildid: 20170210070623 builduid: cf1cd1fc9f7b44379e378c7184c73ce2 revision: b15c57d53466fabea73f47f1829ab3d580ef72dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.085044) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.085553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.085883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.114868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.115478) ========= 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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-02-10 08:40:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.12M=0.001s 2017-02-10 08:40:22 (8.12 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.295650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.296027) ========= 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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.020011 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:22.344682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 08:40:22.345051) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b15c57d53466fabea73f47f1829ab3d580ef72dd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b15c57d53466fabea73f47f1829ab3d580ef72dd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wlKIeNPQUn/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.gZUdY5WbUs/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-02-10 08:40:22,433 truncating revision to first 12 chars 2017-02-10 08:40:22,434 Setting DEBUG logging. 2017-02-10 08:40:22,434 attempt 1/10 2017-02-10 08:40:22,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b15c57d53466?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 08:40:23,211 unpacking tar archive at: mozilla-aurora-b15c57d53466/testing/mozharness/ program finished with exit code 0 elapsedTime=1.041758 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-10 08:40:23.414567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:23.415289) ========= script_repo_revision: b15c57d53466fabea73f47f1829ab3d580ef72dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:23.415764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:23.416085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 08:40:23.436950) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-10 08:40:23.437415) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wlKIeNPQUn/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.gZUdY5WbUs/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:40:23 INFO - MultiFileLogger online at 20170210 08:40:23 in /builds/slave/test 08:40:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:40:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:23 INFO - {'append_to_log': False, 08:40:23 INFO - 'base_work_dir': '/builds/slave/test', 08:40:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:40:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:23 INFO - 'branch': 'Mozilla-Aurora', 08:40:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:23 INFO - 'config_files': ('talos/mac_config.py',), 08:40:23 INFO - 'default_actions': ('clobber', 08:40:23 INFO - 'read-buildbot-config', 08:40:23 INFO - 'download-and-extract', 08:40:23 INFO - 'populate-webroot', 08:40:23 INFO - 'create-virtualenv', 08:40:23 INFO - 'install', 08:40:23 INFO - 'run-tests'), 08:40:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:23 INFO - 'download_minidump_stackwalk': True, 08:40:23 INFO - 'download_symbols': 'ondemand', 08:40:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:23 INFO - 'installer_path': 'installer.exe', 08:40:23 INFO - 'log_level': 'info', 08:40:23 INFO - 'log_name': 'talos', 08:40:23 INFO - 'log_to_console': True, 08:40:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:23 INFO - 'opt_config_files': (), 08:40:23 INFO - 'pip_index': False, 08:40:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:23 INFO - 'cmd': ('bash', 08:40:23 INFO - '-c', 08:40:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:23 INFO - 'enabled': True, 08:40:23 INFO - 'halt_on_failure': False, 08:40:23 INFO - 'name': 'check_screen_resolution'},), 08:40:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:23 INFO - 'cmd': ('bash', 08:40:23 INFO - '-c', 08:40:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:23 INFO - 'enabled': True, 08:40:23 INFO - 'halt_on_failure': False, 08:40:23 INFO - 'name': 'check_screen_resolution'},), 08:40:23 INFO - 'run_cmd_checks_enabled': True, 08:40:23 INFO - 'sps_profile': False, 08:40:23 INFO - 'sps_profile_interval': 0, 08:40:23 INFO - 'suite': 'dromaeojs', 08:40:23 INFO - 'system_bits': '32', 08:40:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:23 INFO - 'title': 't-yosemite-r7-0039', 08:40:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:23 INFO - 'use_talos_json': True, 08:40:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:23 INFO - 'work_dir': 'build'} 08:40:23 INFO - [mozharness: 2017-02-10 16:40:23.658493Z] Running clobber step. 08:40:23 INFO - Running pre-action listener: _resource_record_pre_action 08:40:23 INFO - Running main action method: clobber 08:40:23 INFO - rmtree: /builds/slave/test/build 08:40:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:25 INFO - Running post-action listener: _resource_record_post_action 08:40:25 INFO - [mozharness: 2017-02-10 16:40:25.755141Z] Finished clobber step (success) 08:40:25 INFO - [mozharness: 2017-02-10 16:40:25.755295Z] Running read-buildbot-config step. 08:40:25 INFO - Running pre-action listener: _resource_record_pre_action 08:40:25 INFO - Running main action method: read_buildbot_config 08:40:25 INFO - Using buildbot properties: 08:40:25 INFO - { 08:40:25 INFO - "project": "", 08:40:25 INFO - "product": "firefox", 08:40:25 INFO - "script_repo_revision": "production", 08:40:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:40:25 INFO - "repository": "", 08:40:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:40:25 INFO - "buildid": "20170210070623", 08:40:25 INFO - "pgo_build": "False", 08:40:25 INFO - "basedir": "/builds/slave/test", 08:40:25 INFO - "buildnumber": 26, 08:40:25 INFO - "slavename": "t-yosemite-r7-0039", 08:40:25 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:40:25 INFO - "platform": "yosemite_r7", 08:40:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:40:25 INFO - "branch": "mozilla-aurora", 08:40:25 INFO - "repo_path": "releases/mozilla-aurora", 08:40:25 INFO - "revision": "b15c57d53466fabea73f47f1829ab3d580ef72dd", 08:40:25 INFO - "stage_platform": "macosx64", 08:40:25 INFO - "builduid": "cf1cd1fc9f7b44379e378c7184c73ce2", 08:40:25 INFO - "slavebuilddir": "test" 08:40:25 INFO - } 08:40:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:40:25 INFO - Running post-action listener: _resource_record_post_action 08:40:25 INFO - [mozharness: 2017-02-10 16:40:25.758419Z] Finished read-buildbot-config step (success) 08:40:25 INFO - [mozharness: 2017-02-10 16:40:25.758519Z] Running download-and-extract step. 08:40:25 INFO - Running pre-action listener: _resource_record_pre_action 08:40:25 INFO - Running main action method: download_and_extract 08:40:25 INFO - mkdir: /builds/slave/test/build/tests 08:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:25 INFO - trying https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:40:25 INFO - Downloading https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:40:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:40:27 INFO - Downloaded 1199 bytes. 08:40:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:40:27 INFO - Using the following test package requirements: 08:40:27 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:40:27 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:40:27 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:40:27 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'jsshell-mac.zip'], 08:40:27 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:40:27 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:40:27 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:40:27 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:40:27 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:40:27 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:40:27 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:40:27 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:40:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:40:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:40:27 INFO - Fetch https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:40:28 INFO - Expected file size: 16357907 08:40:28 INFO - Obtained file size: 16357907 08:40:35 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:40:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:40:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:40:35 INFO - Fetch https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:40:35 INFO - Expected file size: 16357907 08:40:35 INFO - Obtained file size: 16357907 08:40:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:40:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:40:42 INFO - Fetch https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:40:43 INFO - Expected file size: 14403485 08:40:43 INFO - Obtained file size: 14403485 08:40: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:40:44 INFO - trying https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:40:44 INFO - Downloading https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:40:47 INFO - Downloaded 73824735 bytes. 08:40:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:40:47 INFO - mkdir: /builds/slave/test/properties 08:40:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:47 INFO - Contents: 08:40:47 INFO - build_url:https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:40:47 INFO - Running post-action listener: _resource_record_post_action 08:40:47 INFO - Running post-action listener: set_extra_try_arguments 08:40:47 INFO - [mozharness: 2017-02-10 16:40:47.894233Z] Finished download-and-extract step (success) 08:40:47 INFO - [mozharness: 2017-02-10 16:40:47.894407Z] Running populate-webroot step. 08:40:47 INFO - Running pre-action listener: _resource_record_pre_action 08:40:47 INFO - Running main action method: populate_webroot 08:40:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:47 INFO - '--tppagecycles', 08:40:47 INFO - '7'], 08:40:47 INFO - 'tests': ['tsvgm']}}, 08:40:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:40:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['damp', 'tps']}, 08:40:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:40:47 INFO - 'tests': ['damp', 'tps']}, 08:40:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['dromaeo_dom']}, 08:40:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['basic_compositor_video']}, 08:40:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['a11yr', 08:40:47 INFO - 'ts_paint', 08:40:47 INFO - 'tpaint', 08:40:47 INFO - 'sessionrestore', 08:40:47 INFO - 'sessionrestore_no_auto_restore', 08:40:47 INFO - 'tabpaint']}, 08:40:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tsvgx', 08:40:47 INFO - 'tsvgr_opacity', 08:40:47 INFO - 'tart', 08:40:47 INFO - 'tscrollx', 08:40:47 INFO - 'cart', 08:40:47 INFO - 'tsvg_static']}, 08:40:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:47 INFO - 'tsvgr_opacity', 08:40:47 INFO - 'tart', 08:40:47 INFO - 'tscrollx', 08:40:47 INFO - 'cart', 08:40:47 INFO - 'tsvg_static']}, 08:40:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s'], 08:40:47 INFO - 'tests': ['tp5o']}, 08:40:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:40:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:40:47 INFO - 'talos_options': ['--disable-e10s', 08:40:47 INFO - '--xperf_path', 08:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:47 INFO - 'tests': ['tp5n']}, 08:40:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:40:47 INFO - 'talos_options': ['--xperf_path', 08:40:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:47 INFO - 'tests': ['tp5n']}}, 08:40:47 INFO - 'talos.zip': {'path': '', 08:40:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:47 INFO - Running post-action listener: _resource_record_post_action 08:40:47 INFO - [mozharness: 2017-02-10 16:40:47.913069Z] Finished populate-webroot step (success) 08:40:47 INFO - [mozharness: 2017-02-10 16:40:47.913179Z] Running create-virtualenv step. 08:40:47 INFO - Running pre-action listener: _resource_record_pre_action 08:40:47 INFO - Running main action method: create_virtualenv 08:40:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:47 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:40:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:48 INFO - Using real prefix '/tools/python27' 08:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:51 INFO - Installing pip.................done. 08:40:51 INFO - Return code: 0 08:40:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:51 INFO - Reading from file tmpfile_stdout 08:40:51 INFO - Output received: 08:40:51 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:40:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:51 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:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:51 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:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:51 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:40:51 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:40:51 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:40:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:40:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:51 INFO - 'HOME': '/Users/cltbld', 08:40:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:51 INFO - 'LOGNAME': 'cltbld', 08:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:51 INFO - 'MOZ_NO_REMOTE': '1', 08:40:51 INFO - 'NO_EM_RESTART': '1', 08:40:51 INFO - 'PAGER': '/bin/cat', 08:40:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:51 INFO - 'PWD': '/builds/slave/test', 08:40:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:51 INFO - 'SHELL': '/bin/bash', 08:40:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:40:51 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:40:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:51 INFO - 'USER': 'cltbld', 08:40:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:51 INFO - 'XPC_FLAGS': '0x0', 08:40:51 INFO - 'XPC_SERVICE_NAME': '0', 08:40:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 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:40:52 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40: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:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:40:52 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:40:52 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:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:52 INFO - 'HOME': '/Users/cltbld', 08:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PAGER': '/bin/cat', 08:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:40:52 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - 'XPC_FLAGS': '0x0', 08:40:52 INFO - 'XPC_SERVICE_NAME': '0', 08:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 INFO - Downloading/unpacking psutil>=3.1.1 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:56 INFO - Installing collected packages: psutil 08:40:56 INFO - Running setup.py install for psutil 08:40:56 INFO - building 'psutil._psutil_osx' extension 08:40:56 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:40:56 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:40:56 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:40:56 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:40:56 INFO - building 'psutil._psutil_posix' extension 08:40:56 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:40:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:40:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:40:56 INFO - ^ 08:40:56 INFO - 1 warning generated. 08:40:56 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:40:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:56 INFO - Successfully installed psutil 08:40:56 INFO - Cleaning up... 08:40:56 INFO - Return code: 0 08:40:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:56 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:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 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:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:40:56 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:40:56 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:40:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:40:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:56 INFO - 'HOME': '/Users/cltbld', 08:40:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:56 INFO - 'LOGNAME': 'cltbld', 08:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:56 INFO - 'MOZ_NO_REMOTE': '1', 08:40:56 INFO - 'NO_EM_RESTART': '1', 08:40:56 INFO - 'PAGER': '/bin/cat', 08:40:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:56 INFO - 'PWD': '/builds/slave/test', 08:40:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:56 INFO - 'SHELL': '/bin/bash', 08:40:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:40:56 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:40:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:56 INFO - 'USER': 'cltbld', 08:40:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:56 INFO - 'XPC_FLAGS': '0x0', 08:40:56 INFO - 'XPC_SERVICE_NAME': '0', 08:40:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:59 INFO - Installing collected packages: mozsystemmonitor 08:40:59 INFO - Running setup.py install for mozsystemmonitor 08:41:00 INFO - Successfully installed mozsystemmonitor 08:41:00 INFO - Cleaning up... 08:41:00 INFO - Return code: 0 08:41:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:00 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:41:00 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:41:00 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:41:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:00 INFO - 'HOME': '/Users/cltbld', 08:41:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:00 INFO - 'LOGNAME': 'cltbld', 08:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:00 INFO - 'MOZ_NO_REMOTE': '1', 08:41:00 INFO - 'NO_EM_RESTART': '1', 08:41:00 INFO - 'PAGER': '/bin/cat', 08:41:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:00 INFO - 'PWD': '/builds/slave/test', 08:41:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:00 INFO - 'SHELL': '/bin/bash', 08:41:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:00 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:00 INFO - 'USER': 'cltbld', 08:41:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:00 INFO - 'XPC_FLAGS': '0x0', 08:41:00 INFO - 'XPC_SERVICE_NAME': '0', 08:41:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:01 INFO - Downloading/unpacking jsonschema==2.5.1 08:41: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:41: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:41: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:41: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:41: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:41: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:41:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:04 INFO - warning: no files found matching '*.txt' 08:41:04 INFO - no previously-included directories found matching 'build' 08:41:04 INFO - no previously-included directories found matching 'dist' 08:41:04 INFO - no previously-included directories found matching '.git*' 08:41:04 INFO - Installing collected packages: jsonschema, functools32 08:41:04 INFO - Running setup.py install for functools32 08:41:04 INFO - warning: no files found matching '*.txt' 08:41:04 INFO - no previously-included directories found matching 'build' 08:41:04 INFO - no previously-included directories found matching 'dist' 08:41:04 INFO - no previously-included directories found matching '.git*' 08:41:04 INFO - Successfully installed jsonschema functools32 08:41:04 INFO - Cleaning up... 08:41:04 INFO - Return code: 0 08:41:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:04 INFO - 'HOME': '/Users/cltbld', 08:41:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:04 INFO - 'LOGNAME': 'cltbld', 08:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:04 INFO - 'MOZ_NO_REMOTE': '1', 08:41:04 INFO - 'NO_EM_RESTART': '1', 08:41:04 INFO - 'PAGER': '/bin/cat', 08:41:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:04 INFO - 'PWD': '/builds/slave/test', 08:41:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:04 INFO - 'SHELL': '/bin/bash', 08:41:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:04 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:04 INFO - 'USER': 'cltbld', 08:41:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:04 INFO - 'XPC_FLAGS': '0x0', 08:41:04 INFO - 'XPC_SERVICE_NAME': '0', 08:41:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:05 INFO - Cleaning up... 08:41:05 INFO - Return code: 0 08:41:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:05 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:41:05 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:41:05 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:41:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:05 INFO - 'HOME': '/Users/cltbld', 08:41:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:05 INFO - 'LOGNAME': 'cltbld', 08:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:05 INFO - 'MOZ_NO_REMOTE': '1', 08:41:05 INFO - 'NO_EM_RESTART': '1', 08:41:05 INFO - 'PAGER': '/bin/cat', 08:41:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:05 INFO - 'PWD': '/builds/slave/test', 08:41:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:05 INFO - 'SHELL': '/bin/bash', 08:41:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:05 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:05 INFO - 'USER': 'cltbld', 08:41:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:05 INFO - 'XPC_FLAGS': '0x0', 08:41:05 INFO - 'XPC_SERVICE_NAME': '0', 08:41:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:09 INFO - Downloading docopt-0.6.1.tar.gz 08:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:09 INFO - Running setup.py install for blobuploader 08:41:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:09 INFO - Running setup.py install for requests 08:41:09 INFO - Running setup.py install for docopt 08:41:10 INFO - Successfully installed blobuploader requests docopt 08:41:10 INFO - Cleaning up... 08:41:10 INFO - Return code: 0 08:41:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:10 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:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 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:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:41:10 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:41:10 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:41:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:10 INFO - 'HOME': '/Users/cltbld', 08:41:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:10 INFO - 'LOGNAME': 'cltbld', 08:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:10 INFO - 'MOZ_NO_REMOTE': '1', 08:41:10 INFO - 'NO_EM_RESTART': '1', 08:41:10 INFO - 'PAGER': '/bin/cat', 08:41:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:10 INFO - 'PWD': '/builds/slave/test', 08:41:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:10 INFO - 'SHELL': '/bin/bash', 08:41:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:10 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:10 INFO - 'USER': 'cltbld', 08:41:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:10 INFO - 'XPC_FLAGS': '0x0', 08:41:10 INFO - 'XPC_SERVICE_NAME': '0', 08:41:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:10 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-XVMBYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:10 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-e_13Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:10 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-o2OXS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:10 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-mdkTWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:10 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-VO0rvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:10 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5LIfcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-SExOMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-H4zYr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-VsXDEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-aUNKfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-4t72Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-lecv7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-zfYNny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-UBsZW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-vzyWjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:11 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-dBp5Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:12 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-_z0xpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:12 INFO - Running setup.py install for manifestparser 08:41:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for mozcrash 08:41:12 INFO - Running setup.py install for mozdebug 08:41:12 INFO - Running setup.py install for mozdevice 08:41:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for mozfile 08:41:12 INFO - Running setup.py install for mozhttpd 08:41:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Running setup.py install for mozinfo 08:41:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Running setup.py install for mozInstall 08:41:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Running setup.py install for mozleak 08:41:13 INFO - Running setup.py install for mozlog 08:41:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Running setup.py install for moznetwork 08:41:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Running setup.py install for mozprocess 08:41:13 INFO - Running setup.py install for mozprofile 08:41:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:14 INFO - Running setup.py install for mozrunner 08:41:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:14 INFO - Running setup.py install for mozscreenshot 08:41:14 INFO - Running setup.py install for moztest 08:41:14 INFO - Running setup.py install for mozversion 08:41:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:14 INFO - Cleaning up... 08:41:14 INFO - Return code: 0 08:41:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:14 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:41:14 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:41:14 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:41:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:14 INFO - 'HOME': '/Users/cltbld', 08:41:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:14 INFO - 'LOGNAME': 'cltbld', 08:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:14 INFO - 'MOZ_NO_REMOTE': '1', 08:41:14 INFO - 'NO_EM_RESTART': '1', 08:41:14 INFO - 'PAGER': '/bin/cat', 08:41:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:14 INFO - 'PWD': '/builds/slave/test', 08:41:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:14 INFO - 'SHELL': '/bin/bash', 08:41:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:14 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:14 INFO - 'USER': 'cltbld', 08:41:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:14 INFO - 'XPC_FLAGS': '0x0', 08:41:14 INFO - 'XPC_SERVICE_NAME': '0', 08:41:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Ino5P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-8Hgsys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-0hTCDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-KjuZsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-PRMfkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-fWko77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-qBbdDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:15 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:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-_ZC5qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:15 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-qczKdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-nMUA4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-lj10b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Cgr6eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-7uPedv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-oCp8ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-y1jPz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-sGEoSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:16 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:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:16 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-q7WuH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:19 INFO - Downloading blessings-1.6.tar.gz 08:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:19 INFO - Installing collected packages: blessings 08:41:19 INFO - Running setup.py install for blessings 08:41:19 INFO - Successfully installed blessings 08:41:19 INFO - Cleaning up... 08:41:19 INFO - Return code: 0 08:41:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:20 INFO - Reading from file tmpfile_stdout 08:41:20 INFO - Current package versions: 08:41:20 INFO - blessings == 1.6 08:41:20 INFO - blobuploader == 1.2.4 08:41:20 INFO - docopt == 0.6.1 08:41:20 INFO - functools32 == 3.2.3-2 08:41:20 INFO - jsonschema == 2.5.1 08:41:20 INFO - manifestparser == 1.1 08:41:20 INFO - mozInstall == 1.12 08:41:20 INFO - mozcrash == 1.0 08:41:20 INFO - mozdebug == 0.1 08:41:20 INFO - mozdevice == 0.49 08:41:20 INFO - mozfile == 1.2 08:41:20 INFO - mozhttpd == 0.7 08:41:20 INFO - mozinfo == 0.9 08:41:20 INFO - mozleak == 0.1 08:41:20 INFO - mozlog == 3.4 08:41:20 INFO - moznetwork == 0.27 08:41:20 INFO - mozprocess == 0.24 08:41:20 INFO - mozprofile == 0.28 08:41:20 INFO - mozrunner == 6.13 08:41:20 INFO - mozscreenshot == 0.1 08:41:20 INFO - mozsystemmonitor == 0.3 08:41:20 INFO - moztest == 0.8 08:41:20 INFO - mozversion == 1.4 08:41:20 INFO - psutil == 3.1.1 08:41:20 INFO - requests == 1.2.3 08:41:20 INFO - wsgiref == 0.1.2 08:41:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:41:20 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:41:20 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:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:20 INFO - 'HOME': '/Users/cltbld', 08:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:20 INFO - 'LOGNAME': 'cltbld', 08:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:20 INFO - 'MOZ_NO_REMOTE': '1', 08:41:20 INFO - 'NO_EM_RESTART': '1', 08:41:20 INFO - 'PAGER': '/bin/cat', 08:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:20 INFO - 'PWD': '/builds/slave/test', 08:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:20 INFO - 'SHELL': '/bin/bash', 08:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:20 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:20 INFO - 'USER': 'cltbld', 08:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:20 INFO - 'XPC_FLAGS': '0x0', 08:41:20 INFO - 'XPC_SERVICE_NAME': '0', 08:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:20 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:41:20 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:41:20 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:41:20 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:41:20 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:41:20 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:41:20 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:41:20 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:41:20 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:41:20 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:41:20 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:41:20 INFO - Cleaning up... 08:41:20 INFO - Return code: 0 08:41:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 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 0x10cc14b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc17768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590573ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, '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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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:41:20 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:41:20 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:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:20 INFO - 'HOME': '/Users/cltbld', 08:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:20 INFO - 'LOGNAME': 'cltbld', 08:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:20 INFO - 'MOZ_NO_REMOTE': '1', 08:41:20 INFO - 'NO_EM_RESTART': '1', 08:41:20 INFO - 'PAGER': '/bin/cat', 08:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:20 INFO - 'PWD': '/builds/slave/test', 08:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:20 INFO - 'SHELL': '/bin/bash', 08:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:20 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:20 INFO - 'USER': 'cltbld', 08:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:20 INFO - 'XPC_FLAGS': '0x0', 08:41:20 INFO - 'XPC_SERVICE_NAME': '0', 08:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:20 INFO - Cleaning up... 08:41:20 INFO - Return code: 0 08:41:20 INFO - Running post-action listener: _resource_record_post_action 08:41:20 INFO - Running post-action listener: _start_resource_monitoring 08:41:20 INFO - Starting resource monitoring. 08:41:20 INFO - [mozharness: 2017-02-10 16:41:20.694220Z] Finished create-virtualenv step (success) 08:41:20 INFO - [mozharness: 2017-02-10 16:41:20.695342Z] Running install step. 08:41:20 INFO - Running pre-action listener: _resource_record_pre_action 08:41:20 INFO - Running main action method: install 08:41:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:20 INFO - Reading from file tmpfile_stdout 08:41:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:21 INFO - Reading from file tmpfile_stdout 08:41:21 INFO - Output received: 08:41:21 INFO - Usage: mozinstall [options] installer 08:41:21 INFO - Options: 08:41:21 INFO - -h, --help show this help message and exit 08:41:21 INFO - -d DEST, --destination=DEST 08:41:21 INFO - Directory to install application into. [default: 08:41:21 INFO - "/builds/slave/test"] 08:41:21 INFO - --app=APP Application being installed. [default: firefox] 08:41:21 INFO - mkdir: /builds/slave/test/build/application 08:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:41:40 INFO - Reading from file tmpfile_stdout 08:41:40 INFO - Output received: 08:41:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:41:40 INFO - Running post-action listener: _resource_record_post_action 08:41:40 INFO - [mozharness: 2017-02-10 16:41:40.912643Z] Finished install step (success) 08:41:40 INFO - [mozharness: 2017-02-10 16:41:40.912778Z] Running run-tests step. 08:41:40 INFO - Running pre-action listener: _resource_record_pre_action 08:41:40 INFO - Running main action method: run_tests 08:41:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:40 INFO - 2017-02-10 08:41:40.925 screenresolution[1962:9959] starting screenresolution argv=screenresolution get 08:41:40 INFO - 2017-02-10 08:41:40.928 screenresolution[1962:9959] Display 0: 1600x1200x32@60 08:41:40 INFO - 2017-02-10 08:41:40.933 screenresolution[1963:9962] starting screenresolution argv=screenresolution list 08:41:40 INFO - Available Modes on Display 0 08:41:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:41 INFO - Intel Iris: 08:41:41 INFO - Chipset Model: Intel Iris 08:41:41 INFO - Type: GPU 08:41:41 INFO - Bus: Built-In 08:41:41 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:41 INFO - Vendor: Intel (0x8086) 08:41:41 INFO - Device ID: 0x0a2e 08:41:41 INFO - Revision ID: 0x0009 08:41:41 INFO - Displays: 08:41:41 INFO - Display: 08:41:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:41 INFO - Display Serial Number: 1600x1200 60 08:41:41 INFO - Main Display: Yes 08:41:41 INFO - Mirror: Off 08:41:41 INFO - Online: Yes 08:41:41 INFO - Rotation: Supported 08:41:41 INFO - Return code: 0 08:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:41 INFO - Python 2.7.3 08:41:41 INFO - Return code: 0 08:41:41 INFO - grabbing minidump binary from tooltool 08:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x10c9f2d30>, '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 0x10c919db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:41:41 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:41:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:41 INFO - Return code: 0 08:41:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlKIeNPQUn/Render', 08:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:41 INFO - 'HOME': '/Users/cltbld', 08:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:41 INFO - 'LOGNAME': 'cltbld', 08:41:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:41 INFO - 'MOZ_NO_REMOTE': '1', 08:41:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:41 INFO - 'NO_EM_RESTART': '1', 08:41:41 INFO - 'PAGER': '/bin/cat', 08:41:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:41 INFO - 'PWD': '/builds/slave/test', 08:41:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:41 INFO - 'SHELL': '/bin/bash', 08:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gZUdY5WbUs/Listeners', 08:41:41 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 08:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:41 INFO - 'USER': 'cltbld', 08:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:41 INFO - 'XPC_FLAGS': '0x0', 08:41:41 INFO - 'XPC_SERVICE_NAME': '0', 08:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:41 INFO - mozversion application_buildid: 20170210070623 08:41:41 INFO - mozversion application_changeset: b15c57d53466fabea73f47f1829ab3d580ef72dd 08:41:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:41:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:41 INFO - mozversion application_name: Firefox 08:41:41 INFO - mozversion application_remotingname: firefox-dev 08:41:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:41 INFO - mozversion application_vendor: Mozilla 08:41:41 INFO - mozversion application_version: 53.0a2 08:41:41 INFO - mozversion platform_buildid: 20170210070623 08:41:41 INFO - mozversion platform_changeset: b15c57d53466fabea73f47f1829ab3d580ef72dd 08:41:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:41 INFO - mozversion platform_version: 53.0a2 08:41:41 INFO - using testdate: 1486744901 08:41:41 INFO - actual date: 1486744901 08:41:41 INFO - starting webserver on 'localhost:49329' 08:41:41 INFO - SUITE-START | Running 2 tests 08:41:41 INFO - TEST-START | dromaeo_css 08:41:41 INFO - operating with platform_type : mac_ 08:41:41 INFO - Initialising browser for dromaeo_css test... 08:41:41 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmp8SdBAf/profile http://localhost:49329/getInfo.html) 08:41:43 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 08:41:43 INFO - PROCESS | 1973 | colorDepth:24 08:41:43 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 08:41:43 INFO - PROCESS | 1973 | __metrics 08:41:44 INFO - PROCESS | 1973 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:41:44 INFO - PROCESS | 1973 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:44 INFO - TEST-INFO | 1973: exit 0 08:41:44 INFO - Browser initialized. 08:41:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:44 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmp8SdBAf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:57 INFO - PROCESS | 1975 | RSS: Main: 212901888 08:41:57 INFO - PROCESS | 1975 | 08:45:00 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49329/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49329/tests/dromaeo/cssquery-ext.html) 08:45:02 INFO - PROCESS | 1975 | RSS: Main: 393478144 08:45:02 INFO - PROCESS | 1975 | 08:46:46 INFO - PROCESS | 1975 | ************************* 08:46:46 INFO - PROCESS | 1975 | A coding exception was thrown and uncaught in a Task. 08:46:46 INFO - PROCESS | 1975 | 08:46:46 ERROR - PROCESS | 1975 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:46:46 INFO - PROCESS | 1975 | Full stack: 08:46:46 INFO - PROCESS | 1975 | ************************* 08:48:05 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49329/tests/dromaeo/cssquery-ext.html (next: http://localhost:49329/tests/dromaeo/cssquery-jquery.html) 08:48:06 INFO - PROCESS | 1975 | RSS: Main: 347824128 08:48:06 INFO - PROCESS | 1975 | 08:51:08 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49329/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49329/tests/dromaeo/cssquery-mootools.html) 08:51:09 INFO - PROCESS | 1975 | RSS: Main: 328265728 08:51:09 INFO - PROCESS | 1975 | 08:54:11 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49329/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49329/tests/dromaeo/cssquery-prototype.html) 08:54:12 INFO - PROCESS | 1975 | RSS: Main: 328343552 08:54:12 INFO - PROCESS | 1975 | 08:57:15 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49329/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49329/tests/dromaeo/cssquery-yui.html) 08:57:16 INFO - PROCESS | 1975 | RSS: Main: 311787520 08:57:16 INFO - PROCESS | 1975 | 09:00:19 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49329/tests/dromaeo/cssquery-yui.html (next: http://localhost:49329/tests/dromaeo/cssquery-dojo.html) 09:00:20 INFO - PROCESS | 1975 | RSS: Main: 404668416 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | __start_tp_report 09:00:20 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 09:00:20 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 09:00:20 INFO - PROCESS | 1975 | |i|pagename|runs| 09:00:20 INFO - PROCESS | 1975 | |0;dojo.html;3249.4963280691495;3295.934081318372;3297.1427428868496;3298.7031167194964;3350.246194606214;5566.666000039995;5611.102223644218;5628.127640215773;5632.83101506955;5633.40849210832;5519.978803921277;5578.41426650202;5640.5487560995125;5645.943540564593;5662.915056274149;5028.245763135532;5119;5162.328897243353;5163.896722065557;5188.896222075557;5058.595312375001;5074.974625126869;5080.237964305346;5170.663906846062;5255.054090263751;5087.7710503027265;5105.795768169269;5115.10485665009;5125.154349532323;5164.457731938149;5175.948240517584;5185.351831021122;5201.635885488017;5201.921971170435;5203.947960520422;5068.847934561969;5149.227615857614;5158.226266060121;5162.5095615916425;5193.454687257821;5457.699826509541;5485.424030476823;5497.39528651848;5586.329640443132;5597.552195824365;6076.96961515194;6175.289841668221;6201.565890387675;6206.689665516707;6207.689615519206;6173.876522469525;6220.751169953196;6254.186955695776;6254.21822272216;6268.623882567015;5548.361938377057;5709.8287051388525;5749.195112684228;5752.252207213078;5766.88466230673;6183.227096612924;6207.5654704171175;6213.254409470802;6213.720382582795;6224.564280500412;5967.104934259809;6026.487748541335;6041.395860413923;6043.7884674036195;6140.846478838065;6141.109539116803;6164.167837341902;6191.628502289877;6198.256209254918;6219.253689557282;6009.1098464084025;6090.421409966046;6124.696630669317;6143.047827586731;6152.446279834837;5861.208736820475;5895.734691938873;5902.026165682614;6188.907166392508;6191.597546159575;4901.852944411673;4948.331975183304;4951.232558953368;4989.3264409305;5000.474950130257;4378.2994720845145;4411.647068234533;4413.911721765611;4424.778761061934;4444.31113177458;5703.572232082611;5719.027765279912;5721.914171287434;5728.971355143281;5737.254156959652;4878.268259761065;5300.787968481295;6108.725107370179;6116.204893363834;6168.537359698041;5732.197492351074;5732.34078081026;5734.082546792493;5741.598088133791;5755;5404.83785486436;5418.945810541923;5443.782248710087;5454.263674403984;5456.7544460499375;6082.9695851520455;6106.419890110433;6123.191113103653;6300.338464461257;6316.589421687576;6086.78696245647;6097.512199024156;6126.670355029888;6130.049842274455;6134.344744984565;6265.310815810349;6267.185265915402;6270.811875643738;6272.968635156795;6276.780312689034;6054.39456054391;6097;6121.234845644294;6122.020476723703;6124.081387791867;5114.667546609458;5938.554608404474;6069.544784141295;6090.208272924491;6132.8773424532155;5389.272448219597;5735.738137609719;6062.575619706755;6076.3012253591405;6090.847728806815;5994.760209591567;6003.549733770072;6046.667433291212;6047.395260473917;6052.213212282375;5724.055530837365;5755.453231942959;5791.884162316815;5813.09896965971;5924.259467566554;6037.63774173551;6052.939470605237;6058.363871793398;6067.757289708362;6087.573869829246;5718.313802343745;5747.08046712524;5751.568632352674;5868.3251426084835;5872.148538461814 09:00:20 INFO - PROCESS | 1975 | |1;ext.html;443.2420560840962;456.33147439001857;498.47908935162764;502.36200025967025;518.7250757098739;30498;32312.515312270305;41167.79416102919;41649;42078.78960605201;43595.34606980898;44143.11713765723;44159;44188.55811441885;44238.33642495357;7884.448088633798;9464.858027129598;9465.053494650549;9479;9486.478243696594;8410.32717382611;8601.225889669928;8618.784530386727;11411.885881141165;11470.02504787094;11327.98048175664;11405.20163588549;11405.54377824886;11412.54349826006;11432.485538150762;8474.067852536216;11416.42917854104;11471.311721296748;11472.196946213768;11514.884851151464;8457.450265732768;11079.002889739962;11349;11353.545858165664;11585.18903676743;41060;41328.38007429891;41347.37978930319;41485.58514414848;41496.37755433671;3867.903302417434;3934.665553427962;3988.78061706606;3996.620321069494;4038.6567141792984;26349;28743.850245990136;29429.264268393246;29466.410671786445;29490.705092949225;3056.404001219763;3299.4555898276753;3332.866685332584;3335.382954153489;3336.73306135511;463953;464732;465461.67269163777;466189;466502;57310.994115205765;57637.8472430549;57742.7112864433;57786.422135778106;57905.710471447375;65267.67366163234;65307.67346163334;65359.673201634636;65409.345906541275;65630;16467.02395712498;16857.83142168587;16874.493765187064;16878.071706056286;16886.98678079319;11657.941710291394;12031.939840300918;12778.744425111445;12926;12942.611721648365;14951.252437378305;19419.223231070882;19638.803611963696;21547.2458463953;22082.44793880166;8681.56592170389;8707.956460217658;8721.781955451164;8769.254613357936;8793.296536277083;838.5136620759945;852.7399143261365;880.801819590587;897.0939351255279;905.3979103895836;29542.40915181727;30025.549616755765;30085.398292034035;30705.539416908763;30734.538981915288;1018.2414101494434;1074.2856000759564;1074.4520294649785;1100.114407901647;1110.9722256943642;12501;15457.5362739118;15495.612609684622;15569.532914012598;15805.762913556306;648476;652335;655024;655164.7241763856;657481;63479.68260158762;63768.36231637717;64091.71816563736;64146.35853641404;64199;1434.791955166495;1451.7822326650876;1473.5652982370011;1474.8672619464085;1476.4906107392933;27126.457470850866;29738.537627325317;29835.552466713452;29954.57041585577;30093.69906300909;49666.758331042016;50280.99438011293;50399.99200015906;50427;50511.74744126256;559574.4042559522;572677;574583;576196;577801;23771.52456950886;23982.76017239875;27119.72880271172;27186.864065679543;27222.455550889266;38268.234635307694;42747;47597.52402475931;48675;50694;36166.914992550264;36317.63682363142;37559.497620095986;38082.66710665113;39217.27435893586;35727.28545429129;35874.4618830723;36055;36580.451293231155;36713.89858304255;35372.11569710778;35704;35944.281114377045;36543.81728091343;36783;30759.384812304077;32555.86054488176;32924;33030.50454243236;33164.83417582897;24010.87994560016;24245.878770606036;24314.75685243125;24723.87638061798;24829.006839726208 09:00:20 INFO - PROCESS | 1975 | |2;jquery.html;351.541238683518;364.9452582112684;386.92648396804606;396.71832998571006;414.786385011719;14804.703905921875;15094.47169349073;17334.913325433372;19917.90041049793;20109.698354524695;19747.308844190455;21151.15395384183;21719.782802171972;21772.237971670995;21801;4805.303231031489;5050.545450909417;5617.269754931853;5752.398081534777;5875.236219291486;5635.774569017234;5772.942270577303;5812;5822.9417705822825;5824.941750582503;4105.979470102645;4310.3534469829465;6125.418085281891;6426.971684530476;6458.257300410466;6211.844703882394;6415.26224484181;6454.386833250834;6476.028595710634;6485.448736857349;5680.488756011979;5680.573956953203;5683.147527870811;5689;5693.544516438675;26095.217143485726;26417.47165056688;26460.206193814218;26486.470270594673;26735;2683.329167708073;2701.1761412769097;2705.945881082387;2728.577070554067;2754.228815931522;13244.53644122451;15498.767518487231;15606;15804.130772807492;15924.601884952968;1447.7321695486369;1725.7325114607256;1757.8769486135975;1779.4839496545985;1810.9366172184043;126706;128097.75217982539;128294;132388;132748.00877986837;11479.311241325548;11491.42542872853;11635.185537012328;11638.825417618742;11766.176367654352;14509.782353264709;14515.709685806225;14530;14531.78202326966;14586.124832510084;7240.818979525554;8671.349648776368;8774.561271936378;8808.471491710518;8903;8723.694670686495;8737.956310218407;8770.51762153075;8926;8948.597313120925;6022.69886505673;7014;7095.690656194377;7161.283871612797;7252.80328745751;1868.7570615819857;1897.2221389230626;1911.6750152474112;1917.3481016454193;1920.9519762006062;1005.4917623564653;1036.212478516333;1043.1498328861953;1044.8484969679505;1059.655611926127;18111.818881811276;22153.227741780618;22549.323520294416;22566.984485698184;22651.43371415695;1073.5598404654054;1076.6931424543968;1088.3469918049107;1097.1332647208776;1100.5157730598671;10990.780184396428;11612.76774464506;11727.882721172678;11821.527138914518;11874.287542747463;406385;481019;741846;765416;774150;129962;131431;133713;136527;139918.60081399258;1034.1468288661883;1043.108142538119;1070.0690399352613;1073.973150671224;1076.3541874875011;18972;19322.420327390202;19620.018999050277;19650.803491964896;19710.90144549268;52685;54465;54788;54966;56067.514598832815;78370.60814696118;79861;80049;80452.59773701095;81172;5841.211436456024;5914;7887.447878648669;8080.313173380094;8536.103709110454;13440.126391784503;13443.731125377633;13701.246431446367;13760.17438953666;13944.860551394357;11053.72365690832;11390.487428065591;11760.176787624785;11798;11856.881431185922;9556.474393908402;11224.494897729459;11403.258788179073;11748.29510229389;11807.291562506278;10268.948655256676;11564.710882228012;11607.593734219261;11612.709682258012;11670.124740644316;8022.27799498048;8054.516728996045;8098.190180981855;8485.490870547786;8490.830183396174;11396;11561.537538498365;11601.651950441501;11803.704907377385;11848.763024739284 09:00:20 INFO - PROCESS | 1975 | |3;mootools.html;1406.7467855785953;1417.22052870921;1419.0350561618095;1426.4222989689179;1436.849130841262;8095.433319667618;8531.78670533237;8540.999999999993;8549.187827156426;8553.059163492011;7424.814379640512;7700.075990881088;7713.421493388004;8041.19588041197;8300.418970672055;2296.334063121697;2333.1717240379676;2338.555674421863;2339.0059224829465;2339.9064037438484;2249.257744944173;2344.894479748407;2346.9647955280684;2359.386559494535;2364.3261670423844;1822.681030819608;2029.553498230387;2098.8530802843807;2228.665700144975;2310.214527060799;2296.540691861626;2317.455397981473;2324.3143272734583;2326.4998025424447;2327.2785436514737;2027.1789925080366;2198.735726957006;2336.661184128292;2343.332150337146;2346.155384061736;8390.119037501097;8449.986001679776;8473.449225800365;8476.957615211946;8482.406231563793;5024.572911302544;5175.767090480937;5183.637145399824;5184.507471790174;5194.662346947436;3315.950260746091;3436.6735160159747;3456.7061799747053;3507.053095664182;3512.701420379271;1142.4059489065723;1189.2983139947473;1206.4751832952693;1230.9569165079179;1259.3262604506544;10888.346699198073;11001.22991390603;11035.779284414266;11070.335779853234;11108.444577771079;4386.4736231652405;4599.563041511051;4631.143238500888;4730.810767569259;4733.431988161443;9165.90834091664;9167.08329167078;9178.541072946326;9181.495017773954;9208.769780755534;5055.368078990126;5132.28148059272;5144.536991670693;5156.226566015052;5159.742012899415;4665.043666048452;4675.275332323427;4697.4832768395445;4762.119007983534;4813.7593120343845;3276.6068071831533;3809.771413715186;3833.559140698855;3858.7298889078056;3897.707671924617;1171.7656468706293;1266.7529831682734;1268.0489632775418;1272.840894888139;1280.04636545774;651.7458191305394;733.6588486353871;754.4567911103996;763.9274268944441;796.3828033274143;5326.786928522815;5353.250544923714;5391.838244852661;5477.972610136924;5619.381867994517;551.80962567914;569.6240481282334;574.8332983434757;581.6422899916521;929.522059924723;3534.169470174507;3659.7255205859665;3720.5535335759882;3739.495168152265;3742.2702572998005;9847.16299114569;10165.288429809842;10171.898281017095;10173.643922462677;10191.082802547806;10043.246756493292;10135.442550659785;10135.898641013642;10144.340617859963;10156.441395723159;7482.812929676693;7732.884006739903;7810.375169986388;7874.370050395954;7937;4566.88582785433;5523.6409633373705;5587.74855131512;5593.748281327432;5641.210230567806;9152.816943660957;9155.176034156957;9402.81194376095;9406.24750019983;9406.717798466058;9049;9394.24846012331;9436.245100392089;9465.716028519155;9621.663241786504;7110.3600675939415;7258.673359698932;7264.927350726425;7273.818154546178;7287.744928927674;6662.200535935719;7716.8456630868195;7815.25755053269;7883.763487095396;7887.329576986021;6967.895481567679;7053.435725141873;7088.397486213729;7106.111736032996;7402.259774022555;6968.79093627192;7065.22282548909;7067.187273463412;7073.3987611053635;7097.148342198969;6317.4630156437215;6427.6786160690845;6438.3883531064475;6448.258450278278;6454.386833250834;4823.831165909176;4896.681715688469;4927.581155601814;4942.4316203637045;4977.8257760978195;4660.883477913079;4738.79160814004;4743.739094349844;4857.53853383928;4902.681325713817 09:00:20 INFO - PROCESS | 1975 | |4;prototype.html;277.3938943408652;324.9951250731238;353.87083714444236;358.4104148675429;365.941449368101;4976.850694479167;5041.294218809369;5117.795288188473;5205.687658740469;5259.500347466994;4339.112486068562;5117.974410127954;5195.766190521426;5212.270282160501;5262.315898933143;3522.894313170596;3941.645251927326;3958.9010274743073;3970.8808735737903;3975.2844487992293;3716.7955762433057;3737.906552336186;3819.732618716691;3840.8847734568008;3963.801809909493;3172.0959526534944;3848.922301755499;3882.3400021996326;3899.3760998240286;3939.606039396066;3654.465124647654;3758.3798673218885;3910.237503686782;3915.334393153171;3975.5030621172355;3243.464828303327;3314.453115235983;3344.8996530104137;3402.9659703403145;3409.9659003409897;3814.9618503814886;4790.712557246541;5061.721605311706;5098.719570423626;5108.245439601889;3546.521219635342;4470.396496472999;4474.753888536129;4500.617447516965;4521.525239849801;5027.673201241908;5169.121249387613;5245.816396426107;5481.232627432123;5484.287042684466;3750.5124333836698;3751.9437208441896;3758.32350176968;3770.3024940385844;3773.5471743390694;5410.242566040757;5763.740631671585;5771.884562308773;5780.88438231233;5803.430890002703;3105.4254962831947;3679.2457546202963;3816.7709937403843;3852.4028775539837;3852.6725228355344;3293.670632936687;3429.045444096841;3635.691336001605;3861.652451279342;3910.0420397002918;3763.5295588051495;4281.28138631971;4351.934720979188;4467.977660111678;4470.329450582439;4268.743875367488;4958.933829226734;5506.898620275961;5522.199281104217;5579.609427340129;1025.354306338331;1234.2964510229262;1249.8375211222483;1258.3205069262497;1262.715888925003;720.7117153138681;817.9182081791773;849.5048714262941;851.7444766570004;857.4298091768903;4265.76538290397;4418.425604671372;4863.878403039952;4892.575197361861;4909.7790599423115;4667.9766601166775;4789.988204953927;4941.851744447672;5389.89793980348;5440.292761941001;4173;4608;4882.633802464829;4925.310456536088;4969.776360063805;2529.5699731045765;2654.336415896026;2836.5817091454273;2840.480343016476;2855.7144285571276;4624.791884365211;5423.207048370093;5582.581306402036;5596;5611.466910643482;5072.782532192247;5292.576593872481;5465.262189604432;5571.972140139354;5837.67892765902;5188.63679542436;5880.588958526983;5883.264591926009;5897.764089436375;6006.969965150146;5491.588130890279;5712.885742285214;5723.370429252695;5728.713564321851;5735.684537350486;4032.435459035796;4454;4864.1929702827865;5593.580481463988;5608.718235576181;5886.735096920564;5890.4993075589055;5896.439838215363;5898.1152827076285;5960.880782384242;3570.785752854837;3586.8163506043466;3630.963690363168;3790.753601015925;3838.3111430970284;4704.88280273885;4847.81903073584;5368.892622147613;5550.5282051026115;5656.575756818337;4812.8796780080775;5341.385740639721;5381.973090134525;5398;5458.208559758733;4850.7574621269505;5471.124620060771;5478.726593257265;5490;5522.806701765419;4523.326369243401;5080.288759573737;5198.4801519847715;5372.435894231049;5450.700211488406;4586.334981427741;4590.678652494294;4593.471750748707;5112.079825631274;5502.80740174108;4521.977390113028;5391.81128660495;5408.78364865401;5426.213199086189;5479.205515200353 09:00:20 INFO - PROCESS | 1975 | |5;yui.html;718.3319512853051;728.6138346676263;741.3809469093306;742.647242559784;750.1448348882275;14663.780043299346;15309.387624495006;15334.846651533482;15352.385904563804;15357.846421535782;14123.293835308219;14195.361208745606;14209.360578773954;14231.288435578206;14234.928825355884;650.7982525417136;672.4721093941257;678.3318431345122;833.0586437325813;840.8108175660489;850.8043150075487;853.5348235211793;865.0225245472639;866.0084203586889;866.9263112635402;910.0808183734442;911.4667919267237;912.803747194353;914.3325372478095;916.5188276155005;691.9757808476729;715.6278735057741;904.5522466379184;905.2712566384058;908.4503875155535;647.8671872266174;665.737033871618;672.3713328038251;673.3300366135726;675.9290274521154;14955.027923184958;14995.625109372244;15003.024803387745;15034.248287585577;15037.624059398493;12781.488740450372;12836.614901552968;13040.608781736562;13074.280914549696;13102.344882755824;12302.692432689255;12364.814527782091;12585.181963172365;12884.613461596073;13402.86597134026;4249.617534421886;4273.893152671208;4533.841315553973;4580.175568397687;4584.885377865547;93728;94803.0519694808;95279;99414;102158.48920755423;10396.064354208007;10541.894581054245;10648.254622176373;10696.358218506915;10754.085902698202;19916.60166796656;21749.238776642742;22259.109635614393;22694.659580106312;22737.545249094925;7786.4938778979185;7806.219378062148;7871.134175240719;7900.68397264103;8002.9599852000365;4195.790210489463;4203.495580530356;4278.336857787048;4432.955670443319;4473.396091527602;3549.680528752425;3661.176235347079;3663.19409729859;3668.137987572918;3679.392900171442;616.8797084568466;619.4394073363613;619.7861737700487;620.6710443464971;623.7660877171061;562.443181250559;604.8064619321863;667.9666016699146;723.8516104198627;723.9457040721861;9511.143997040299;9622.855657165148;10073.546690398949;10186.185105191715;10469;647.6599785112759;704.2499737779249;716.6022857314241;723.9239879812544;735.6615956659996;4504;4966.577840883565;4973.452920178777;4983.127952608279;4990.925136122961;79658.20341796624;102968.97031029593;103808;106382.46808765907;109563;80304.59847700724;81765;83318.58340708379;89095.10904890997;90104.5494772535;73507;75076.24923750693;80067.59966200132;80071;84856.72714909281;9077.636894524145;10613.628523001658;10784.838227426751;10986.505607247853;11198.83201751958;40928.77213683594;49939;50581.735456612405;50607.49392506175;50730;65287.347126528126;67194.66402668151;67945.3205467939;69947.95078073935;70878;12229.388530573258;12667.873321267038;12759.234445933274;12878.42047107901;12903.870961290642;13578.524751633646;14200.573982780534;14720.631984200481;14787.11277323364;14950.327235274657;13149.73700525965;13373.933130334286;13531;13696.93151534236;13722.274016721336;12877.549285774952;12937.611871643865;13135.934320328337;13339;13361.732765344444;12923.741525169631;13029.08796384282;13030.08789384734;13086.476540938256;13105.27920964356;9345.609247547189;10275.126614237874;11045.889541104807;11387.943060284646;11719.707007324543;10886.782264354826;10980.835287470854;11534.1926065178;11699.23954942926;11781.469833857325 09:00:20 INFO - PROCESS | 1975 | __end_tp_report 09:00:20 INFO - PROCESS | 1975 | __start_cc_report 09:00:20 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,2006 09:00:20 INFO - PROCESS | 1975 | __end_cc_report 09:00:20 INFO - PROCESS | 1975 | __startTimestamp1486746020134__endTimestamp 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | ------- Summary: start ------- 09:00:20 INFO - PROCESS | 1975 | Number of tests: 6 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5651.83 Median:5755.00 stddev:623.07 (10.8%) stddev-sans-first:595.79 09:00:20 INFO - PROCESS | 1975 | Values: 3249.5 3295.9 3297.1 3298.7 3350.2 5566.7 5611.1 5628.1 5632.8 5633.4 5520.0 5578.4 5640.5 5645.9 5662.9 5028.2 5119.0 5162.3 5163.9 5188.9 5058.6 5075.0 5080.2 5170.7 5255.1 5087.8 5105.8 5115.1 5125.2 5164.5 5175.9 5185.4 5201.6 5201.9 5203.9 5068.8 5149.2 5158.2 5162.5 5193.5 5457.7 5485.4 5497.4 5586.3 5597.6 6077.0 6175.3 6201.6 6206.7 6207.7 6173.9 6220.8 6254.2 6254.2 6268.6 5548.4 5709.8 5749.2 5752.3 5766.9 6183.2 6207.6 6213.3 6213.7 6224.6 5967.1 6026.5 6041.4 6043.8 6140.8 6141.1 6164.2 6191.6 6198.3 6219.3 6009.1 6090.4 6124.7 6143.0 6152.4 5861.2 5895.7 5902.0 6188.9 6191.6 4901.9 4948.3 4951.2 4989.3 5000.5 4378.3 4411.6 4413.9 4424.8 4444.3 5703.6 5719.0 5721.9 5729.0 5737.3 4878.3 5300.8 6108.7 6116.2 6168.5 5732.2 5732.3 5734.1 5741.6 5755.0 5404.8 5418.9 5443.8 5454.3 5456.8 6083.0 6106.4 6123.2 6300.3 6316.6 6086.8 6097.5 6126.7 6130.0 6134.3 6265.3 6267.2 6270.8 6273.0 6276.8 6054.4 6097.0 6121.2 6122.0 6124.1 5114.7 5938.6 6069.5 6090.2 6132.9 5389.3 5735.7 6062.6 6076.3 6090.8 5994.8 6003.5 6046.7 6047.4 6052.2 5724.1 5755.5 5791.9 5813.1 5924.3 6037.6 6052.9 6058.4 6067.8 6087.6 5718.3 5747.1 5751.6 5868.3 5872.1 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:69814.33 Median:36562.13 stddev:152070.99 (415.9%) stddev-sans-first:152408.39 09:00:20 INFO - PROCESS | 1975 | Values: 443.2 456.3 498.5 502.4 518.7 30498.0 32312.5 41167.8 41649.0 42078.8 43595.3 44143.1 44159.0 44188.6 44238.3 7884.4 9464.9 9465.1 9479.0 9486.5 8410.3 8601.2 8618.8 11411.9 11470.0 11328.0 11405.2 11405.5 11412.5 11432.5 8474.1 11416.4 11471.3 11472.2 11514.9 8457.5 11079.0 11349.0 11353.5 11585.2 41060.0 41328.4 41347.4 41485.6 41496.4 3867.9 3934.7 3988.8 3996.6 4038.7 26349.0 28743.9 29429.3 29466.4 29490.7 3056.4 3299.5 3332.9 3335.4 3336.7 463953.0 464732.0 465461.7 466189.0 466502.0 57311.0 57637.8 57742.7 57786.4 57905.7 65267.7 65307.7 65359.7 65409.3 65630.0 16467.0 16857.8 16874.5 16878.1 16887.0 11657.9 12031.9 12778.7 12926.0 12942.6 14951.3 19419.2 19638.8 21547.2 22082.4 8681.6 8708.0 8721.8 8769.3 8793.3 838.5 852.7 880.8 897.1 905.4 29542.4 30025.5 30085.4 30705.5 30734.5 1018.2 1074.3 1074.5 1100.1 1111.0 12501.0 15457.5 15495.6 15569.5 15805.8 648476.0 652335.0 655024.0 655164.7 657481.0 63479.7 63768.4 64091.7 64146.4 64199.0 1434.8 1451.8 1473.6 1474.9 1476.5 27126.5 29738.5 29835.6 29954.6 30093.7 49666.8 50281.0 50400.0 50427.0 50511.7 559574.4 572677.0 574583.0 576196.0 577801.0 23771.5 23982.8 27119.7 27186.9 27222.5 38268.2 42747.0 47597.5 48675.0 50694.0 36166.9 36317.6 37559.5 38082.7 39217.3 35727.3 35874.5 36055.0 36580.5 36713.9 35372.1 35704.0 35944.3 36543.8 36783.0 30759.4 32555.9 32924.0 33030.5 33164.8 24010.9 24245.9 24314.8 24723.9 24829.0 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:36921.26 Median:20630.43 stddev:109060.88 (528.6%) stddev-sans-first:109332.25 09:00:20 INFO - PROCESS | 1975 | Values: 351.5 364.9 386.9 396.7 414.8 14804.7 15094.5 17334.9 19917.9 20109.7 19747.3 21151.2 21719.8 21772.2 21801.0 4805.3 5050.5 5617.3 5752.4 5875.2 5635.8 5772.9 5812.0 5822.9 5824.9 4106.0 4310.4 6125.4 6427.0 6458.3 6211.8 6415.3 6454.4 6476.0 6485.4 5680.5 5680.6 5683.1 5689.0 5693.5 26095.2 26417.5 26460.2 26486.5 26735.0 2683.3 2701.2 2705.9 2728.6 2754.2 13244.5 15498.8 15606.0 15804.1 15924.6 1447.7 1725.7 1757.9 1779.5 1810.9 126706.0 128097.8 128294.0 132388.0 132748.0 11479.3 11491.4 11635.2 11638.8 11766.2 14509.8 14515.7 14530.0 14531.8 14586.1 7240.8 8671.3 8774.6 8808.5 8903.0 8723.7 8738.0 8770.5 8926.0 8948.6 6022.7 7014.0 7095.7 7161.3 7252.8 1868.8 1897.2 1911.7 1917.3 1921.0 1005.5 1036.2 1043.1 1044.8 1059.7 18111.8 22153.2 22549.3 22567.0 22651.4 1073.6 1076.7 1088.3 1097.1 1100.5 10990.8 11612.8 11727.9 11821.5 11874.3 406385.0 481019.0 741846.0 765416.0 774150.0 129962.0 131431.0 133713.0 136527.0 139918.6 1034.1 1043.1 1070.1 1074.0 1076.4 18972.0 19322.4 19620.0 19650.8 19710.9 52685.0 54465.0 54788.0 54966.0 56067.5 78370.6 79861.0 80049.0 80452.6 81172.0 5841.2 5914.0 7887.4 8080.3 8536.1 13440.1 13443.7 13701.2 13760.2 13944.9 11053.7 11390.5 11760.2 11798.0 11856.9 9556.5 11224.5 11403.3 11748.3 11807.3 10268.9 11564.7 11607.6 11612.7 11670.1 8022.3 8054.5 8098.2 8485.5 8490.8 11396.0 11561.5 11601.7 11803.7 11848.8 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:5407.05 Median:5039.97 stddev:3003.95 (59.6%) stddev-sans-first:2997.33 09:00:20 INFO - PROCESS | 1975 | Values: 1406.7 1417.2 1419.0 1426.4 1436.8 8095.4 8531.8 8541.0 8549.2 8553.1 7424.8 7700.1 7713.4 8041.2 8300.4 2296.3 2333.2 2338.6 2339.0 2339.9 2249.3 2344.9 2347.0 2359.4 2364.3 1822.7 2029.6 2098.9 2228.7 2310.2 2296.5 2317.5 2324.3 2326.5 2327.3 2027.2 2198.7 2336.7 2343.3 2346.2 8390.1 8450.0 8473.4 8477.0 8482.4 5024.6 5175.8 5183.6 5184.5 5194.7 3316.0 3436.7 3456.7 3507.1 3512.7 1142.4 1189.3 1206.5 1231.0 1259.3 10888.3 11001.2 11035.8 11070.3 11108.4 4386.5 4599.6 4631.1 4730.8 4733.4 9165.9 9167.1 9178.5 9181.5 9208.8 5055.4 5132.3 5144.5 5156.2 5159.7 4665.0 4675.3 4697.5 4762.1 4813.8 3276.6 3809.8 3833.6 3858.7 3897.7 1171.8 1266.8 1268.0 1272.8 1280.0 651.7 733.7 754.5 763.9 796.4 5326.8 5353.3 5391.8 5478.0 5619.4 551.8 569.6 574.8 581.6 929.5 3534.2 3659.7 3720.6 3739.5 3742.3 9847.2 10165.3 10171.9 10173.6 10191.1 10043.2 10135.4 10135.9 10144.3 10156.4 7482.8 7732.9 7810.4 7874.4 7937.0 4566.9 5523.6 5587.7 5593.7 5641.2 9152.8 9155.2 9402.8 9406.2 9406.7 9049.0 9394.2 9436.2 9465.7 9621.7 7110.4 7258.7 7264.9 7273.8 7287.7 6662.2 7716.8 7815.3 7883.8 7887.3 6967.9 7053.4 7088.4 7106.1 7402.3 6968.8 7065.2 7067.2 7073.4 7097.1 6317.5 6427.7 6438.4 6448.3 6454.4 4823.8 4896.7 4927.6 4942.4 4977.8 4660.9 4738.8 4743.7 4857.5 4902.7 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:4353.65 Median:4849.29 stddev:1360.01 (28.0%) stddev-sans-first:1328.97 09:00:20 INFO - PROCESS | 1975 | Values: 277.4 325.0 353.9 358.4 365.9 4976.9 5041.3 5117.8 5205.7 5259.5 4339.1 5118.0 5195.8 5212.3 5262.3 3522.9 3941.6 3958.9 3970.9 3975.3 3716.8 3737.9 3819.7 3840.9 3963.8 3172.1 3848.9 3882.3 3899.4 3939.6 3654.5 3758.4 3910.2 3915.3 3975.5 3243.5 3314.5 3344.9 3403.0 3410.0 3815.0 4790.7 5061.7 5098.7 5108.2 3546.5 4470.4 4474.8 4500.6 4521.5 5027.7 5169.1 5245.8 5481.2 5484.3 3750.5 3751.9 3758.3 3770.3 3773.5 5410.2 5763.7 5771.9 5780.9 5803.4 3105.4 3679.2 3816.8 3852.4 3852.7 3293.7 3429.0 3635.7 3861.7 3910.0 3763.5 4281.3 4351.9 4468.0 4470.3 4268.7 4958.9 5506.9 5522.2 5579.6 1025.4 1234.3 1249.8 1258.3 1262.7 720.7 817.9 849.5 851.7 857.4 4265.8 4418.4 4863.9 4892.6 4909.8 4668.0 4790.0 4941.9 5389.9 5440.3 4173.0 4608.0 4882.6 4925.3 4969.8 2529.6 2654.3 2836.6 2840.5 2855.7 4624.8 5423.2 5582.6 5596.0 5611.5 5072.8 5292.6 5465.3 5572.0 5837.7 5188.6 5880.6 5883.3 5897.8 6007.0 5491.6 5712.9 5723.4 5728.7 5735.7 4032.4 4454.0 4864.2 5593.6 5608.7 5886.7 5890.5 5896.4 5898.1 5960.9 3570.8 3586.8 3631.0 3790.8 3838.3 4704.9 4847.8 5368.9 5550.5 5656.6 4812.9 5341.4 5382.0 5398.0 5458.2 4850.8 5471.1 5478.7 5490.0 5522.8 4523.3 5080.3 5198.5 5372.4 5450.7 4586.3 4590.7 4593.5 5112.1 5502.8 4522.0 5391.8 5408.8 5426.2 5479.2 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:20051.92 Median:4276.12 stddev:28321.77 (662.3%) stddev-sans-first:28364.02 09:00:20 INFO - PROCESS | 1975 | Values: 718.3 728.6 741.4 742.6 750.1 14663.8 15309.4 15334.8 15352.4 15357.8 14123.3 14195.4 14209.4 14231.3 14234.9 650.8 672.5 678.3 833.1 840.8 850.8 853.5 865.0 866.0 866.9 910.1 911.5 912.8 914.3 916.5 692.0 715.6 904.6 905.3 908.5 647.9 665.7 672.4 673.3 675.9 14955.0 14995.6 15003.0 15034.2 15037.6 12781.5 12836.6 13040.6 13074.3 13102.3 12302.7 12364.8 12585.2 12884.6 13402.9 4249.6 4273.9 4533.8 4580.2 4584.9 93728.0 94803.1 95279.0 99414.0 102158.5 10396.1 10541.9 10648.3 10696.4 10754.1 19916.6 21749.2 22259.1 22694.7 22737.5 7786.5 7806.2 7871.1 7900.7 8003.0 4195.8 4203.5 4278.3 4433.0 4473.4 3549.7 3661.2 3663.2 3668.1 3679.4 616.9 619.4 619.8 620.7 623.8 562.4 604.8 668.0 723.9 723.9 9511.1 9622.9 10073.5 10186.2 10469.0 647.7 704.2 716.6 723.9 735.7 4504.0 4966.6 4973.5 4983.1 4990.9 79658.2 102969.0 103808.0 106382.5 109563.0 80304.6 81765.0 83318.6 89095.1 90104.5 73507.0 75076.2 80067.6 80071.0 84856.7 9077.6 10613.6 10784.8 10986.5 11198.8 40928.8 49939.0 50581.7 50607.5 50730.0 65287.3 67194.7 67945.3 69948.0 70878.0 12229.4 12667.9 12759.2 12878.4 12903.9 13578.5 14200.6 14720.6 14787.1 14950.3 13149.7 13373.9 13531.0 13696.9 13722.3 12877.5 12937.6 13135.9 13339.0 13361.7 12923.7 13029.1 13030.1 13086.5 13105.3 9345.6 10275.1 11045.9 11387.9 11719.7 10886.8 10980.8 11534.2 11699.2 11781.5 09:00:20 INFO - PROCESS | 1975 | -------- Summary: end -------- 09:00:20 INFO - PROCESS | 1975 | 09:00:20 INFO - TEST-INFO | 1975: exit 0 09:00:20 INFO - TEST-OK | dromaeo_css | took 1119402ms 09:00:20 INFO - TEST-START | kraken 09:00:20 INFO - operating with platform_type : mac_ 09:00:20 INFO - Initialising browser for kraken test... 09:00:20 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpdAGwA9/profile http://localhost:49329/getInfo.html) 09:00:23 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 09:00:23 INFO - PROCESS | 1977 | colorDepth:24 09:00:23 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 09:00:23 INFO - PROCESS | 1977 | __metrics 09:00:23 INFO - PROCESS | 1977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:00:23 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:24 INFO - TEST-INFO | 1977: exit 0 09:00:24 INFO - Browser initialized. 09:00:24 INFO - Running cycle 1/1 for kraken test... 09:00:24 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpdAGwA9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:36 INFO - PROCESS | 1978 | RSS: Main: 213282816 09:00:36 INFO - PROCESS | 1978 | 09:00:39 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49329/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:40 INFO - PROCESS | 1978 | RSS: Main: 266096640 09:00:40 INFO - PROCESS | 1978 | 09:00:42 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49329/tests/kraken/driver.html?testName=audio-dft) 09:00:43 INFO - PROCESS | 1978 | RSS: Main: 276168704 09:00:43 INFO - PROCESS | 1978 | 09:00:46 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49329/tests/kraken/driver.html?testName=audio-fft) 09:00:47 INFO - PROCESS | 1978 | RSS: Main: 372785152 09:00:47 INFO - PROCESS | 1978 | 09:00:49 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49329/tests/kraken/driver.html?testName=audio-oscillator) 09:00:49 INFO - PROCESS | 1978 | RSS: Main: 277114880 09:00:49 INFO - PROCESS | 1978 | 09:00:51 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49329/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:52 INFO - PROCESS | 1978 | RSS: Main: 278761472 09:00:52 INFO - PROCESS | 1978 | 09:00:55 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49329/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:55 INFO - PROCESS | 1978 | RSS: Main: 319217664 09:00:55 INFO - PROCESS | 1978 | 09:00:58 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49329/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:59 INFO - PROCESS | 1978 | RSS: Main: 319508480 09:00:59 INFO - PROCESS | 1978 | 09:01:02 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49329/tests/kraken/driver.html?testName=json-parse-financial) 09:01:02 INFO - PROCESS | 1978 | RSS: Main: 317906944 09:01:02 INFO - PROCESS | 1978 | 09:01:04 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49329/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:04 INFO - PROCESS | 1978 | RSS: Main: 295399424 09:01:04 INFO - PROCESS | 1978 | 09:01:06 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:07 INFO - PROCESS | 1978 | RSS: Main: 296558592 09:01:07 INFO - PROCESS | 1978 | 09:01:09 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:10 INFO - PROCESS | 1978 | RSS: Main: 299524096 09:01:10 INFO - PROCESS | 1978 | 09:01:13 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:14 INFO - PROCESS | 1978 | RSS: Main: 317239296 09:01:14 INFO - PROCESS | 1978 | 09:01:17 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:17 INFO - PROCESS | 1978 | RSS: Main: 310833152 09:01:17 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49329/tests/kraken/driver.html?testName=ai-astar) 09:01:19 INFO - PROCESS | 1978 | RSS: Main: 355139584 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | __start_tp_report 09:01:19 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 09:01:19 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 09:01:19 INFO - PROCESS | 1978 | |i|pagename|runs| 09:01:19 INFO - PROCESS | 1978 | |0;ai-astar;115;113;114;114;113;113;112;112;110;113 09:01:19 INFO - PROCESS | 1978 | |1;audio-beat-detection;141;110;107;141;110;108;107;107;127;110 09:01:19 INFO - PROCESS | 1978 | |2;audio-dft;186;182;183;185;185;185;184;185;184;186 09:01:19 INFO - PROCESS | 1978 | |3;audio-fft;83;59;58;93;61;57;58;60;86;81 09:01:19 INFO - PROCESS | 1978 | |4;audio-oscillator;86;69;86;69;69;69;81;67;69;81 09:01:19 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;88;84;88;85;88;85;88;85;88;85 09:01:19 INFO - PROCESS | 1978 | |6;imaging-darkroom;97;96;98;98;99;97;97;98;97;99 09:01:19 INFO - PROCESS | 1978 | |7;imaging-desaturate;88;87;85;86;98;123;86;86;85;95 09:01:19 INFO - PROCESS | 1978 | |8;json-parse-financial;57;54;52;53;57;57;57;57;57;56 09:01:19 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;65;74;69;76;71;71;70;71;71;73 09:01:19 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;86;84;82;83;86;83;80;86;106;101 09:01:19 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;139;140;152;130;128;145;151;152;194;152 09:01:19 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;169;169;191;231;227;185;166;166;167;167 09:01:19 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;66;66;66;64;66;65;68;78;82;83 09:01:19 INFO - PROCESS | 1978 | __end_tp_report 09:01:19 INFO - PROCESS | 1978 | __start_cc_report 09:01:19 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,1998 09:01:19 INFO - PROCESS | 1978 | __end_cc_report 09:01:19 INFO - PROCESS | 1978 | __startTimestamp1486746079721__endTimestamp 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | ------- Summary: start ------- 09:01:19 INFO - PROCESS | 1978 | Number of tests: 14 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.37 (1.2%) stddev-sans-first:1.22 09:01:19 INFO - PROCESS | 1978 | Values: 115.0 113.0 114.0 114.0 113.0 113.0 112.0 112.0 110.0 113.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:110.00 stddev:14.06 (12.8%) stddev-sans-first:11.88 09:01:19 INFO - PROCESS | 1978 | Values: 141.0 110.0 107.0 141.0 110.0 108.0 107.0 107.0 127.0 110.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.27 (0.7%) stddev-sans-first:1.22 09:01:19 INFO - PROCESS | 1978 | Values: 186.0 182.0 183.0 185.0 185.0 185.0 184.0 185.0 184.0 186.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:69.60 Median:71.00 stddev:14.27 (20.1%) stddev-sans-first:14.29 09:01:19 INFO - PROCESS | 1978 | Values: 83.0 59.0 58.0 93.0 61.0 57.0 58.0 60.0 86.0 81.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:75.00 stddev:7.86 (10.5%) stddev-sans-first:7.18 09:01:19 INFO - PROCESS | 1978 | Values: 86.0 69.0 86.0 69.0 69.0 69.0 81.0 67.0 69.0 81.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:88.00 stddev:1.71 (1.9%) stddev-sans-first:1.72 09:01:19 INFO - PROCESS | 1978 | Values: 88.0 84.0 88.0 85.0 88.0 85.0 88.0 85.0 88.0 85.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:98.00 stddev:0.97 (1.0%) stddev-sans-first:1.00 09:01:19 INFO - PROCESS | 1978 | Values: 97.0 96.0 98.0 98.0 99.0 97.0 97.0 98.0 97.0 99.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:86.50 stddev:11.80 (13.6%) stddev-sans-first:12.43 09:01:19 INFO - PROCESS | 1978 | Values: 88.0 87.0 85.0 86.0 98.0 123.0 86.0 86.0 85.0 95.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:57.00 stddev:1.95 (3.4%) stddev-sans-first:2.01 09:01:19 INFO - PROCESS | 1978 | Values: 57.0 54.0 52.0 53.0 57.0 57.0 57.0 57.0 57.0 56.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:2.96 (4.2%) stddev-sans-first:2.17 09:01:19 INFO - PROCESS | 1978 | Values: 65.0 74.0 69.0 76.0 71.0 71.0 70.0 71.0 71.0 73.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:83.50 stddev:8.63 (10.3%) stddev-sans-first:9.13 09:01:19 INFO - PROCESS | 1978 | Values: 86.0 84.0 82.0 83.0 86.0 83.0 80.0 86.0 106.0 101.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:151.50 stddev:18.41 (12.2%) stddev-sans-first:19.22 09:01:19 INFO - PROCESS | 1978 | Values: 139.0 140.0 152.0 130.0 128.0 145.0 151.0 152.0 194.0 152.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:177.00 stddev:25.35 (14.3%) stddev-sans-first:26.32 09:01:19 INFO - PROCESS | 1978 | Values: 169.0 169.0 191.0 231.0 227.0 185.0 166.0 166.0 167.0 167.0 09:01:19 INFO - PROCESS | 1978 | 09:01:19 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:67.00 stddev:7.49 (11.2%) stddev-sans-first:7.77 09:01:19 INFO - PROCESS | 1978 | Values: 66.0 66.0 66.0 64.0 66.0 65.0 68.0 78.0 82.0 83.0 09:01:19 INFO - PROCESS | 1978 | -------- Summary: end -------- 09:01:19 INFO - PROCESS | 1978 | 09:01:20 INFO - TEST-INFO | 1978: exit 0 09:01:20 INFO - TEST-OK | kraken | took 59698ms 09:01:20 INFO - SUITE-END | took 1179s 09:01:20 INFO - Completed test suite (00:19:39) 09:01:20 INFO - javascript benchmark 09:01:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.4963280691495, 3295.934081318372, 3297.1427428868496, 3298.7031167194964, 3350.246194606214, 5566.666000039995, 5611.102223644218, 5628.127640215773, 5632.83101506955, 5633.40849210832, 5519.978803921277, 5578.41426650202, 5640.5487560995125, 5645.943540564593, 5662.915056274149, 5028.245763135532, 5119.0, 5162.328897243353, 5163.896722065557, 5188.896222075557, 5058.595312375001, 5074.974625126869, 5080.237964305346, 5170.663906846062, 5255.054090263751, 5087.7710503027265, 5105.795768169269, 5115.10485665009, 5125.154349532323, 5164.457731938149, 5175.948240517584, 5185.351831021122, 5201.635885488017, 5201.921971170435, 5203.947960520422, 5068.847934561969, 5149.227615857614, 5158.226266060121, 5162.5095615916425, 5193.454687257821, 5457.699826509541, 5485.424030476823, 5497.39528651848, 5586.329640443132, 5597.552195824365, 6076.96961515194, 6175.289841668221, 6201.565890387675, 6206.689665516707, 6207.689615519206, 6173.876522469525, 6220.751169953196, 6254.186955695776, 6254.21822272216, 6268.623882567015, 5548.361938377057, 5709.8287051388525, 5749.195112684228, 5752.252207213078, 5766.88466230673, 6183.227096612924, 6207.5654704171175, 6213.254409470802, 6213.720382582795, 6224.564280500412, 5967.104934259809, 6026.487748541335, 6041.395860413923, 6043.7884674036195, 6140.846478838065, 6141.109539116803, 6164.167837341902, 6191.628502289877, 6198.256209254918, 6219.253689557282, 6009.1098464084025, 6090.421409966046, 6124.696630669317, 6143.047827586731, 6152.446279834837, 5861.208736820475, 5895.734691938873, 5902.026165682614, 6188.907166392508, 6191.597546159575, 4901.852944411673, 4948.331975183304, 4951.232558953368, 4989.3264409305, 5000.474950130257, 4378.2994720845145, 4411.647068234533, 4413.911721765611, 4424.778761061934, 4444.31113177458, 5703.572232082611, 5719.027765279912, 5721.914171287434, 5728.971355143281, 5737.254156959652, 4878.268259761065, 5300.787968481295, 6108.725107370179, 6116.204893363834, 6168.537359698041, 5732.197492351074, 5732.34078081026, 5734.082546792493, 5741.598088133791, 5755.0, 5404.83785486436, 5418.945810541923, 5443.782248710087, 5454.263674403984, 5456.7544460499375, 6082.9695851520455, 6106.419890110433, 6123.191113103653, 6300.338464461257, 6316.589421687576, 6086.78696245647, 6097.512199024156, 6126.670355029888, 6130.049842274455, 6134.344744984565, 6265.310815810349, 6267.185265915402, 6270.811875643738, 6272.968635156795, 6276.780312689034, 6054.39456054391, 6097.0, 6121.234845644294, 6122.020476723703, 6124.081387791867, 5114.667546609458, 5938.554608404474, 6069.544784141295, 6090.208272924491, 6132.8773424532155, 5389.272448219597, 5735.738137609719, 6062.575619706755, 6076.3012253591405, 6090.847728806815, 5994.760209591567, 6003.549733770072, 6046.667433291212, 6047.395260473917, 6052.213212282375, 5724.055530837365, 5755.453231942959, 5791.884162316815, 5813.09896965971, 5924.259467566554, 6037.63774173551, 6052.939470605237, 6058.363871793398, 6067.757289708362, 6087.573869829246, 5718.313802343745, 5747.08046712524, 5751.568632352674, 5868.3251426084835, 5872.148538461814], "value": 5612.741054230651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.2420560840962, 456.33147439001857, 498.47908935162764, 502.36200025967025, 518.7250757098739, 30498.0, 32312.515312270305, 41167.79416102919, 41649.0, 42078.78960605201, 43595.34606980898, 44143.11713765723, 44159.0, 44188.55811441885, 44238.33642495357, 7884.448088633798, 9464.858027129598, 9465.053494650549, 9479.0, 9486.478243696594, 8410.32717382611, 8601.225889669928, 8618.784530386727, 11411.885881141165, 11470.02504787094, 11327.98048175664, 11405.20163588549, 11405.54377824886, 11412.54349826006, 11432.485538150762, 8474.067852536216, 11416.42917854104, 11471.311721296748, 11472.196946213768, 11514.884851151464, 8457.450265732768, 11079.002889739962, 11349.0, 11353.545858165664, 11585.18903676743, 41060.0, 41328.38007429891, 41347.37978930319, 41485.58514414848, 41496.37755433671, 3867.903302417434, 3934.665553427962, 3988.78061706606, 3996.620321069494, 4038.6567141792984, 26349.0, 28743.850245990136, 29429.264268393246, 29466.410671786445, 29490.705092949225, 3056.404001219763, 3299.4555898276753, 3332.866685332584, 3335.382954153489, 3336.73306135511, 463953.0, 464732.0, 465461.67269163777, 466189.0, 466502.0, 57310.994115205765, 57637.8472430549, 57742.7112864433, 57786.422135778106, 57905.710471447375, 65267.67366163234, 65307.67346163334, 65359.673201634636, 65409.345906541275, 65630.0, 16467.02395712498, 16857.83142168587, 16874.493765187064, 16878.071706056286, 16886.98678079319, 11657.941710291394, 12031.939840300918, 12778.744425111445, 12926.0, 12942.611721648365, 14951.252437378305, 19419.223231070882, 19638.803611963696, 21547.2458463953, 22082.44793880166, 8681.56592170389, 8707.956460217658, 8721.781955451164, 8769.254613357936, 8793.296536277083, 838.5136620759945, 852.7399143261365, 880.801819590587, 897.0939351255279, 905.3979103895836, 29542.40915181727, 30025.549616755765, 30085.398292034035, 30705.539416908763, 30734.538981915288, 1018.2414101494434, 1074.2856000759564, 1074.4520294649785, 1100.114407901647, 1110.9722256943642, 12501.0, 15457.5362739118, 15495.612609684622, 15569.532914012598, 15805.762913556306, 648476.0, 652335.0, 655024.0, 655164.7241763856, 657481.0, 63479.68260158762, 63768.36231637717, 64091.71816563736, 64146.35853641404, 64199.0, 1434.791955166495, 1451.7822326650876, 1473.5652982370011, 1474.8672619464085, 1476.4906107392933, 27126.457470850866, 29738.537627325317, 29835.552466713452, 29954.57041585577, 30093.69906300909, 49666.758331042016, 50280.99438011293, 50399.99200015906, 50427.0, 50511.74744126256, 559574.4042559522, 572677.0, 574583.0, 576196.0, 577801.0, 23771.52456950886, 23982.76017239875, 27119.72880271172, 27186.864065679543, 27222.455550889266, 38268.234635307694, 42747.0, 47597.52402475931, 48675.0, 50694.0, 36166.914992550264, 36317.63682363142, 37559.497620095986, 38082.66710665113, 39217.27435893586, 35727.28545429129, 35874.4618830723, 36055.0, 36580.451293231155, 36713.89858304255, 35372.11569710778, 35704.0, 35944.281114377045, 36543.81728091343, 36783.0, 30759.384812304077, 32555.86054488176, 32924.0, 33030.50454243236, 33164.83417582897, 24010.87994560016, 24245.878770606036, 24314.75685243125, 24723.87638061798, 24829.006839726208], "value": 20164.87799859302, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.541238683518, 364.9452582112684, 386.92648396804606, 396.71832998571006, 414.786385011719, 14804.703905921875, 15094.47169349073, 17334.913325433372, 19917.90041049793, 20109.698354524695, 19747.308844190455, 21151.15395384183, 21719.782802171972, 21772.237971670995, 21801.0, 4805.303231031489, 5050.545450909417, 5617.269754931853, 5752.398081534777, 5875.236219291486, 5635.774569017234, 5772.942270577303, 5812.0, 5822.9417705822825, 5824.941750582503, 4105.979470102645, 4310.3534469829465, 6125.418085281891, 6426.971684530476, 6458.257300410466, 6211.844703882394, 6415.26224484181, 6454.386833250834, 6476.028595710634, 6485.448736857349, 5680.488756011979, 5680.573956953203, 5683.147527870811, 5689.0, 5693.544516438675, 26095.217143485726, 26417.47165056688, 26460.206193814218, 26486.470270594673, 26735.0, 2683.329167708073, 2701.1761412769097, 2705.945881082387, 2728.577070554067, 2754.228815931522, 13244.53644122451, 15498.767518487231, 15606.0, 15804.130772807492, 15924.601884952968, 1447.7321695486369, 1725.7325114607256, 1757.8769486135975, 1779.4839496545985, 1810.9366172184043, 126706.0, 128097.75217982539, 128294.0, 132388.0, 132748.00877986837, 11479.311241325548, 11491.42542872853, 11635.185537012328, 11638.825417618742, 11766.176367654352, 14509.782353264709, 14515.709685806225, 14530.0, 14531.78202326966, 14586.124832510084, 7240.818979525554, 8671.349648776368, 8774.561271936378, 8808.471491710518, 8903.0, 8723.694670686495, 8737.956310218407, 8770.51762153075, 8926.0, 8948.597313120925, 6022.69886505673, 7014.0, 7095.690656194377, 7161.283871612797, 7252.80328745751, 1868.7570615819857, 1897.2221389230626, 1911.6750152474112, 1917.3481016454193, 1920.9519762006062, 1005.4917623564653, 1036.212478516333, 1043.1498328861953, 1044.8484969679505, 1059.655611926127, 18111.818881811276, 22153.227741780618, 22549.323520294416, 22566.984485698184, 22651.43371415695, 1073.5598404654054, 1076.6931424543968, 1088.3469918049107, 1097.1332647208776, 1100.5157730598671, 10990.780184396428, 11612.76774464506, 11727.882721172678, 11821.527138914518, 11874.287542747463, 406385.0, 481019.0, 741846.0, 765416.0, 774150.0, 129962.0, 131431.0, 133713.0, 136527.0, 139918.60081399258, 1034.1468288661883, 1043.108142538119, 1070.0690399352613, 1073.973150671224, 1076.3541874875011, 18972.0, 19322.420327390202, 19620.018999050277, 19650.803491964896, 19710.90144549268, 52685.0, 54465.0, 54788.0, 54966.0, 56067.514598832815, 78370.60814696118, 79861.0, 80049.0, 80452.59773701095, 81172.0, 5841.211436456024, 5914.0, 7887.447878648669, 8080.313173380094, 8536.103709110454, 13440.126391784503, 13443.731125377633, 13701.246431446367, 13760.17438953666, 13944.860551394357, 11053.72365690832, 11390.487428065591, 11760.176787624785, 11798.0, 11856.881431185922, 9556.474393908402, 11224.494897729459, 11403.258788179073, 11748.29510229389, 11807.291562506278, 10268.948655256676, 11564.710882228012, 11607.593734219261, 11612.709682258012, 11670.124740644316, 8022.27799498048, 8054.516728996045, 8098.190180981855, 8485.490870547786, 8490.830183396174, 11396.0, 11561.537538498365, 11601.651950441501, 11803.704907377385, 11848.763024739284], "value": 10020.458907988374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.7467855785953, 1417.22052870921, 1419.0350561618095, 1426.4222989689179, 1436.849130841262, 8095.433319667618, 8531.78670533237, 8540.999999999993, 8549.187827156426, 8553.059163492011, 7424.814379640512, 7700.075990881088, 7713.421493388004, 8041.19588041197, 8300.418970672055, 2296.334063121697, 2333.1717240379676, 2338.555674421863, 2339.0059224829465, 2339.9064037438484, 2249.257744944173, 2344.894479748407, 2346.9647955280684, 2359.386559494535, 2364.3261670423844, 1822.681030819608, 2029.553498230387, 2098.8530802843807, 2228.665700144975, 2310.214527060799, 2296.540691861626, 2317.455397981473, 2324.3143272734583, 2326.4998025424447, 2327.2785436514737, 2027.1789925080366, 2198.735726957006, 2336.661184128292, 2343.332150337146, 2346.155384061736, 8390.119037501097, 8449.986001679776, 8473.449225800365, 8476.957615211946, 8482.406231563793, 5024.572911302544, 5175.767090480937, 5183.637145399824, 5184.507471790174, 5194.662346947436, 3315.950260746091, 3436.6735160159747, 3456.7061799747053, 3507.053095664182, 3512.701420379271, 1142.4059489065723, 1189.2983139947473, 1206.4751832952693, 1230.9569165079179, 1259.3262604506544, 10888.346699198073, 11001.22991390603, 11035.779284414266, 11070.335779853234, 11108.444577771079, 4386.4736231652405, 4599.563041511051, 4631.143238500888, 4730.810767569259, 4733.431988161443, 9165.90834091664, 9167.08329167078, 9178.541072946326, 9181.495017773954, 9208.769780755534, 5055.368078990126, 5132.28148059272, 5144.536991670693, 5156.226566015052, 5159.742012899415, 4665.043666048452, 4675.275332323427, 4697.4832768395445, 4762.119007983534, 4813.7593120343845, 3276.6068071831533, 3809.771413715186, 3833.559140698855, 3858.7298889078056, 3897.707671924617, 1171.7656468706293, 1266.7529831682734, 1268.0489632775418, 1272.840894888139, 1280.04636545774, 651.7458191305394, 733.6588486353871, 754.4567911103996, 763.9274268944441, 796.3828033274143, 5326.786928522815, 5353.250544923714, 5391.838244852661, 5477.972610136924, 5619.381867994517, 551.80962567914, 569.6240481282334, 574.8332983434757, 581.6422899916521, 929.522059924723, 3534.169470174507, 3659.7255205859665, 3720.5535335759882, 3739.495168152265, 3742.2702572998005, 9847.16299114569, 10165.288429809842, 10171.898281017095, 10173.643922462677, 10191.082802547806, 10043.246756493292, 10135.442550659785, 10135.898641013642, 10144.340617859963, 10156.441395723159, 7482.812929676693, 7732.884006739903, 7810.375169986388, 7874.370050395954, 7937.0, 4566.88582785433, 5523.6409633373705, 5587.74855131512, 5593.748281327432, 5641.210230567806, 9152.816943660957, 9155.176034156957, 9402.81194376095, 9406.24750019983, 9406.717798466058, 9049.0, 9394.24846012331, 9436.245100392089, 9465.716028519155, 9621.663241786504, 7110.3600675939415, 7258.673359698932, 7264.927350726425, 7273.818154546178, 7287.744928927674, 6662.200535935719, 7716.8456630868195, 7815.25755053269, 7883.763487095396, 7887.329576986021, 6967.895481567679, 7053.435725141873, 7088.397486213729, 7106.111736032996, 7402.259774022555, 6968.79093627192, 7065.22282548909, 7067.187273463412, 7073.3987611053635, 7097.148342198969, 6317.4630156437215, 6427.6786160690845, 6438.3883531064475, 6448.258450278278, 6454.386833250834, 4823.831165909176, 4896.681715688469, 4927.581155601814, 4942.4316203637045, 4977.8257760978195, 4660.883477913079, 4738.79160814004, 4743.739094349844, 4857.53853383928, 4902.681325713817], "value": 4326.400786691965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.3938943408652, 324.9951250731238, 353.87083714444236, 358.4104148675429, 365.941449368101, 4976.850694479167, 5041.294218809369, 5117.795288188473, 5205.687658740469, 5259.500347466994, 4339.112486068562, 5117.974410127954, 5195.766190521426, 5212.270282160501, 5262.315898933143, 3522.894313170596, 3941.645251927326, 3958.9010274743073, 3970.8808735737903, 3975.2844487992293, 3716.7955762433057, 3737.906552336186, 3819.732618716691, 3840.8847734568008, 3963.801809909493, 3172.0959526534944, 3848.922301755499, 3882.3400021996326, 3899.3760998240286, 3939.606039396066, 3654.465124647654, 3758.3798673218885, 3910.237503686782, 3915.334393153171, 3975.5030621172355, 3243.464828303327, 3314.453115235983, 3344.8996530104137, 3402.9659703403145, 3409.9659003409897, 3814.9618503814886, 4790.712557246541, 5061.721605311706, 5098.719570423626, 5108.245439601889, 3546.521219635342, 4470.396496472999, 4474.753888536129, 4500.617447516965, 4521.525239849801, 5027.673201241908, 5169.121249387613, 5245.816396426107, 5481.232627432123, 5484.287042684466, 3750.5124333836698, 3751.9437208441896, 3758.32350176968, 3770.3024940385844, 3773.5471743390694, 5410.242566040757, 5763.740631671585, 5771.884562308773, 5780.88438231233, 5803.430890002703, 3105.4254962831947, 3679.2457546202963, 3816.7709937403843, 3852.4028775539837, 3852.6725228355344, 3293.670632936687, 3429.045444096841, 3635.691336001605, 3861.652451279342, 3910.0420397002918, 3763.5295588051495, 4281.28138631971, 4351.934720979188, 4467.977660111678, 4470.329450582439, 4268.743875367488, 4958.933829226734, 5506.898620275961, 5522.199281104217, 5579.609427340129, 1025.354306338331, 1234.2964510229262, 1249.8375211222483, 1258.3205069262497, 1262.715888925003, 720.7117153138681, 817.9182081791773, 849.5048714262941, 851.7444766570004, 857.4298091768903, 4265.76538290397, 4418.425604671372, 4863.878403039952, 4892.575197361861, 4909.7790599423115, 4667.9766601166775, 4789.988204953927, 4941.851744447672, 5389.89793980348, 5440.292761941001, 4173.0, 4608.0, 4882.633802464829, 4925.310456536088, 4969.776360063805, 2529.5699731045765, 2654.336415896026, 2836.5817091454273, 2840.480343016476, 2855.7144285571276, 4624.791884365211, 5423.207048370093, 5582.581306402036, 5596.0, 5611.466910643482, 5072.782532192247, 5292.576593872481, 5465.262189604432, 5571.972140139354, 5837.67892765902, 5188.63679542436, 5880.588958526983, 5883.264591926009, 5897.764089436375, 6006.969965150146, 5491.588130890279, 5712.885742285214, 5723.370429252695, 5728.713564321851, 5735.684537350486, 4032.435459035796, 4454.0, 4864.1929702827865, 5593.580481463988, 5608.718235576181, 5886.735096920564, 5890.4993075589055, 5896.439838215363, 5898.1152827076285, 5960.880782384242, 3570.785752854837, 3586.8163506043466, 3630.963690363168, 3790.753601015925, 3838.3111430970284, 4704.88280273885, 4847.81903073584, 5368.892622147613, 5550.5282051026115, 5656.575756818337, 4812.8796780080775, 5341.385740639721, 5381.973090134525, 5398.0, 5458.208559758733, 4850.7574621269505, 5471.124620060771, 5478.726593257265, 5490.0, 5522.806701765419, 4523.326369243401, 5080.288759573737, 5198.4801519847715, 5372.435894231049, 5450.700211488406, 4586.334981427741, 4590.678652494294, 4593.471750748707, 5112.079825631274, 5502.80740174108, 4521.977390113028, 5391.81128660495, 5408.78364865401, 5426.213199086189, 5479.205515200353], "value": 3930.694578956133, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.3319512853051, 728.6138346676263, 741.3809469093306, 742.647242559784, 750.1448348882275, 14663.780043299346, 15309.387624495006, 15334.846651533482, 15352.385904563804, 15357.846421535782, 14123.293835308219, 14195.361208745606, 14209.360578773954, 14231.288435578206, 14234.928825355884, 650.7982525417136, 672.4721093941257, 678.3318431345122, 833.0586437325813, 840.8108175660489, 850.8043150075487, 853.5348235211793, 865.0225245472639, 866.0084203586889, 866.9263112635402, 910.0808183734442, 911.4667919267237, 912.803747194353, 914.3325372478095, 916.5188276155005, 691.9757808476729, 715.6278735057741, 904.5522466379184, 905.2712566384058, 908.4503875155535, 647.8671872266174, 665.737033871618, 672.3713328038251, 673.3300366135726, 675.9290274521154, 14955.027923184958, 14995.625109372244, 15003.024803387745, 15034.248287585577, 15037.624059398493, 12781.488740450372, 12836.614901552968, 13040.608781736562, 13074.280914549696, 13102.344882755824, 12302.692432689255, 12364.814527782091, 12585.181963172365, 12884.613461596073, 13402.86597134026, 4249.617534421886, 4273.893152671208, 4533.841315553973, 4580.175568397687, 4584.885377865547, 93728.0, 94803.0519694808, 95279.0, 99414.0, 102158.48920755423, 10396.064354208007, 10541.894581054245, 10648.254622176373, 10696.358218506915, 10754.085902698202, 19916.60166796656, 21749.238776642742, 22259.109635614393, 22694.659580106312, 22737.545249094925, 7786.4938778979185, 7806.219378062148, 7871.134175240719, 7900.68397264103, 8002.9599852000365, 4195.790210489463, 4203.495580530356, 4278.336857787048, 4432.955670443319, 4473.396091527602, 3549.680528752425, 3661.176235347079, 3663.19409729859, 3668.137987572918, 3679.392900171442, 616.8797084568466, 619.4394073363613, 619.7861737700487, 620.6710443464971, 623.7660877171061, 562.443181250559, 604.8064619321863, 667.9666016699146, 723.8516104198627, 723.9457040721861, 9511.143997040299, 9622.855657165148, 10073.546690398949, 10186.185105191715, 10469.0, 647.6599785112759, 704.2499737779249, 716.6022857314241, 723.9239879812544, 735.6615956659996, 4504.0, 4966.577840883565, 4973.452920178777, 4983.127952608279, 4990.925136122961, 79658.20341796624, 102968.97031029593, 103808.0, 106382.46808765907, 109563.0, 80304.59847700724, 81765.0, 83318.58340708379, 89095.10904890997, 90104.5494772535, 73507.0, 75076.24923750693, 80067.59966200132, 80071.0, 84856.72714909281, 9077.636894524145, 10613.628523001658, 10784.838227426751, 10986.505607247853, 11198.83201751958, 40928.77213683594, 49939.0, 50581.735456612405, 50607.49392506175, 50730.0, 65287.347126528126, 67194.66402668151, 67945.3205467939, 69947.95078073935, 70878.0, 12229.388530573258, 12667.873321267038, 12759.234445933274, 12878.42047107901, 12903.870961290642, 13578.524751633646, 14200.573982780534, 14720.631984200481, 14787.11277323364, 14950.327235274657, 13149.73700525965, 13373.933130334286, 13531.0, 13696.93151534236, 13722.274016721336, 12877.549285774952, 12937.611871643865, 13135.934320328337, 13339.0, 13361.732765344444, 12923.741525169631, 13029.08796384282, 13030.08789384734, 13086.476540938256, 13105.27920964356, 9345.609247547189, 10275.126614237874, 11045.889541104807, 11387.943060284646, 11719.707007324543, 10886.782264354826, 10980.835287470854, 11534.1926065178, 11699.23954942926, 11781.469833857325], "value": 7462.812997484238, "unit": "score"}], "name": "dromaeo_css", "value": 7239.379845254924, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 114.0, 113.0, 113.0, 112.0, 112.0, 110.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 107.0, 141.0, 110.0, 108.0, 107.0, 107.0, 127.0, 110.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 183.0, 185.0, 185.0, 185.0, 184.0, 185.0, 184.0, 186.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 93.0, 61.0, 57.0, 58.0, 60.0, 86.0, 81.0], "value": 69.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 86.0, 69.0, 69.0, 69.0, 81.0, 67.0, 69.0, 81.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 85.0, 88.0, 85.0, 88.0, 85.0, 88.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 98.0, 98.0, 99.0, 97.0, 97.0, 98.0, 97.0, 99.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 86.0, 98.0, 123.0, 86.0, 86.0, 85.0, 95.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 52.0, 53.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 69.0, 76.0, 71.0, 71.0, 70.0, 71.0, 71.0, 73.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 82.0, 83.0, 86.0, 83.0, 80.0, 86.0, 106.0, 101.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 152.0, 130.0, 128.0, 145.0, 151.0, 152.0, 194.0, 152.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 191.0, 231.0, 227.0, 185.0, 166.0, 166.0, 167.0, 167.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 64.0, 66.0, 65.0, 68.0, 78.0, 82.0, 83.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1451.3, "alertThreshold": 2.0}]} 09:01:20 INFO - Return code: 0 09:01:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:21 ERROR - # TBPL SUCCESS # 09:01:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:21 INFO - 2017-02-10 09:01:21.040 screenresolution[1982:11991] starting screenresolution argv=screenresolution get 09:01:21 INFO - 2017-02-10 09:01:21.042 screenresolution[1982:11991] Display 0: 1600x1200x32@60 09:01:21 INFO - 2017-02-10 09:01:21.048 screenresolution[1983:11994] starting screenresolution argv=screenresolution list 09:01:21 INFO - Available Modes on Display 0 09:01:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:21 INFO - Intel Iris: 09:01:21 INFO - Chipset Model: Intel Iris 09:01:21 INFO - Type: GPU 09:01:21 INFO - Bus: Built-In 09:01:21 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:21 INFO - Vendor: Intel (0x8086) 09:01:21 INFO - Device ID: 0x0a2e 09:01:21 INFO - Revision ID: 0x0009 09:01:21 INFO - Displays: 09:01:21 INFO - Display: 09:01:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:21 INFO - Display Serial Number: 1600x1200 60 09:01:21 INFO - Main Display: Yes 09:01:21 INFO - Mirror: Off 09:01:21 INFO - Online: Yes 09:01:21 INFO - Rotation: Supported 09:01:21 INFO - Return code: 0 09:01:21 INFO - Running post-action listener: _resource_record_post_action 09:01:21 INFO - [mozharness: 2017-02-10 17:01:21.296221Z] Finished run-tests step (success) 09:01:21 INFO - Running post-run listener: _resource_record_post_run 09:01:21 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 331776; Write bytes: 506910208; Read time: 7; Write time: 1747 09:01:21 INFO - TinderboxPrint: CPU usage
53.4% 09:01:21 INFO - TinderboxPrint: I/O read bytes / time
331,776 / 7 09:01:21 INFO - TinderboxPrint: I/O write bytes / time
506,910,208 / 1,747 09:01:21 INFO - TinderboxPrint: CPU idle
2,236.8 (46.6%) 09:01:21 INFO - TinderboxPrint: CPU system
958.8 (20.0%) 09:01:21 INFO - TinderboxPrint: CPU user
1,606.0 (33.4%) 09:01:21 INFO - TinderboxPrint: Swap in / out
207,384,576 / 0 09:01:21 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207270400; Write bytes: 202335232; Read time: 15993; Write time: 420 09:01:21 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 159744; Write bytes: 294572544; Read time: 3; Write time: 1291 09:01:21 INFO - Running post-run listener: _upload_blobber_files 09:01:21 INFO - Blob upload gear active. 09:01:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:21 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:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:22 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:22 INFO - (blobuploader) - INFO - Done attempting. 09:01:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:25 INFO - (blobuploader) - INFO - Done attempting. 09:01:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:01:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:01:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:26 INFO - (blobuploader) - INFO - Done attempting. 09:01:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:28 INFO - (blobuploader) - INFO - Done attempting. 09:01:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:28 INFO - Return code: 0 09:01:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9d5413a4d8287d4b2f339e710def69f213b4ed000d49866e98d3929a991fe9348e55f4a968039d08685768a7c982173fb51629048fc63c9dceec4d00eaf7b5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7df28299fab3aa6f27774a060b4a137bdf64a62514f108ead2b9a1e59ced58fddeb9accc1184f7f5a0471dc9212c673b3832826596353070384372b557914034", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ca234835a412bae5b2f684a1b0ead3e80f909c381e21b6c31b40e577d881511066594a006b0c64c66e77a68d7a44b96d97c11a7b7423daba76bc1d5e084447a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d670b3289544da74311a8477f6ea92ad2046f75098dee13ed2180b610f498f40a0f047417f06f360c116f90f48a469c981c5e3716830a37d1fe14b8351db32db"} 09:01:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:28 INFO - Contents: 09:01:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9d5413a4d8287d4b2f339e710def69f213b4ed000d49866e98d3929a991fe9348e55f4a968039d08685768a7c982173fb51629048fc63c9dceec4d00eaf7b5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7df28299fab3aa6f27774a060b4a137bdf64a62514f108ead2b9a1e59ced58fddeb9accc1184f7f5a0471dc9212c673b3832826596353070384372b557914034", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ca234835a412bae5b2f684a1b0ead3e80f909c381e21b6c31b40e577d881511066594a006b0c64c66e77a68d7a44b96d97c11a7b7423daba76bc1d5e084447a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d670b3289544da74311a8477f6ea92ad2046f75098dee13ed2180b610f498f40a0f047417f06f360c116f90f48a469c981c5e3716830a37d1fe14b8351db32db"} 09:01:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:28 INFO - Copying logs to upload dir... 09:01:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.338526 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-10 09:01:28.819078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 09:01:28.822274) ========= 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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9d5413a4d8287d4b2f339e710def69f213b4ed000d49866e98d3929a991fe9348e55f4a968039d08685768a7c982173fb51629048fc63c9dceec4d00eaf7b5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7df28299fab3aa6f27774a060b4a137bdf64a62514f108ead2b9a1e59ced58fddeb9accc1184f7f5a0471dc9212c673b3832826596353070384372b557914034", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ca234835a412bae5b2f684a1b0ead3e80f909c381e21b6c31b40e577d881511066594a006b0c64c66e77a68d7a44b96d97c11a7b7423daba76bc1d5e084447a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d670b3289544da74311a8477f6ea92ad2046f75098dee13ed2180b610f498f40a0f047417f06f360c116f90f48a469c981c5e3716830a37d1fe14b8351db32db"} build_url:https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011600 build_url: 'https://queue.taskcluster.net/v1/task/P4X6LLHqSUmJKd_GGd-a_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9d5413a4d8287d4b2f339e710def69f213b4ed000d49866e98d3929a991fe9348e55f4a968039d08685768a7c982173fb51629048fc63c9dceec4d00eaf7b5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7df28299fab3aa6f27774a060b4a137bdf64a62514f108ead2b9a1e59ced58fddeb9accc1184f7f5a0471dc9212c673b3832826596353070384372b557914034", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ca234835a412bae5b2f684a1b0ead3e80f909c381e21b6c31b40e577d881511066594a006b0c64c66e77a68d7a44b96d97c11a7b7423daba76bc1d5e084447a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d670b3289544da74311a8477f6ea92ad2046f75098dee13ed2180b610f498f40a0f047417f06f360c116f90f48a469c981c5e3716830a37d1fe14b8351db32db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 09:01:28.857542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:01:28.857892) ========= 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.wlKIeNPQUn/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.gZUdY5WbUs/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.005276 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 09:01:28.906727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 09:01:28.907136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 09:01:28.907477) ========= ========= Total master_lag: 0.19 =========