builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0328 starttime: 1484959682.47 results: success (0) buildid: 20170120144225 builduid: c1215c97759d498b8e1479f8270be8af revision: ccec56819e76733f28ae7f046e4602824ddbed10 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.473428) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.473860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.474135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.505045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.505424) ========= 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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-01-20 16:48:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-01-20 16:48:02 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.346683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.875579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.878923) ========= 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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.029882 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:02.931176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 16:48:02.931518) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ccec56819e76733f28ae7f046e4602824ddbed10 --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 ccec56819e76733f28ae7f046e4602824ddbed10 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-01-20 16:48:03,040 truncating revision to first 12 chars 2017-01-20 16:48:03,041 Setting DEBUG logging. 2017-01-20 16:48:03,041 attempt 1/10 2017-01-20 16:48:03,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ccec56819e76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 16:48:05,158 unpacking tar archive at: mozilla-aurora-ccec56819e76/testing/mozharness/ program finished with exit code 0 elapsedTime=2.395603 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 16:48:05.353296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:05.353596) ========= script_repo_revision: ccec56819e76733f28ae7f046e4602824ddbed10 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 16:48:05.353989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-01-20 16:48:05.354248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-01-20 16:48:08.319361) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-20 16:48:08.320154) ========= /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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:48:08 INFO - MultiFileLogger online at 20170120 16:48:08 in /builds/slave/test 16:48:08 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 16:48:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:48:08 INFO - {'append_to_log': False, 16:48:08 INFO - 'base_work_dir': '/builds/slave/test', 16:48:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:48:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:48:08 INFO - 'branch': 'Mozilla-Aurora', 16:48:08 INFO - 'buildbot_json_path': 'buildprops.json', 16:48:08 INFO - 'config_files': ('talos/mac_config.py',), 16:48:08 INFO - 'default_actions': ('clobber', 16:48:08 INFO - 'read-buildbot-config', 16:48:08 INFO - 'download-and-extract', 16:48:08 INFO - 'populate-webroot', 16:48:08 INFO - 'create-virtualenv', 16:48:08 INFO - 'install', 16:48:08 INFO - 'run-tests'), 16:48:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:48:08 INFO - 'download_minidump_stackwalk': True, 16:48:08 INFO - 'download_symbols': 'ondemand', 16:48:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:48:08 INFO - 'tooltool.py': '/tools/tooltool.py', 16:48:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:48:08 INFO - '/tools/misc-python/virtualenv.py')}, 16:48:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:48:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:48:08 INFO - 'installer_path': 'installer.exe', 16:48:08 INFO - 'log_level': 'info', 16:48:08 INFO - 'log_name': 'talos', 16:48:08 INFO - 'log_to_console': True, 16:48:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:48:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:48:08 INFO - 'opt_config_files': (), 16:48:08 INFO - 'pip_index': False, 16:48:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:48:08 INFO - 'cmd': ('bash', 16:48:08 INFO - '-c', 16:48:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:48:08 INFO - 'enabled': True, 16:48:08 INFO - 'halt_on_failure': False, 16:48:08 INFO - 'name': 'check_screen_resolution'},), 16:48:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:48:08 INFO - 'cmd': ('bash', 16:48:08 INFO - '-c', 16:48:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:48:08 INFO - 'enabled': True, 16:48:08 INFO - 'halt_on_failure': False, 16:48:08 INFO - 'name': 'check_screen_resolution'},), 16:48:08 INFO - 'run_cmd_checks_enabled': True, 16:48:08 INFO - 'sps_profile': False, 16:48:08 INFO - 'sps_profile_interval': 0, 16:48:08 INFO - 'suite': 'dromaeojs', 16:48:08 INFO - 'system_bits': '32', 16:48:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:48:08 INFO - 'title': 't-yosemite-r7-0328', 16:48:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:48:08 INFO - 'use_talos_json': True, 16:48:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:48:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:48:08 INFO - 'work_dir': 'build'} 16:48:08 INFO - [mozharness: 2017-01-21 00:48:08.531539Z] Running clobber step. 16:48:08 INFO - Running pre-action listener: _resource_record_pre_action 16:48:08 INFO - Running main action method: clobber 16:48:08 INFO - rmtree: /builds/slave/test/build 16:48:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:48:10 INFO - Running post-action listener: _resource_record_post_action 16:48:10 INFO - [mozharness: 2017-01-21 00:48:10.868987Z] Finished clobber step (success) 16:48:10 INFO - [mozharness: 2017-01-21 00:48:10.869091Z] Running read-buildbot-config step. 16:48:10 INFO - Running pre-action listener: _resource_record_pre_action 16:48:10 INFO - Running main action method: read_buildbot_config 16:48:10 INFO - Using buildbot properties: 16:48:10 INFO - { 16:48:10 INFO - "project": "", 16:48:10 INFO - "product": "firefox", 16:48:10 INFO - "script_repo_revision": "production", 16:48:10 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:48:10 INFO - "repository": "", 16:48:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:48:10 INFO - "buildid": "20170120144225", 16:48:10 INFO - "pgo_build": "False", 16:48:10 INFO - "basedir": "/builds/slave/test", 16:48:10 INFO - "buildnumber": 34, 16:48:10 INFO - "slavename": "t-yosemite-r7-0328", 16:48:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:48:10 INFO - "platform": "yosemite_r7", 16:48:10 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:48:10 INFO - "branch": "mozilla-aurora", 16:48:10 INFO - "repo_path": "releases/mozilla-aurora", 16:48:10 INFO - "revision": "ccec56819e76733f28ae7f046e4602824ddbed10", 16:48:10 INFO - "stage_platform": "macosx64", 16:48:10 INFO - "builduid": "c1215c97759d498b8e1479f8270be8af", 16:48:10 INFO - "slavebuilddir": "test" 16:48:10 INFO - } 16:48:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 16:48:10 INFO - Running post-action listener: _resource_record_post_action 16:48:10 INFO - [mozharness: 2017-01-21 00:48:10.871753Z] Finished read-buildbot-config step (success) 16:48:10 INFO - [mozharness: 2017-01-21 00:48:10.871876Z] Running download-and-extract step. 16:48:10 INFO - Running pre-action listener: _resource_record_pre_action 16:48:10 INFO - Running main action method: download_and_extract 16:48:10 INFO - mkdir: /builds/slave/test/build/tests 16:48: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')]} 16:48:10 INFO - trying https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 16:48:10 INFO - Downloading https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 16:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 16:48:12 INFO - Downloaded 1199 bytes. 16:48:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 16:48:12 INFO - Using the following test package requirements: 16:48:12 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 16:48:12 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 16:48:12 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 16:48:12 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'jsshell-mac.zip'], 16:48:12 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 16:48:12 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 16:48:12 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 16:48:12 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 16:48:12 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 16:48:12 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 16:48:12 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 16:48:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:48:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 16:48:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:48:12 INFO - Fetch https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 16:48:12 INFO - Http code: 200 16:48:12 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 16:48:12 INFO - x-amz-cf-id: -M4kQMq-6Nj-k517uNW30zQ1sNgCGIY78OLCH5PVrnO7yLEGa0hpkA== 16:48:12 INFO - x-amz-version-id: Bc6ElE57GF_PPPqIU5NhnU8Ftt2oCn.m 16:48:13 INFO - Expected file size: 16276206 16:48:13 INFO - Obtained file size: 16276206 16:48:19 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:48:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 16:48:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:48:19 INFO - Fetch https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 16:48:20 INFO - Http code: 200 16:48:20 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 16:48:20 INFO - x-amz-cf-id: T_lWJh9YskVJk0N_OtPKUZMU2-re93MOa2IRtd9KP_7nr1rEt9jnMw== 16:48:20 INFO - x-amz-version-id: Bc6ElE57GF_PPPqIU5NhnU8Ftt2oCn.m 16:48:20 INFO - Expected file size: 16276206 16:48:20 INFO - Obtained file size: 16276206 16:48:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 16:48:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:48:26 INFO - Fetch https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 16:48:27 INFO - Http code: 200 16:48:27 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 16:48:27 INFO - x-amz-cf-id: nOP70cyTk2uKUaQ66ZzaZhU8NfaPEWR1yBJKT9GumGQ9Bf_VARqZCA== 16:48:27 INFO - x-amz-version-id: 0oDhBiQChCKDTl52Vq7ILLEZn1rWkckV 16:48:27 INFO - Expected file size: 14402992 16:48:27 INFO - Obtained file size: 14402992 16:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:28 INFO - trying https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 16:48:28 INFO - Downloading https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 16:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 16:48:30 INFO - Downloaded 109968401 bytes. 16:48:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 16:48:30 INFO - mkdir: /builds/slave/test/properties 16:48:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:48:30 INFO - Writing to file /builds/slave/test/properties/build_url 16:48:30 INFO - Contents: 16:48:30 INFO - build_url:https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 16:48:31 INFO - Running post-action listener: _resource_record_post_action 16:48:31 INFO - Running post-action listener: set_extra_try_arguments 16:48:31 INFO - [mozharness: 2017-01-21 00:48:31.934449Z] Finished download-and-extract step (success) 16:48:31 INFO - [mozharness: 2017-01-21 00:48:31.934579Z] Running populate-webroot step. 16:48:31 INFO - Running pre-action listener: _resource_record_pre_action 16:48:31 INFO - Running main action method: populate_webroot 16:48:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:48:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:48:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:48:31 INFO - '--tppagecycles', 16:48:31 INFO - '7'], 16:48:31 INFO - 'tests': ['tsvgm']}}, 16:48:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:48:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:48:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:48:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:48:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['damp', 'tps']}, 16:48:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'tests': ['damp', 'tps']}, 16:48:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['dromaeo_dom']}, 16:48:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:48:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['basic_compositor_video']}, 16:48:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:48:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['a11yr', 16:48:31 INFO - 'ts_paint', 16:48:31 INFO - 'tpaint', 16:48:31 INFO - 'sessionrestore', 16:48:31 INFO - 'sessionrestore_no_auto_restore', 16:48:31 INFO - 'tabpaint']}, 16:48:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:48:31 INFO - 'ts_paint', 16:48:31 INFO - 'tpaint', 16:48:31 INFO - 'sessionrestore', 16:48:31 INFO - 'sessionrestore_no_auto_restore', 16:48:31 INFO - 'tabpaint']}, 16:48:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:48:31 INFO - 'ts_paint', 16:48:31 INFO - 'tpaint', 16:48:31 INFO - 'sessionrestore', 16:48:31 INFO - 'sessionrestore_no_auto_restore', 16:48:31 INFO - 'tabpaint']}, 16:48:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:48:31 INFO - 'ts_paint', 16:48:31 INFO - 'tpaint', 16:48:31 INFO - 'sessionrestore', 16:48:31 INFO - 'sessionrestore_no_auto_restore', 16:48:31 INFO - 'tabpaint']}, 16:48:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['a11yr', 16:48:31 INFO - 'ts_paint', 16:48:31 INFO - 'tpaint', 16:48:31 INFO - 'sessionrestore', 16:48:31 INFO - 'sessionrestore_no_auto_restore', 16:48:31 INFO - 'tabpaint']}, 16:48:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['a11yr', 16:48:31 INFO - 'ts_paint', 16:48:31 INFO - 'tpaint', 16:48:31 INFO - 'sessionrestore', 16:48:31 INFO - 'sessionrestore_no_auto_restore', 16:48:31 INFO - 'tabpaint']}, 16:48:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['tsvgx', 16:48:31 INFO - 'tsvgr_opacity', 16:48:31 INFO - 'tart', 16:48:31 INFO - 'tscrollx', 16:48:31 INFO - 'cart']}, 16:48:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:48:31 INFO - 'tsvgr_opacity', 16:48:31 INFO - 'tart', 16:48:31 INFO - 'tscrollx', 16:48:31 INFO - 'cart']}, 16:48:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'talos_options': ['--disable-e10s'], 16:48:31 INFO - 'tests': ['tp5o']}, 16:48:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'tests': ['tp5o']}, 16:48:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'talos_options': ['--disable-e10s', 16:48:31 INFO - '--xperf_path', 16:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:31 INFO - 'tests': ['tp5n']}, 16:48:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:31 INFO - 'talos_options': ['--xperf_path', 16:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:31 INFO - 'tests': ['tp5n']}}, 16:48:31 INFO - 'talos.zip': {'path': '', 16:48:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:48:31 INFO - Running post-action listener: _resource_record_post_action 16:48:31 INFO - [mozharness: 2017-01-21 00:48:31.953538Z] Finished populate-webroot step (success) 16:48:31 INFO - [mozharness: 2017-01-21 00:48:31.953647Z] Running create-virtualenv step. 16:48:31 INFO - Running pre-action listener: _resource_record_pre_action 16:48:31 INFO - Running main action method: create_virtualenv 16:48:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:48:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:48:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:48:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:48:32 INFO - Using real prefix '/tools/python27' 16:48:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:48:32 INFO - Installing distribute.............................................................................................................................................................................................done. 16:48:35 INFO - Installing pip.................done. 16:48:35 INFO - Return code: 0 16:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:48:35 INFO - Reading from file tmpfile_stdout 16:48:35 INFO - Output received: 16:48:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:48:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:35 INFO - 'HOME': '/Users/cltbld', 16:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:35 INFO - 'LOGNAME': 'cltbld', 16:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:35 INFO - 'MOZ_NO_REMOTE': '1', 16:48:35 INFO - 'NO_EM_RESTART': '1', 16:48:35 INFO - 'PAGER': '/bin/cat', 16:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:35 INFO - 'PWD': '/builds/slave/test', 16:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:35 INFO - 'SHELL': '/bin/bash', 16:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:35 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:35 INFO - 'USER': 'cltbld', 16:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:35 INFO - 'XPC_FLAGS': '0x0', 16:48:35 INFO - 'XPC_SERVICE_NAME': '0', 16:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:48:36 INFO - Cleaning up... 16:48:36 INFO - Return code: 0 16:48:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:36 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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:36 INFO - 'HOME': '/Users/cltbld', 16:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:36 INFO - 'LOGNAME': 'cltbld', 16:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:36 INFO - 'MOZ_NO_REMOTE': '1', 16:48:36 INFO - 'NO_EM_RESTART': '1', 16:48:36 INFO - 'PAGER': '/bin/cat', 16:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:36 INFO - 'PWD': '/builds/slave/test', 16:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:36 INFO - 'SHELL': '/bin/bash', 16:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:36 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:36 INFO - 'USER': 'cltbld', 16:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:36 INFO - 'XPC_FLAGS': '0x0', 16:48:36 INFO - 'XPC_SERVICE_NAME': '0', 16:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:36 INFO - Downloading/unpacking psutil>=3.1.1 16:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:48:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:39 INFO - Installing collected packages: psutil 16:48:39 INFO - Running setup.py install for psutil 16:48:40 INFO - building 'psutil._psutil_osx' extension 16:48:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:48:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:48:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:48:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:48:40 INFO - building 'psutil._psutil_posix' extension 16:48:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:48:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:48:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:48:40 INFO - ^ 16:48:40 INFO - 1 warning generated. 16:48:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:48:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:41 INFO - Successfully installed psutil 16:48:41 INFO - Cleaning up... 16:48:41 INFO - Return code: 0 16:48:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:48: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')]} 16:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48: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')]} 16:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:41 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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:41 INFO - 'HOME': '/Users/cltbld', 16:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:41 INFO - 'LOGNAME': 'cltbld', 16:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:41 INFO - 'MOZ_NO_REMOTE': '1', 16:48:41 INFO - 'NO_EM_RESTART': '1', 16:48:41 INFO - 'PAGER': '/bin/cat', 16:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:41 INFO - 'PWD': '/builds/slave/test', 16:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:41 INFO - 'SHELL': '/bin/bash', 16:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:41 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:41 INFO - 'USER': 'cltbld', 16:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:41 INFO - 'XPC_FLAGS': '0x0', 16:48:41 INFO - 'XPC_SERVICE_NAME': '0', 16:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:48:44 INFO - Installing collected packages: mozsystemmonitor 16:48:44 INFO - Running setup.py install for mozsystemmonitor 16:48:44 INFO - Successfully installed mozsystemmonitor 16:48:44 INFO - Cleaning up... 16:48:44 INFO - Return code: 0 16:48:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:48: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')]} 16:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48: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')]} 16:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:44 INFO - 'HOME': '/Users/cltbld', 16:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:44 INFO - 'LOGNAME': 'cltbld', 16:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:44 INFO - 'MOZ_NO_REMOTE': '1', 16:48:44 INFO - 'NO_EM_RESTART': '1', 16:48:44 INFO - 'PAGER': '/bin/cat', 16:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:44 INFO - 'PWD': '/builds/slave/test', 16:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:44 INFO - 'SHELL': '/bin/bash', 16:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:44 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:44 INFO - 'USER': 'cltbld', 16:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:44 INFO - 'XPC_FLAGS': '0x0', 16:48:44 INFO - 'XPC_SERVICE_NAME': '0', 16:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:44 INFO - Downloading/unpacking jsonschema==2.5.1 16:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:48:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:47 INFO - Downloading functools32-3.2.3-2.tar.gz 16:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:48:47 INFO - warning: no files found matching '*.txt' 16:48:47 INFO - no previously-included directories found matching 'build' 16:48:47 INFO - no previously-included directories found matching 'dist' 16:48:47 INFO - no previously-included directories found matching '.git*' 16:48:47 INFO - Installing collected packages: jsonschema, functools32 16:48:47 INFO - Running setup.py install for functools32 16:48:47 INFO - warning: no files found matching '*.txt' 16:48:47 INFO - no previously-included directories found matching 'build' 16:48:47 INFO - no previously-included directories found matching 'dist' 16:48:47 INFO - no previously-included directories found matching '.git*' 16:48:47 INFO - Successfully installed jsonschema functools32 16:48:47 INFO - Cleaning up... 16:48:48 INFO - Return code: 0 16:48:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:48 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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:48 INFO - 'HOME': '/Users/cltbld', 16:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:48 INFO - 'LOGNAME': 'cltbld', 16:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:48 INFO - 'MOZ_NO_REMOTE': '1', 16:48:48 INFO - 'NO_EM_RESTART': '1', 16:48:48 INFO - 'PAGER': '/bin/cat', 16:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:48 INFO - 'PWD': '/builds/slave/test', 16:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:48 INFO - 'SHELL': '/bin/bash', 16:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:48 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:48 INFO - 'USER': 'cltbld', 16:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:48 INFO - 'XPC_FLAGS': '0x0', 16:48:48 INFO - 'XPC_SERVICE_NAME': '0', 16:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:48:48 INFO - Cleaning up... 16:48:48 INFO - Return code: 0 16:48:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:48 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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:48 INFO - 'HOME': '/Users/cltbld', 16:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:48 INFO - 'LOGNAME': 'cltbld', 16:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:48 INFO - 'MOZ_NO_REMOTE': '1', 16:48:48 INFO - 'NO_EM_RESTART': '1', 16:48:48 INFO - 'PAGER': '/bin/cat', 16:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:48 INFO - 'PWD': '/builds/slave/test', 16:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:48 INFO - 'SHELL': '/bin/bash', 16:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:48 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:48 INFO - 'USER': 'cltbld', 16:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:48 INFO - 'XPC_FLAGS': '0x0', 16:48:48 INFO - 'XPC_SERVICE_NAME': '0', 16:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:51 INFO - Downloading blobuploader-1.2.4.tar.gz 16:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:48:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:48:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:52 INFO - Downloading docopt-0.6.1.tar.gz 16:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:48:52 INFO - Installing collected packages: blobuploader, requests, docopt 16:48:52 INFO - Running setup.py install for blobuploader 16:48:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:48:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:48:52 INFO - Running setup.py install for requests 16:48:53 INFO - Running setup.py install for docopt 16:48:53 INFO - Successfully installed blobuploader requests docopt 16:48:53 INFO - Cleaning up... 16:48:53 INFO - Return code: 0 16:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:53 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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:53 INFO - 'HOME': '/Users/cltbld', 16:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:53 INFO - 'LOGNAME': 'cltbld', 16:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:53 INFO - 'MOZ_NO_REMOTE': '1', 16:48:53 INFO - 'NO_EM_RESTART': '1', 16:48:53 INFO - 'PAGER': '/bin/cat', 16:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:53 INFO - 'PWD': '/builds/slave/test', 16:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:53 INFO - 'SHELL': '/bin/bash', 16:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:53 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:53 INFO - 'USER': 'cltbld', 16:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:53 INFO - 'XPC_FLAGS': '0x0', 16:48:53 INFO - 'XPC_SERVICE_NAME': '0', 16:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:53 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-uQ6Gal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:53 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-c2ZkzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:53 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-MvQDb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-DW4wom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Te_dnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-_Ix2W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-DEwe4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-fdcQq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Fan_1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-6QgQdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-tZiDqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-8fbR1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:54 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-90eH21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Vete9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-SIJ3YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-K2C9d7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-ZeoWdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:48:55 INFO - Running setup.py install for manifestparser 16:48:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:48:55 INFO - Running setup.py install for mozcrash 16:48:55 INFO - Running setup.py install for mozdebug 16:48:55 INFO - Running setup.py install for mozdevice 16:48:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Running setup.py install for mozfile 16:48:56 INFO - Running setup.py install for mozhttpd 16:48:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Running setup.py install for mozinfo 16:48:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Running setup.py install for mozInstall 16:48:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Running setup.py install for mozleak 16:48:56 INFO - Running setup.py install for mozlog 16:48:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:48:56 INFO - Running setup.py install for moznetwork 16:48:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:48:57 INFO - Running setup.py install for mozprocess 16:48:57 INFO - Running setup.py install for mozprofile 16:48:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:48:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:48:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:48:57 INFO - Running setup.py install for mozrunner 16:48:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:48:57 INFO - Running setup.py install for mozscreenshot 16:48:57 INFO - Running setup.py install for moztest 16:48:57 INFO - Running setup.py install for mozversion 16:48:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:48:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:48:58 INFO - Cleaning up... 16:48:58 INFO - Return code: 0 16:48:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:58 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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:48:58 INFO - 'HOME': '/Users/cltbld', 16:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:48:58 INFO - 'LOGNAME': 'cltbld', 16:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:58 INFO - 'MOZ_NO_REMOTE': '1', 16:48:58 INFO - 'NO_EM_RESTART': '1', 16:48:58 INFO - 'PAGER': '/bin/cat', 16:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:58 INFO - 'PWD': '/builds/slave/test', 16:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:48:58 INFO - 'SHELL': '/bin/bash', 16:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:48:58 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:48:58 INFO - 'USER': 'cltbld', 16:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:58 INFO - 'XPC_FLAGS': '0x0', 16:48:58 INFO - 'XPC_SERVICE_NAME': '0', 16:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:58 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-OCFF9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:58 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-b3MpTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:58 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-5pWTjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-j7vlWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-1Fzhy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-uznuKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-lopjFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-trQxSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-VNelSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-JhWxbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-mOpNMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:59 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-87Ug_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-BM9UNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-cO6aPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-W98oHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-81fPBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-zpXWFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:03 INFO - Downloading blessings-1.6.tar.gz 16:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:03 INFO - Installing collected packages: blessings 16:49:03 INFO - Running setup.py install for blessings 16:49:03 INFO - Successfully installed blessings 16:49:03 INFO - Cleaning up... 16:49:03 INFO - Return code: 0 16:49:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:03 INFO - Reading from file tmpfile_stdout 16:49:03 INFO - Current package versions: 16:49:03 INFO - blessings == 1.6 16:49:03 INFO - blobuploader == 1.2.4 16:49:03 INFO - docopt == 0.6.1 16:49:03 INFO - functools32 == 3.2.3-2 16:49:03 INFO - jsonschema == 2.5.1 16:49:03 INFO - manifestparser == 1.1 16:49:03 INFO - mozInstall == 1.12 16:49:03 INFO - mozcrash == 1.0 16:49:03 INFO - mozdebug == 0.1 16:49:03 INFO - mozdevice == 0.48 16:49:03 INFO - mozfile == 1.2 16:49:03 INFO - mozhttpd == 0.7 16:49:03 INFO - mozinfo == 0.9 16:49:03 INFO - mozleak == 0.1 16:49:03 INFO - mozlog == 3.4 16:49:03 INFO - moznetwork == 0.27 16:49:03 INFO - mozprocess == 0.23 16:49:03 INFO - mozprofile == 0.28 16:49:03 INFO - mozrunner == 6.13 16:49:03 INFO - mozscreenshot == 0.1 16:49:03 INFO - mozsystemmonitor == 0.3 16:49:03 INFO - moztest == 0.8 16:49:03 INFO - mozversion == 1.4 16:49:03 INFO - psutil == 3.1.1 16:49:03 INFO - requests == 1.2.3 16:49:03 INFO - wsgiref == 0.1.2 16:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:03 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 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:49:03 INFO - 'HOME': '/Users/cltbld', 16:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:49:03 INFO - 'LOGNAME': 'cltbld', 16:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:03 INFO - 'MOZ_NO_REMOTE': '1', 16:49:03 INFO - 'NO_EM_RESTART': '1', 16:49:03 INFO - 'PAGER': '/bin/cat', 16:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:03 INFO - 'PWD': '/builds/slave/test', 16:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:49:03 INFO - 'SHELL': '/bin/bash', 16:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:49:03 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:49:03 INFO - 'USER': 'cltbld', 16:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:03 INFO - 'XPC_FLAGS': '0x0', 16:49:03 INFO - 'XPC_SERVICE_NAME': '0', 16:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:49:04 INFO - Cleaning up... 16:49:04 INFO - Return code: 0 16:49:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ab8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa480581a40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, '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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:49:04 INFO - 'HOME': '/Users/cltbld', 16:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:49:04 INFO - 'LOGNAME': 'cltbld', 16:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:04 INFO - 'MOZ_NO_REMOTE': '1', 16:49:04 INFO - 'NO_EM_RESTART': '1', 16:49:04 INFO - 'PAGER': '/bin/cat', 16:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:04 INFO - 'PWD': '/builds/slave/test', 16:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:49:04 INFO - 'SHELL': '/bin/bash', 16:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:49:04 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:49:04 INFO - 'USER': 'cltbld', 16:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:04 INFO - 'XPC_FLAGS': '0x0', 16:49:04 INFO - 'XPC_SERVICE_NAME': '0', 16:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:49:04 INFO - Cleaning up... 16:49:04 INFO - Return code: 0 16:49:04 INFO - Running post-action listener: _resource_record_post_action 16:49:04 INFO - Running post-action listener: _start_resource_monitoring 16:49:04 INFO - Starting resource monitoring. 16:49:04 INFO - [mozharness: 2017-01-21 00:49:04.350114Z] Finished create-virtualenv step (success) 16:49:04 INFO - [mozharness: 2017-01-21 00:49:04.351106Z] Running install step. 16:49:04 INFO - Running pre-action listener: _resource_record_pre_action 16:49:04 INFO - Running main action method: install 16:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:04 INFO - Reading from file tmpfile_stdout 16:49:04 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:49:04 INFO - Reading from file tmpfile_stdout 16:49:04 INFO - Output received: 16:49:04 INFO - Usage: mozinstall [options] installer 16:49:04 INFO - Options: 16:49:04 INFO - -h, --help show this help message and exit 16:49:04 INFO - -d DEST, --destination=DEST 16:49:04 INFO - Directory to install application into. [default: 16:49:04 INFO - "/builds/slave/test"] 16:49:04 INFO - --app=APP Application being installed. [default: firefox] 16:49:04 INFO - mkdir: /builds/slave/test/build/application 16:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:49:35 INFO - Reading from file tmpfile_stdout 16:49:35 INFO - Output received: 16:49:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:49:35 INFO - Running post-action listener: _resource_record_post_action 16:49:35 INFO - [mozharness: 2017-01-21 00:49:35.778056Z] Finished install step (success) 16:49:35 INFO - [mozharness: 2017-01-21 00:49:35.778218Z] Running run-tests step. 16:49:35 INFO - Running pre-action listener: _resource_record_pre_action 16:49:35 INFO - Running main action method: run_tests 16:49:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:49:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:49:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:49:35 INFO - 2017-01-20 16:49:35.792 screenresolution[1629:7501] starting screenresolution argv=screenresolution get 16:49:35 INFO - 2017-01-20 16:49:35.795 screenresolution[1629:7501] Display 0: 1600x1200x32@60 16:49:35 INFO - 2017-01-20 16:49:35.801 screenresolution[1630:7504] starting screenresolution argv=screenresolution list 16:49:35 INFO - Available Modes on Display 0 16:49:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:49:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:49:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:49:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:49:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:49:36 INFO - Intel Iris: 16:49:36 INFO - Chipset Model: Intel Iris 16:49:36 INFO - Type: GPU 16:49:36 INFO - Bus: Built-In 16:49:36 INFO - VRAM (Dynamic, Max): 1536 MB 16:49:36 INFO - Vendor: Intel (0x8086) 16:49:36 INFO - Device ID: 0x0a2e 16:49:36 INFO - Revision ID: 0x0009 16:49:36 INFO - Displays: 16:49:36 INFO - Display: 16:49:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:49:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:49:36 INFO - Display Serial Number: 1600x1200 60 16:49:36 INFO - Main Display: Yes 16:49:36 INFO - Mirror: Off 16:49:36 INFO - Online: Yes 16:49:36 INFO - Rotation: Supported 16:49:36 INFO - Return code: 0 16:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:49:36 INFO - Python 2.7.3 16:49:36 INFO - Return code: 0 16:49:36 INFO - grabbing minidump binary from tooltool 16:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:36 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 0x1088ccd30>, '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 0x108732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088c4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:49:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:49:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:49:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:49:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:49:36 INFO - Return code: 0 16:49:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:49:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:49:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:49:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:49:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:49:36 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/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 16:49:36 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/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0328 --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 16:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6bkOd2HjUv/Render', 16:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:49:36 INFO - 'HOME': '/Users/cltbld', 16:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:49:36 INFO - 'LOGNAME': 'cltbld', 16:49:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:49:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:36 INFO - 'MOZ_NO_REMOTE': '1', 16:49:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:49:36 INFO - 'NO_EM_RESTART': '1', 16:49:36 INFO - 'PAGER': '/bin/cat', 16:49:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:36 INFO - 'PWD': '/builds/slave/test', 16:49:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:49:36 INFO - 'SHELL': '/bin/bash', 16:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U5c2ot1Rf1/Listeners', 16:49:36 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:49:36 INFO - 'USER': 'cltbld', 16:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:36 INFO - 'XPC_FLAGS': '0x0', 16:49:36 INFO - 'XPC_SERVICE_NAME': '0', 16:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:49:36 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/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 16:49:36 INFO - mozversion application_buildid: 20170120144225 16:49:36 INFO - mozversion application_changeset: ccec56819e76733f28ae7f046e4602824ddbed10 16:49:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:49:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:49:36 INFO - mozversion application_name: Firefox 16:49:36 INFO - mozversion application_remotingname: firefox-dev 16:49:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:49:36 INFO - mozversion application_vendor: Mozilla 16:49:36 INFO - mozversion application_version: 52.0a2 16:49:36 INFO - mozversion platform_buildid: 20170120144225 16:49:36 INFO - mozversion platform_changeset: ccec56819e76733f28ae7f046e4602824ddbed10 16:49:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:49:36 INFO - mozversion platform_version: 52.0a2 16:49:36 INFO - using testdate: 1484959776 16:49:36 INFO - actual date: 1484959776 16:49:36 INFO - starting webserver on 'localhost:49244' 16:49:36 INFO - SUITE-START | Running 2 tests 16:49:36 INFO - TEST-START | dromaeo_css 16:49:36 INFO - operating with platform_type : mac_ 16:49:36 INFO - Initialising browser for dromaeo_css test... 16:49:36 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmps0Ht38/profile http://localhost:49244/getInfo.html) 16:49:39 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 16:49:39 INFO - PROCESS | 1640 | colorDepth:24 16:49:39 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 16:49:39 INFO - PROCESS | 1640 | __metrics 16:49:39 INFO - PROCESS | 1640 | 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" 16:49:39 INFO - PROCESS | 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:49:40 INFO - TEST-INFO | 1640: exit 0 16:49:40 INFO - Browser initialized. 16:49:40 INFO - Running cycle 1/1 for dromaeo_css test... 16:49:40 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmps0Ht38/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:52 INFO - PROCESS | 1642 | RSS: Main: 222142464 16:49:52 INFO - PROCESS | 1642 | 16:52:55 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 16:52:57 INFO - PROCESS | 1642 | RSS: Main: 373211136 16:52:57 INFO - PROCESS | 1642 | 16:56:00 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 16:56:01 INFO - PROCESS | 1642 | RSS: Main: 348364800 16:56:01 INFO - PROCESS | 1642 | 16:59:03 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 16:59:04 INFO - PROCESS | 1642 | RSS: Main: 323866624 16:59:04 INFO - PROCESS | 1642 | 17:02:06 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 17:02:07 INFO - PROCESS | 1642 | RSS: Main: 331022336 17:02:07 INFO - PROCESS | 1642 | 17:05:10 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 17:05:11 INFO - PROCESS | 1642 | RSS: Main: 305319936 17:05:11 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 17:08:14 INFO - PROCESS | 1642 | RSS: Main: 356507648 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | __start_tp_report 17:08:14 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 17:08:14 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 17:08:14 INFO - PROCESS | 1642 | |i|pagename|runs| 17:08:14 INFO - PROCESS | 1642 | |0;dojo.html;2602.713701492836;3015.6531998820133;3358.6305506394306;3380.661933806621;3399.9830000849993;5680.659160450376;5680.9431905680985;5735.799247026355;5760.36635970043;5768.1059435787465;4497.415336006315;5786.56600754944;5793.797217097403;5798.420157984199;5799.391063938278;5219.191025391061;5226.947730522684;5259.921101183485;5263.868403289929;5302.390225124122;5151.742412879341;5164.1995490699;5175.482451754813;5312.4687531246955;5354.22363757255;5201.68789872607;5228.346456692913;5257.211418287268;5276.050310944029;5280.471952804727;5257.1588545832865;5302.628815982883;5305.0450918834595;5310.681359118426;5318.335208098988;5145;5172.482751724835;5253.658512196695;5275;5277.023750606112;5618.971905140489;5646.915296270559;5682.914756278659;5684.062129748587;5740.13897915316;6214.596051256699;6256.78101266458;6257.780977665805;6264.248290205159;6316.115743795872;6355.586886852339;6359.586626869239;6365.2998170201245;6373.490120790326;6376.808695739135;5636.661800291955;5690.658560486384;5747.195392645033;5818.359980402152;5824.417558244227;6292.354788931379;6311;6318.936810631835;6353.841153971095;6365.172527571386;6197.752089916353;6210.068489726577;6220.098085777628;6220.315765265817;6223.253209614784;6158.876822463526;6211.534134939898;6214.9689251553455;6280.905786413116;6281;6218.347073557211;6263.060540918898;6279.309275979638;6279.529035322278;6303.684815759194;6233.376662333821;6282.685865706696;6284.4344009039405;6305.968470157712;6322.4942004639515;4849.2726091086615;4873.975630121898;4883.853484395474;4888.780004899788;4983.476734942851;4406.889827754332;4455.933161002587;4455.977720111378;4474.530174331713;4534.047849951481;5797.36229014808;5809.8547536311935;5810.912836307459;5811.535077193815;5822.388649191858;6127.234095738033;6320.525960552977;6348;6351.269603995507;6359.300476947532;5693.800716974886;5731.111677689964;5762.596618236767;5776.797812076557;5790;5447;5461.044317244467;5484.7531861066345;5489.451054894478;5513.3108361454815;6315.147455093595;6329.050642403584;6330.430261276507;6340.334264902119;6348.460380867493;6043.607165534227;6135.385782596223;6197.101420294122;6277.12120303167;6327.050942358683;5608.158776183605;6062.575294805629;6311.368863113652;6312.242530896322;6331.588446750947;6236.781712640036;6248.4376406123665;6250.812475625738;6252.718627661857;6277.340879207617;6117.64471673804;6231.594946328474;6242.282137554058;6329.145565348619;6338.271098823694;5962.522998160223;5991.730372133177;6073.240844894388;6119.938800611937;6134.631922084689;5960.0761881908375;5979.940200598112;6144.8771024580155;6159.384061593805;6180.196574445294;5940.405959404198;5960.165576819162;5982.58121931478;5996.37038110992;5998.49012833914;5908.172855800278;5975.103734439695;5981.910271346021;6049.939500604937;6057.606255593372;5957.523398128053;5977.641341519523;5988.520918326611;6006.699665016819;6025.698715064142 17:08:14 INFO - PROCESS | 1642 | |1;ext.html;471.9669623126378;498.8852563910303;509.8980203959208;511.468073203868;518.5203686589904;27120.457590848197;31118;38101;39111.608883911154;39209.21581568374;40404.79797601015;40755.59244407555;40759.38860917081;40802;40853.59146408535;9242.76893077675;9399.718008459757;9411.247100231965;9419.764505887339;9420.387674801115;7044.330788575103;8404.453710508797;9133.949595796503;10933.617323393682;11291.887081129165;11122.833157502644;11195.608153714622;11203.04774094203;11233.438328083605;11247.381394023325;11131.443427828617;11213.775724485546;11225.326480411202;11243.83134252987;11247.887521124765;11115.83326250107;11196.888031119748;11204.15968802343;11210.887891121147;11212.215144939857;38353.808230958944;38653.613463865564;38655.806720966495;38680;38759.61240387588;3279;3356.664333566648;3414.4878268259713;3589.228315912065;3800.0879788850752;27949.441011179664;28059.85970070157;29419.41161176786;29789.95735149281;29999.400011999638;2825;3143.858526366319;3162.177833763215;3165.208697825544;3223.2103134731906;449057;451776;453211.7339413315;453775;458306;32704.018879433654;33629.15927101842;55952.44047559554;56411;56625;34742.65257347394;34963.82518087393;34993;34996;35027.649723502436;14124.50564230247;14259.857401426061;14263.215523146326;14287.357068931715;14290;12002.519899203933;12083.758324833454;12090.455929483194;12103.636890893287;12125.39373031345;7235.8552828944175;7402.925970740332;7415;7537.886931696029;7780;3188.6811318867926;3202.871885124569;3203.0711093783007;3232.8383580820864;3271.754618403629;881.9382643215042;978.5400861595039;1001.5943542865151;1004.50779118233;1082.5236895765838;27759.306017349325;29560.260993475335;29578.704212958026;29613.407731845244;29952.700472995428;866.8439680857506;1008.8083264179783;1054.0618849224197;1063.691529456449;1081.4700796609604;14532.418703251962;14979.850201497846;15049.54851354461;15345.156016418981;15381.07713537169;609406;611197;614719;624423;634396.968090958;42802.57197428048;44308;46263.612091637304;55674;55740.72129639326;1334.166146158651;1339.2567125245582;1369.233229391544;1370.4518192722792;1377.2562816079205;28755.856220718764;29583.112506623977;29999.70000299969;30529;30593.694063059975;47961;48563;48566.757166213945;48617;48735.02529949452;556871;569016;570300;571700;573157;20987.370378888656;24741.50516989686;24768.133115340876;25776.355591109623;25880.870595646902;44122.11755764931;44423.333649995926;44516.10967780691;44767;44792.55207448014;36497.452538211415;36633.900982970554;37058.8147059263;37059.44410833894;37286.25427491489;30424.69575304307;36223.818880905426;37118.44322335221;37155.814220928725;37470.43794343142;36019.81990090138;36499;36975.63024369722;37175.25649487049;37215.81392093131;31776.36447271088;33127.00618981435;33761;33795;33888.66111338855;22258.109675612795;24871.378215544755;24955.87522062378;25182.866770995715;25471.490570188864 17:08:14 INFO - PROCESS | 1642 | |2;jquery.html;352.25322316688624;373.94016957286834;379.4933763425826;384.5961740172819;404.9939250911237;11597.942010289948;14224;15124.546263612081;18968.810311896876;19374.903125484354;18066.4580062598;19691.901540492312;20164;20356.592868142627;20367.490812729688;5638.520725738307;5973.4623883850445;5981.1028345748055;5981.28224613047;5991.310999235078;5640.661560306375;5874.118882167688;5895.587308888379;5927.970360148193;5937.970310148443;5866.794662186824;5870.618409803371;5886.4113588641;5891;5897.528197744192;5556.527695145917;5751.539876809887;5793.986052440827;5848.327442344143;5854.238948936653;4880.902381952341;5128.589712822965;5138.897222055538;5142.7685754140775;5149.150390185615;25095.62356564653;25268.494630107478;25348.239552813444;25693.972241110332;25761.227163185133;2205.63607004844;2349.4009027698;2431.197704757426;2453.092355828355;2454.312792418126;9674.467904265262;10301.484925753683;10533.631322903662;13459.057865949388;14298.428062877472;1830.7436958825774;1836.9081545922784;1857.7120546315343;1881.1158755384947;1893.2033997947435;116326;118227.40886295514;122451.38774306161;123945.38027309805;126041.10938335932;10160.4919754012;10588.364698118137;11241.325520468798;11734.765304693858;11767.588134415426;14598.124112553282;14634.780478292834;14972.925135374253;15011.549653510412;15038.32327545263;8362.958185209034;8472.364572657076;8566.443181193203;8641.524716140548;8718.956405217934;8190.8771368429525;8295.875561866576;8299.419040667217;8300.543470109202;8454.112318206622;4489;4543;4549.567791059911;4649.907001859944;4659.2312268476;1865.0066643038;1921.7213504041836;1933.3136736458637;1950.561123747174;1977.4166620846884;798.5607915646372;799.6641410607559;878.5519385113638;948.8671585977969;965.8840939087354;19819;21268.950139855257;21344.78655213428;21406.357809265748;21458.78541214599;874.6239117179547;926.3839546701369;980.7057882635181;981.7300242433388;1030.3663247103127;10578;10793.190510711727;11058.889411105785;11123.499442525106;11144.164187685794;589515;601264;601700;609141.7714557172;611571;72809.6359518199;118877;130035.69964300236;130322.34838825745;134601.65398346088;948.2935213266161;953.0564740906452;986.9506524673737;988.461288597716;989.3124278626285;17939.5515112118;18103.909480452512;18444.446666600023;18450.630987380446;18512.259509619464;53635.73182134065;55529;55621;56818;56959;75051.87422188562;76361.85457218258;80142;80432;80592.59703701679;6860.108185935796;7783.961080194563;7859.921400786147;8127.634256458356;8160.347172226089;12356.196847204903;12456.937715311366;12483;12600.243985360908;12809.359532023547;10624.893751062391;10775.625206070768;10937.234393592691;10989.890101098887;11118.277311974696;10607;10717.624883129365;10837.566497340333;10900.563977440814;10939.781204376028;9154.496502692416;9671.742673452407;10850.620228291971;11147.331160130418;11309.773804524028;7899.763007109796;7926.960365198137;8071.717489887826;8153.470024448392;8208.712695055645;8143.389245806707;10379.84430233532;10700;11010.229283950046;11104.389258590532 17:08:14 INFO - PROCESS | 1642 | |3;mootools.html;1303.0683061610946;1444.2634256529172;1469.7354476194287;1622.4402581109514;1821.1167583721901;7504.198992241863;7928.484648497851;7928.920710792898;7935.484193527417;7938.48399854009;7752.651130699118;7857.096433910102;8244.958775206116;8487;8502.574871256444;2303.7465878753324;2332.8017118544944;2333.055112679359;2338.2985104468676;2338.976610233893;2317.9536409271805;2351.9647205291935;2364.4679947011955;2375.287413775869;2379.6430535419654;2279.2706333973133;2289.53064621753;2306.2965795432387;2308.53829234153;2314.0396735354893;2287.0508738873345;2291.3698732848434;2315.5947709150832;2318.0611852199886;2326.4067662745892;2315.1549684365255;2330.8368414211013;2337.263761915008;2338.941526461835;2343.906243750248;8280.378971577096;8470.152984701543;8476.618552165106;8483.703070392507;8489.575521223976;5021.723805190713;5074.13739664258;5244.659097158673;5251.711155886424;5257.7108259045735;3469.340825243221;3561.269939662389;3567.2152126532123;3571.6785489305826;3573.6962358199585;1052.921030922684;1069.502681253221;1103.426218366453;1103.6523495099018;1103.9116870650328;10925.399103049409;11007.669769906915;11020.393878336688;11035.337879727242;11079.335239885551;4375.453068366454;4487.551244875486;4525.434320709911;4535.682502224879;4535.750533720677;8767.912320876709;8769.298456123495;8772.254358379481;8788.516631585324;8791.208791208694;5095.0574143783515;5104.4895510449405;5106.361704786902;5107.131787596118;5107.540321371094;4003.739756915791;4109.3425051991535;4406.27296496081;4682;4737.3841400618385;3650.2699460108083;3664.4686520454916;3757.56787969387;3770.0951771574623;3772.1135533149686;972.4748635736623;1120.4061847220985;1136.664683918246;1148.4257871064467;1152.913531485142;808.321010351296;819.2913130142502;879.3624622149018;880.1022956584249;906.5240748607034;5485.725713714299;5600.971995140079;5649.209110724501;5677.545796336283;5884.411558844081;947.9336446448682;970.4080510888352;984.2519685039422;1001.7495626093477;1001.8847832499356;3317.6848199421015;3622.8188590570367;3655.908602284911;3674.173311005056;3772.6981841452616;9807.607695692235;10304.12414944723;10305.639302624371;10310.381377117397;10315.690529283984;9965.55155018026;10074.345167564084;10105.040021197974;10173.135283500837;10192.898071019343;7475.215102414277;7829.64766585505;7839.843203135905;7968.521888686697;7993.120756716757;5505.366882808528;5592;5653.660780353192;5703.657780533182;5880.529557635465;8312.25189732927;8956.641734330553;9328.160465558132;9502.85745713801;9510.667126650535;7452.956586077845;8076.27313541784;9682.854757178507;9711.3202075854;9712.223022158352;6935.757248496278;7081.539699919489;7223.2776722329445;7273.418126549969;7277.745278915212;7877.369810415038;8038.115807261313;8042.758717238258;8056.476329038594;8064.15326390744;7049.330313620198;7154.67803948834;7169.139703235436;7173.892391614234;7308.415326773739;7048.189458212166;7084.752033678797;7085.716571337089;7099.929000709927;7102.431805455654;6622.569532980341;6686.565373250918;6689.933100668931;6761.830954226184;6762.053312536347;4822.180229361087;4841.467438581823;4869.732164730974;4879.194932836042;4905.288733133747;4781.258904869751;4799.856004319876;4882.92675609859;4976.850694479172;4993.925091123563 17:08:14 INFO - PROCESS | 1642 | |4;prototype.html;249.56700125282632;294.17923992062146;304.72574682785495;308.8640997960897;312.2334668389102;4471.473617406164;4660.627149828014;4915.238138088602;5104.285400043992;5162.767675454605;4753.429588449382;4870.269459581064;4914.483979182188;4927.2855435961765;5164;3861.903452413684;3875.360565506688;3889.4943657324648;3889.8994542946775;3923.5684074751753;3841.5390153181656;3859.749116307445;3864.85014713008;3896.1103864625634;3900.4929359183407;3719.753882449369;3869.148787266811;3873.1479074603544;3884.9417258741;3895.9351543681896;3413.9317213655713;3858.864939727096;3861.691064714816;3908.355121404965;3925.1953349563414;2936.8546266955905;3213.4215841148584;3367.3433680432327;3374.4263475209273;3408.352413041514;4916.532929371704;4934.284528743348;4946.3817022872145;4957.851264462036;4967.627427942883;4004.619561141687;4051.858184963512;4111.8972025699295;4272.829086836523;4450.688451808374;4362.498312694017;4373.737575745434;4639.628829693616;5320.707361095138;5332.92000619991;3717.275131349388;3729.1727053743743;3729.6829769469628;3738.3084129436143;3767.4193177673105;4707.952920470786;5322.939309896786;5470.56235501159;5475.6440831345835;5518.613697041209;3476.8261586920553;3762.0030691866677;3762.793046382475;3764.6235376462682;3764.8705388383923;3822.1591249924973;3829.5787463379006;3829.8744196970392;3848.615138486185;3859.1895701902354;3588.659077387644;3781.489498917611;4295.291276939332;4401.6478681705385;4434.5343738907595;4821.7589120543835;4900.877478063006;5152.510511501401;5298.390685071189;5311.787528498894;1188.294796966356;1196.2702751321688;1234.4259919137464;1245.9439325230387;1264.5510843650557;804.9919500805034;819.3281509162549;831.2477208126655;850.965961361551;870.3515880668815;4677.555632214934;4685.765711714401;4699.553542413465;4731.455882573479;4740.45484769249;4447.264297989705;4480.9103817924115;5157.369741431897;5204.297419848348;5231.659942103751;4143.606357396043;4177.164567086595;4599.08018396322;4622.659428765687;4633.590532922929;2242.3048854855047;2359.3484560807506;2686.408990022192;2711.5119278530055;2760.7239276072232;4740.70520987917;4887.238710128766;4986.4514903360605;5329.307190065267;5336.252924590561;4467.910641787146;4556.67609519141;4720.811167553259;4938.678985865908;5282.31329927107;4215.430916826251;4240;4748.287756836433;5193.948060519422;5196.558292545176;4348.412964249786;5016;5055.646104772631;5056.115179843439;5063.316452278895;4272.38050482672;4347.869533935562;4815.398075240595;4992.525710057539;5205.271262023244;4415.624671902924;4601.493835678006;4855.077535268288;5184.351956005499;5184.896302074013;3556.7154627630243;3577.373959557119;3587.959491747364;3635.927281454409;3659.432787917877;4302.569743025798;4518.457785065813;5046.4701206374275;5048.72232027242;5163.509466600667;4815.398075240595;5219.799446127336;5330.307060082165;5346.278252436027;5365.168398898177;5306.97346513265;5365.7048862311385;5385.791825351587;5386.8383948481605;5387.407385187705;3945.270125026879;4891.706497610155;5127.974360128175;5222.29499017643;5344.278522399582;4969.676970996874;5106.591472682251;5110.948890511196;5177.792888284426;5343.385510666323;4352.825886964486;5217.452167522356;5218.8956220876125;5222.529972302511;5263.631455821437 17:08:14 INFO - PROCESS | 1642 | |5;yui.html;725.981850453739;742.4728442805612;755.5882044285863;784.5528049012064;803.0724513187271;14402;14554.345054472547;14599.78100328496;14621.78067328991;14769.409223631055;12914.354282285894;12975.286359250238;12984.28586427746;12997.935010324958;13024.804627930589;639.3318981664149;664.717495064598;795.387551585279;796.5141263829059;824.8432797768435;823.2467292427451;839.1314988986401;839.5382539603224;839.7858546070744;840.3781201910604;850.9234168924795;853.5988085599789;854.5001174313035;855.3883972959333;855.4653341661461;587.7707693999322;603.3966033966034;679.4021261290058;704.9541779784298;706.9893951590731;613.6471528870873;634.4385219081147;637.9649119298437;638.00152760929;638.6678926958002;14066.648333791634;14071.929640351835;14092.788608170886;14121.717565648732;14122.22327771972;10062.849057264148;12522.81215781764;12635.1787133836;12644.367781610974;12770.80843787344;11878.465469053826;12025.158238923279;12099.213551119148;12123.878761212363;12157.331346775924;4217.093324935123;4244.405783190356;4280.443542339507;4364.105358401552;4462.219111655448;84324;86618;87995;88967;89631.55184224037;9506.287028472892;10014.499275036365;10201.642942496977;10203.38779673222;10240.129588984872;19001.714974275397;19016.619667606847;19026.904865475582;19039.90480047591;19043;6641.535092543572;6875.209350924608;6889.586624802528;6899.413549848218;7055.2239253682055;3593.8921832345072;4295.52749197588;4334.609885110292;4374.58441448062;4375.606195442362;3170.936581268362;3204.1669166017004;3271.689189526991;3280.048785852076;3285.901422957315;627.7802769030802;668.2749217099405;680.6766785776716;681.1655721740827;692.8891377379595;572.1989215098895;638.5370606310481;646.7639311651213;647.6955830759536;661.8682053688151;8350.33197344211;8677.262432693291;8834;8880.555972201364;8953.59708813105;570.7574280930588;592.6503363015842;609.6045029187384;625.2965413909352;650.0703993289546;4197.370394440797;4211.873643790691;4406.223591986915;4534.45586529612;4551.47658019332;62628.68685656634;110368;113354;114410.42794786139;114439;93986;96788;97006;98826;102471;50731.999999999265;51875.48124518707;86439;88258;89659.10340896508;9201.861972070557;9554.665586704432;9647.565859536197;9663;9679.370840895319;50295.49704502908;51053.234201486266;51355.972880542926;52681;54722;63816;72938;76911;77484.61257693675;77994.4401111986;11830.46762895689;12092.939535302266;12209.938950305192;12289;12813;12988.870111299144;13703.520376786764;14448;14627.853721462649;14949.005774529536;12204.962578180599;12226;12919;13129.868701312864;13327.466901323838;11191.32852028881;12796.61610151697;13349.929516211132;13711.588652340446;13851.376688049264;12205.280142852183;12767.361631918182;13331.400086995915;13375.799363009368;13595.11631743973;10798.622048228275;11154.442277886235;11278.605248816251;11493.367864767519;11587.015103716278;7494.400447964259;9136.223421009023;9582.856257156287;11199.593358183705;11208.55165793359 17:08:14 INFO - PROCESS | 1642 | __end_tp_report 17:08:14 INFO - PROCESS | 1642 | __start_cc_report 17:08:14 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1856 17:08:14 INFO - PROCESS | 1642 | __end_cc_report 17:08:14 INFO - PROCESS | 1642 | __startTimestamp1484960894910__endTimestamp 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | ------- Summary: start ------- 17:08:14 INFO - PROCESS | 1642 | Number of tests: 6 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5757.80 Median:5975.10 stddev:673.11 (11.3%) stddev-sans-first:628.02 17:08:14 INFO - PROCESS | 1642 | Values: 2602.7 3015.7 3358.6 3380.7 3400.0 5680.7 5680.9 5735.8 5760.4 5768.1 4497.4 5786.6 5793.8 5798.4 5799.4 5219.2 5226.9 5259.9 5263.9 5302.4 5151.7 5164.2 5175.5 5312.5 5354.2 5201.7 5228.3 5257.2 5276.1 5280.5 5257.2 5302.6 5305.0 5310.7 5318.3 5145.0 5172.5 5253.7 5275.0 5277.0 5619.0 5646.9 5682.9 5684.1 5740.1 6214.6 6256.8 6257.8 6264.2 6316.1 6355.6 6359.6 6365.3 6373.5 6376.8 5636.7 5690.7 5747.2 5818.4 5824.4 6292.4 6311.0 6318.9 6353.8 6365.2 6197.8 6210.1 6220.1 6220.3 6223.3 6158.9 6211.5 6215.0 6280.9 6281.0 6218.3 6263.1 6279.3 6279.5 6303.7 6233.4 6282.7 6284.4 6306.0 6322.5 4849.3 4874.0 4883.9 4888.8 4983.5 4406.9 4455.9 4456.0 4474.5 4534.0 5797.4 5809.9 5810.9 5811.5 5822.4 6127.2 6320.5 6348.0 6351.3 6359.3 5693.8 5731.1 5762.6 5776.8 5790.0 5447.0 5461.0 5484.8 5489.5 5513.3 6315.1 6329.1 6330.4 6340.3 6348.5 6043.6 6135.4 6197.1 6277.1 6327.1 5608.2 6062.6 6311.4 6312.2 6331.6 6236.8 6248.4 6250.8 6252.7 6277.3 6117.6 6231.6 6242.3 6329.1 6338.3 5962.5 5991.7 6073.2 6119.9 6134.6 5960.1 5979.9 6144.9 6159.4 6180.2 5940.4 5960.2 5982.6 5996.4 5998.5 5908.2 5975.1 5981.9 6049.9 6057.6 5957.5 5977.6 5988.5 6006.7 6025.7 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:65922.94 Median:18651.57 stddev:147582.99 (791.3%) stddev-sans-first:147915.19 17:08:14 INFO - PROCESS | 1642 | Values: 472.0 498.9 509.9 511.5 518.5 27120.5 31118.0 38101.0 39111.6 39209.2 40404.8 40755.6 40759.4 40802.0 40853.6 9242.8 9399.7 9411.2 9419.8 9420.4 7044.3 8404.5 9133.9 10933.6 11291.9 11122.8 11195.6 11203.0 11233.4 11247.4 11131.4 11213.8 11225.3 11243.8 11247.9 11115.8 11196.9 11204.2 11210.9 11212.2 38353.8 38653.6 38655.8 38680.0 38759.6 3279.0 3356.7 3414.5 3589.2 3800.1 27949.4 28059.9 29419.4 29790.0 29999.4 2825.0 3143.9 3162.2 3165.2 3223.2 449057.0 451776.0 453211.7 453775.0 458306.0 32704.0 33629.2 55952.4 56411.0 56625.0 34742.7 34963.8 34993.0 34996.0 35027.6 14124.5 14259.9 14263.2 14287.4 14290.0 12002.5 12083.8 12090.5 12103.6 12125.4 7235.9 7402.9 7415.0 7537.9 7780.0 3188.7 3202.9 3203.1 3232.8 3271.8 881.9 978.5 1001.6 1004.5 1082.5 27759.3 29560.3 29578.7 29613.4 29952.7 866.8 1008.8 1054.1 1063.7 1081.5 14532.4 14979.9 15049.5 15345.2 15381.1 609406.0 611197.0 614719.0 624423.0 634397.0 42802.6 44308.0 46263.6 55674.0 55740.7 1334.2 1339.3 1369.2 1370.5 1377.3 28755.9 29583.1 29999.7 30529.0 30593.7 47961.0 48563.0 48566.8 48617.0 48735.0 556871.0 569016.0 570300.0 571700.0 573157.0 20987.4 24741.5 24768.1 25776.4 25880.9 44122.1 44423.3 44516.1 44767.0 44792.6 36497.5 36633.9 37058.8 37059.4 37286.3 30424.7 36223.8 37118.4 37155.8 37470.4 36019.8 36499.0 36975.6 37175.3 37215.8 31776.4 33127.0 33761.0 33795.0 33888.7 22258.1 24871.4 24955.9 25182.9 25471.5 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:34848.32 Median:13056.74 stddev:100499.18 (769.7%) stddev-sans-first:100747.72 17:08:14 INFO - PROCESS | 1642 | Values: 352.3 373.9 379.5 384.6 405.0 11597.9 14224.0 15124.5 18968.8 19374.9 18066.5 19691.9 20164.0 20356.6 20367.5 5638.5 5973.5 5981.1 5981.3 5991.3 5640.7 5874.1 5895.6 5928.0 5938.0 5866.8 5870.6 5886.4 5891.0 5897.5 5556.5 5751.5 5794.0 5848.3 5854.2 4880.9 5128.6 5138.9 5142.8 5149.2 25095.6 25268.5 25348.2 25694.0 25761.2 2205.6 2349.4 2431.2 2453.1 2454.3 9674.5 10301.5 10533.6 13459.1 14298.4 1830.7 1836.9 1857.7 1881.1 1893.2 116326.0 118227.4 122451.4 123945.4 126041.1 10160.5 10588.4 11241.3 11734.8 11767.6 14598.1 14634.8 14972.9 15011.5 15038.3 8363.0 8472.4 8566.4 8641.5 8719.0 8190.9 8295.9 8299.4 8300.5 8454.1 4489.0 4543.0 4549.6 4649.9 4659.2 1865.0 1921.7 1933.3 1950.6 1977.4 798.6 799.7 878.6 948.9 965.9 19819.0 21269.0 21344.8 21406.4 21458.8 874.6 926.4 980.7 981.7 1030.4 10578.0 10793.2 11058.9 11123.5 11144.2 589515.0 601264.0 601700.0 609141.8 611571.0 72809.6 118877.0 130035.7 130322.3 134601.7 948.3 953.1 987.0 988.5 989.3 17939.6 18103.9 18444.4 18450.6 18512.3 53635.7 55529.0 55621.0 56818.0 56959.0 75051.9 76361.9 80142.0 80432.0 80592.6 6860.1 7784.0 7859.9 8127.6 8160.3 12356.2 12456.9 12483.0 12600.2 12809.4 10624.9 10775.6 10937.2 10989.9 11118.3 10607.0 10717.6 10837.6 10900.6 10939.8 9154.5 9671.7 10850.6 11147.3 11309.8 7899.8 7927.0 8071.7 8153.5 8208.7 8143.4 10379.8 10700.0 11010.2 11104.4 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5412.97 Median:5084.60 stddev:2961.39 (58.2%) stddev-sans-first:2953.59 17:08:14 INFO - PROCESS | 1642 | Values: 1303.1 1444.3 1469.7 1622.4 1821.1 7504.2 7928.5 7928.9 7935.5 7938.5 7752.7 7857.1 8245.0 8487.0 8502.6 2303.7 2332.8 2333.1 2338.3 2339.0 2318.0 2352.0 2364.5 2375.3 2379.6 2279.3 2289.5 2306.3 2308.5 2314.0 2287.1 2291.4 2315.6 2318.1 2326.4 2315.2 2330.8 2337.3 2338.9 2343.9 8280.4 8470.2 8476.6 8483.7 8489.6 5021.7 5074.1 5244.7 5251.7 5257.7 3469.3 3561.3 3567.2 3571.7 3573.7 1052.9 1069.5 1103.4 1103.7 1103.9 10925.4 11007.7 11020.4 11035.3 11079.3 4375.5 4487.6 4525.4 4535.7 4535.8 8767.9 8769.3 8772.3 8788.5 8791.2 5095.1 5104.5 5106.4 5107.1 5107.5 4003.7 4109.3 4406.3 4682.0 4737.4 3650.3 3664.5 3757.6 3770.1 3772.1 972.5 1120.4 1136.7 1148.4 1152.9 808.3 819.3 879.4 880.1 906.5 5485.7 5601.0 5649.2 5677.5 5884.4 947.9 970.4 984.3 1001.7 1001.9 3317.7 3622.8 3655.9 3674.2 3772.7 9807.6 10304.1 10305.6 10310.4 10315.7 9965.6 10074.3 10105.0 10173.1 10192.9 7475.2 7829.6 7839.8 7968.5 7993.1 5505.4 5592.0 5653.7 5703.7 5880.5 8312.3 8956.6 9328.2 9502.9 9510.7 7453.0 8076.3 9682.9 9711.3 9712.2 6935.8 7081.5 7223.3 7273.4 7277.7 7877.4 8038.1 8042.8 8056.5 8064.2 7049.3 7154.7 7169.1 7173.9 7308.4 7048.2 7084.8 7085.7 7099.9 7102.4 6622.6 6686.6 6689.9 6761.8 6762.1 4822.2 4841.5 4869.7 4879.2 4905.3 4781.3 4799.9 4882.9 4976.9 4993.9 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4174.07 Median:4612.08 stddev:1235.60 (26.8%) stddev-sans-first:1203.44 17:08:14 INFO - PROCESS | 1642 | Values: 249.6 294.2 304.7 308.9 312.2 4471.5 4660.6 4915.2 5104.3 5162.8 4753.4 4870.3 4914.5 4927.3 5164.0 3861.9 3875.4 3889.5 3889.9 3923.6 3841.5 3859.7 3864.9 3896.1 3900.5 3719.8 3869.1 3873.1 3884.9 3895.9 3413.9 3858.9 3861.7 3908.4 3925.2 2936.9 3213.4 3367.3 3374.4 3408.4 4916.5 4934.3 4946.4 4957.9 4967.6 4004.6 4051.9 4111.9 4272.8 4450.7 4362.5 4373.7 4639.6 5320.7 5332.9 3717.3 3729.2 3729.7 3738.3 3767.4 4708.0 5322.9 5470.6 5475.6 5518.6 3476.8 3762.0 3762.8 3764.6 3764.9 3822.2 3829.6 3829.9 3848.6 3859.2 3588.7 3781.5 4295.3 4401.6 4434.5 4821.8 4900.9 5152.5 5298.4 5311.8 1188.3 1196.3 1234.4 1245.9 1264.6 805.0 819.3 831.2 851.0 870.4 4677.6 4685.8 4699.6 4731.5 4740.5 4447.3 4480.9 5157.4 5204.3 5231.7 4143.6 4177.2 4599.1 4622.7 4633.6 2242.3 2359.3 2686.4 2711.5 2760.7 4740.7 4887.2 4986.5 5329.3 5336.3 4467.9 4556.7 4720.8 4938.7 5282.3 4215.4 4240.0 4748.3 5193.9 5196.6 4348.4 5016.0 5055.6 5056.1 5063.3 4272.4 4347.9 4815.4 4992.5 5205.3 4415.6 4601.5 4855.1 5184.4 5184.9 3556.7 3577.4 3588.0 3635.9 3659.4 4302.6 4518.5 5046.5 5048.7 5163.5 4815.4 5219.8 5330.3 5346.3 5365.2 5307.0 5365.7 5385.8 5386.8 5387.4 3945.3 4891.7 5128.0 5222.3 5344.3 4969.7 5106.6 5110.9 5177.8 5343.4 4352.8 5217.5 5218.9 5222.5 5263.6 17:08:14 INFO - PROCESS | 1642 | 17:08:14 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19899.37 Median:27423.49 stddev:29240.17 (106.6%) stddev-sans-first:29286.75 17:08:14 INFO - PROCESS | 1642 | Values: 726.0 742.5 755.6 784.6 803.1 14402.0 14554.3 14599.8 14621.8 14769.4 12914.4 12975.3 12984.3 12997.9 13024.8 639.3 664.7 795.4 796.5 824.8 823.2 839.1 839.5 839.8 840.4 850.9 853.6 854.5 855.4 855.5 587.8 603.4 679.4 705.0 707.0 613.6 634.4 638.0 638.0 638.7 14066.6 14071.9 14092.8 14121.7 14122.2 10062.8 12522.8 12635.2 12644.4 12770.8 11878.5 12025.2 12099.2 12123.9 12157.3 4217.1 4244.4 4280.4 4364.1 4462.2 84324.0 86618.0 87995.0 88967.0 89631.6 9506.3 10014.5 10201.6 10203.4 10240.1 19001.7 19016.6 19026.9 19039.9 19043.0 6641.5 6875.2 6889.6 6899.4 7055.2 3593.9 4295.5 4334.6 4374.6 4375.6 3170.9 3204.2 3271.7 3280.0 3285.9 627.8 668.3 680.7 681.2 692.9 572.2 638.5 646.8 647.7 661.9 8350.3 8677.3 8834.0 8880.6 8953.6 570.8 592.7 609.6 625.3 650.1 4197.4 4211.9 4406.2 4534.5 4551.5 62628.7 110368.0 113354.0 114410.4 114439.0 93986.0 96788.0 97006.0 98826.0 102471.0 50732.0 51875.5 86439.0 88258.0 89659.1 9201.9 9554.7 9647.6 9663.0 9679.4 50295.5 51053.2 51356.0 52681.0 54722.0 63816.0 72938.0 76911.0 77484.6 77994.4 11830.5 12092.9 12209.9 12289.0 12813.0 12988.9 13703.5 14448.0 14627.9 14949.0 12205.0 12226.0 12919.0 13129.9 13327.5 11191.3 12796.6 13349.9 13711.6 13851.4 12205.3 12767.4 13331.4 13375.8 13595.1 10798.6 11154.4 11278.6 11493.4 11587.0 7494.4 9136.2 9582.9 11199.6 11208.6 17:08:14 INFO - PROCESS | 1642 | -------- Summary: end -------- 17:08:14 INFO - PROCESS | 1642 | 17:08:15 INFO - TEST-INFO | 1642: exit 0 17:08:15 INFO - TEST-OK | dromaeo_css | took 1119309ms 17:08:15 INFO - TEST-START | kraken 17:08:15 INFO - operating with platform_type : mac_ 17:08:15 INFO - Initialising browser for kraken test... 17:08:15 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpWxPkPg/profile http://localhost:49244/getInfo.html) 17:08:18 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 17:08:18 INFO - PROCESS | 1651 | colorDepth:24 17:08:18 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 17:08:18 INFO - PROCESS | 1651 | __metrics 17:08:18 INFO - PROCESS | 1651 | 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" 17:08:18 INFO - PROCESS | 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:19 INFO - TEST-INFO | 1651: exit 0 17:08:19 INFO - Browser initialized. 17:08:19 INFO - Running cycle 1/1 for kraken test... 17:08:19 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpWxPkPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:31 INFO - PROCESS | 1652 | RSS: Main: 222572544 17:08:31 INFO - PROCESS | 1652 | 17:08:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 17:08:35 INFO - PROCESS | 1652 | RSS: Main: 272269312 17:08:35 INFO - PROCESS | 1652 | 17:08:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 17:08:38 INFO - PROCESS | 1652 | RSS: Main: 283828224 17:08:38 INFO - PROCESS | 1652 | 17:08:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 17:08:42 INFO - PROCESS | 1652 | RSS: Main: 379772928 17:08:42 INFO - PROCESS | 1652 | 17:08:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 17:08:45 INFO - PROCESS | 1652 | RSS: Main: 281698304 17:08:45 INFO - PROCESS | 1652 | 17:08:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:47 INFO - PROCESS | 1652 | RSS: Main: 282935296 17:08:47 INFO - PROCESS | 1652 | 17:08:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:51 INFO - PROCESS | 1652 | RSS: Main: 324165632 17:08:51 INFO - PROCESS | 1652 | 17:08:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 17:08:54 INFO - PROCESS | 1652 | RSS: Main: 325840896 17:08:54 INFO - PROCESS | 1652 | 17:08:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 17:08:57 INFO - PROCESS | 1652 | RSS: Main: 325382144 17:08:57 INFO - PROCESS | 1652 | 17:08:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:00 INFO - PROCESS | 1652 | RSS: Main: 299450368 17:09:00 INFO - PROCESS | 1652 | 17:09:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:02 INFO - PROCESS | 1652 | RSS: Main: 303890432 17:09:02 INFO - PROCESS | 1652 | 17:09:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:05 INFO - PROCESS | 1652 | RSS: Main: 305958912 17:09:05 INFO - PROCESS | 1652 | 17:09:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:09 INFO - PROCESS | 1652 | RSS: Main: 314183680 17:09:09 INFO - PROCESS | 1652 | 17:09:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:12 INFO - PROCESS | 1652 | RSS: Main: 314597376 17:09:12 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 17:09:14 INFO - PROCESS | 1652 | RSS: Main: 357720064 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | __start_tp_report 17:09:14 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 17:09:14 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 17:09:14 INFO - PROCESS | 1652 | |i|pagename|runs| 17:09:14 INFO - PROCESS | 1652 | |0;ai-astar;114;114;113;117;163;166;114;113;115;113 17:09:14 INFO - PROCESS | 1652 | |1;audio-beat-detection;155;138;137;145;109;111;114;109;140;127 17:09:14 INFO - PROCESS | 1652 | |2;audio-dft;186;183;188;181;182;184;182;185;181;181 17:09:14 INFO - PROCESS | 1652 | |3;audio-fft;82;59;60;98;52;61;78;81;107;80 17:09:14 INFO - PROCESS | 1652 | |4;audio-oscillator;87;70;92;68;67;69;116;94;96;74 17:09:14 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;84;87;85;89;85;89;85;87;85 17:09:14 INFO - PROCESS | 1652 | |6;imaging-darkroom;96;95;95;95;95;97;96;96;96;95 17:09:14 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;81;78;79;81;82;83;85;83;84 17:09:14 INFO - PROCESS | 1652 | |8;json-parse-financial;56;54;54;54;57;58;57;57;57;57 17:09:14 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;65;66;80;75;73;69;94;101;101;76 17:09:14 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;85;84;86;85;83;82;81;83;85;85 17:09:14 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;137;139;140;139;139;138;144;141;177;144 17:09:14 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;169;164;170;222;206;164;165;162;173;163 17:09:14 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;68;66;66;67;67;66;69;67;67 17:09:14 INFO - PROCESS | 1652 | __end_tp_report 17:09:14 INFO - PROCESS | 1652 | __start_cc_report 17:09:14 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1960 17:09:14 INFO - PROCESS | 1652 | __end_cc_report 17:09:14 INFO - PROCESS | 1652 | __startTimestamp1484960954673__endTimestamp 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | ------- Summary: start ------- 17:09:14 INFO - PROCESS | 1652 | Number of tests: 14 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:124.20 Median:114.50 stddev:21.29 (18.6%) stddev-sans-first:22.25 17:09:14 INFO - PROCESS | 1652 | Values: 114.0 114.0 113.0 117.0 163.0 166.0 114.0 113.0 115.0 113.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:137.50 stddev:16.83 (12.2%) stddev-sans-first:14.87 17:09:14 INFO - PROCESS | 1652 | Values: 155.0 138.0 137.0 145.0 109.0 111.0 114.0 109.0 140.0 127.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:2.41 (1.3%) stddev-sans-first:2.35 17:09:14 INFO - PROCESS | 1652 | Values: 186.0 183.0 188.0 181.0 182.0 184.0 182.0 185.0 181.0 181.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:75.80 Median:79.00 stddev:17.86 (22.6%) stddev-sans-first:18.80 17:09:14 INFO - PROCESS | 1652 | Values: 82.0 59.0 60.0 98.0 52.0 61.0 78.0 81.0 107.0 80.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:80.50 stddev:16.34 (20.3%) stddev-sans-first:17.27 17:09:14 INFO - PROCESS | 1652 | Values: 87.0 70.0 92.0 68.0 67.0 69.0 116.0 94.0 96.0 74.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.77 (2.0%) stddev-sans-first:1.86 17:09:14 INFO - PROCESS | 1652 | Values: 87.0 84.0 87.0 85.0 89.0 85.0 89.0 85.0 87.0 85.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 17:09:14 INFO - PROCESS | 1652 | Values: 96.0 95.0 95.0 95.0 95.0 97.0 96.0 96.0 96.0 95.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:82.00 Median:83.00 stddev:2.26 (2.7%) stddev-sans-first:2.28 17:09:14 INFO - PROCESS | 1652 | Values: 84.0 81.0 78.0 79.0 81.0 82.0 83.0 85.0 83.0 84.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:1.52 (2.7%) stddev-sans-first:1.62 17:09:14 INFO - PROCESS | 1652 | Values: 56.0 54.0 54.0 54.0 57.0 58.0 57.0 57.0 57.0 57.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:74.00 stddev:13.78 (18.6%) stddev-sans-first:13.51 17:09:14 INFO - PROCESS | 1652 | Values: 65.0 66.0 80.0 75.0 73.0 69.0 94.0 101.0 101.0 76.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:85.00 stddev:1.60 (1.9%) stddev-sans-first:1.64 17:09:14 INFO - PROCESS | 1652 | Values: 85.0 84.0 86.0 85.0 83.0 82.0 81.0 83.0 85.0 85.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:140.50 stddev:11.90 (8.5%) stddev-sans-first:12.36 17:09:14 INFO - PROCESS | 1652 | Values: 137.0 139.0 140.0 139.0 139.0 138.0 144.0 141.0 177.0 144.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:169.50 stddev:20.77 (12.3%) stddev-sans-first:21.89 17:09:14 INFO - PROCESS | 1652 | Values: 169.0 164.0 170.0 222.0 206.0 164.0 165.0 162.0 173.0 163.0 17:09:14 INFO - PROCESS | 1652 | 17:09:14 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 17:09:14 INFO - PROCESS | 1652 | Values: 68.0 68.0 66.0 66.0 67.0 67.0 66.0 69.0 67.0 67.0 17:09:14 INFO - PROCESS | 1652 | -------- Summary: end -------- 17:09:14 INFO - PROCESS | 1652 | 17:09:15 INFO - TEST-INFO | 1652: exit 0 17:09:15 INFO - TEST-OK | kraken | took 60043ms 17:09:15 INFO - SUITE-END | took 1179s 17:09:15 INFO - Completed test suite (00:19:39) 17:09:15 INFO - javascript benchmark 17:09:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.713701492836, 3015.6531998820133, 3358.6305506394306, 3380.661933806621, 3399.9830000849993, 5680.659160450376, 5680.9431905680985, 5735.799247026355, 5760.36635970043, 5768.1059435787465, 4497.415336006315, 5786.56600754944, 5793.797217097403, 5798.420157984199, 5799.391063938278, 5219.191025391061, 5226.947730522684, 5259.921101183485, 5263.868403289929, 5302.390225124122, 5151.742412879341, 5164.1995490699, 5175.482451754813, 5312.4687531246955, 5354.22363757255, 5201.68789872607, 5228.346456692913, 5257.211418287268, 5276.050310944029, 5280.471952804727, 5257.1588545832865, 5302.628815982883, 5305.0450918834595, 5310.681359118426, 5318.335208098988, 5145.0, 5172.482751724835, 5253.658512196695, 5275.0, 5277.023750606112, 5618.971905140489, 5646.915296270559, 5682.914756278659, 5684.062129748587, 5740.13897915316, 6214.596051256699, 6256.78101266458, 6257.780977665805, 6264.248290205159, 6316.115743795872, 6355.586886852339, 6359.586626869239, 6365.2998170201245, 6373.490120790326, 6376.808695739135, 5636.661800291955, 5690.658560486384, 5747.195392645033, 5818.359980402152, 5824.417558244227, 6292.354788931379, 6311.0, 6318.936810631835, 6353.841153971095, 6365.172527571386, 6197.752089916353, 6210.068489726577, 6220.098085777628, 6220.315765265817, 6223.253209614784, 6158.876822463526, 6211.534134939898, 6214.9689251553455, 6280.905786413116, 6281.0, 6218.347073557211, 6263.060540918898, 6279.309275979638, 6279.529035322278, 6303.684815759194, 6233.376662333821, 6282.685865706696, 6284.4344009039405, 6305.968470157712, 6322.4942004639515, 4849.2726091086615, 4873.975630121898, 4883.853484395474, 4888.780004899788, 4983.476734942851, 4406.889827754332, 4455.933161002587, 4455.977720111378, 4474.530174331713, 4534.047849951481, 5797.36229014808, 5809.8547536311935, 5810.912836307459, 5811.535077193815, 5822.388649191858, 6127.234095738033, 6320.525960552977, 6348.0, 6351.269603995507, 6359.300476947532, 5693.800716974886, 5731.111677689964, 5762.596618236767, 5776.797812076557, 5790.0, 5447.0, 5461.044317244467, 5484.7531861066345, 5489.451054894478, 5513.3108361454815, 6315.147455093595, 6329.050642403584, 6330.430261276507, 6340.334264902119, 6348.460380867493, 6043.607165534227, 6135.385782596223, 6197.101420294122, 6277.12120303167, 6327.050942358683, 5608.158776183605, 6062.575294805629, 6311.368863113652, 6312.242530896322, 6331.588446750947, 6236.781712640036, 6248.4376406123665, 6250.812475625738, 6252.718627661857, 6277.340879207617, 6117.64471673804, 6231.594946328474, 6242.282137554058, 6329.145565348619, 6338.271098823694, 5962.522998160223, 5991.730372133177, 6073.240844894388, 6119.938800611937, 6134.631922084689, 5960.0761881908375, 5979.940200598112, 6144.8771024580155, 6159.384061593805, 6180.196574445294, 5940.405959404198, 5960.165576819162, 5982.58121931478, 5996.37038110992, 5998.49012833914, 5908.172855800278, 5975.103734439695, 5981.910271346021, 6049.939500604937, 6057.606255593372, 5957.523398128053, 5977.641341519523, 5988.520918326611, 6006.699665016819, 6025.698715064142], "value": 5711.240442966163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.9669623126378, 498.8852563910303, 509.8980203959208, 511.468073203868, 518.5203686589904, 27120.457590848197, 31118.0, 38101.0, 39111.608883911154, 39209.21581568374, 40404.79797601015, 40755.59244407555, 40759.38860917081, 40802.0, 40853.59146408535, 9242.76893077675, 9399.718008459757, 9411.247100231965, 9419.764505887339, 9420.387674801115, 7044.330788575103, 8404.453710508797, 9133.949595796503, 10933.617323393682, 11291.887081129165, 11122.833157502644, 11195.608153714622, 11203.04774094203, 11233.438328083605, 11247.381394023325, 11131.443427828617, 11213.775724485546, 11225.326480411202, 11243.83134252987, 11247.887521124765, 11115.83326250107, 11196.888031119748, 11204.15968802343, 11210.887891121147, 11212.215144939857, 38353.808230958944, 38653.613463865564, 38655.806720966495, 38680.0, 38759.61240387588, 3279.0, 3356.664333566648, 3414.4878268259713, 3589.228315912065, 3800.0879788850752, 27949.441011179664, 28059.85970070157, 29419.41161176786, 29789.95735149281, 29999.400011999638, 2825.0, 3143.858526366319, 3162.177833763215, 3165.208697825544, 3223.2103134731906, 449057.0, 451776.0, 453211.7339413315, 453775.0, 458306.0, 32704.018879433654, 33629.15927101842, 55952.44047559554, 56411.0, 56625.0, 34742.65257347394, 34963.82518087393, 34993.0, 34996.0, 35027.649723502436, 14124.50564230247, 14259.857401426061, 14263.215523146326, 14287.357068931715, 14290.0, 12002.519899203933, 12083.758324833454, 12090.455929483194, 12103.636890893287, 12125.39373031345, 7235.8552828944175, 7402.925970740332, 7415.0, 7537.886931696029, 7780.0, 3188.6811318867926, 3202.871885124569, 3203.0711093783007, 3232.8383580820864, 3271.754618403629, 881.9382643215042, 978.5400861595039, 1001.5943542865151, 1004.50779118233, 1082.5236895765838, 27759.306017349325, 29560.260993475335, 29578.704212958026, 29613.407731845244, 29952.700472995428, 866.8439680857506, 1008.8083264179783, 1054.0618849224197, 1063.691529456449, 1081.4700796609604, 14532.418703251962, 14979.850201497846, 15049.54851354461, 15345.156016418981, 15381.07713537169, 609406.0, 611197.0, 614719.0, 624423.0, 634396.968090958, 42802.57197428048, 44308.0, 46263.612091637304, 55674.0, 55740.72129639326, 1334.166146158651, 1339.2567125245582, 1369.233229391544, 1370.4518192722792, 1377.2562816079205, 28755.856220718764, 29583.112506623977, 29999.70000299969, 30529.0, 30593.694063059975, 47961.0, 48563.0, 48566.757166213945, 48617.0, 48735.02529949452, 556871.0, 569016.0, 570300.0, 571700.0, 573157.0, 20987.370378888656, 24741.50516989686, 24768.133115340876, 25776.355591109623, 25880.870595646902, 44122.11755764931, 44423.333649995926, 44516.10967780691, 44767.0, 44792.55207448014, 36497.452538211415, 36633.900982970554, 37058.8147059263, 37059.44410833894, 37286.25427491489, 30424.69575304307, 36223.818880905426, 37118.44322335221, 37155.814220928725, 37470.43794343142, 36019.81990090138, 36499.0, 36975.63024369722, 37175.25649487049, 37215.81392093131, 31776.36447271088, 33127.00618981435, 33761.0, 33795.0, 33888.66111338855, 22258.109675612795, 24871.378215544755, 24955.87522062378, 25182.866770995715, 25471.490570188864], "value": 18163.64955603922, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.25322316688624, 373.94016957286834, 379.4933763425826, 384.5961740172819, 404.9939250911237, 11597.942010289948, 14224.0, 15124.546263612081, 18968.810311896876, 19374.903125484354, 18066.4580062598, 19691.901540492312, 20164.0, 20356.592868142627, 20367.490812729688, 5638.520725738307, 5973.4623883850445, 5981.1028345748055, 5981.28224613047, 5991.310999235078, 5640.661560306375, 5874.118882167688, 5895.587308888379, 5927.970360148193, 5937.970310148443, 5866.794662186824, 5870.618409803371, 5886.4113588641, 5891.0, 5897.528197744192, 5556.527695145917, 5751.539876809887, 5793.986052440827, 5848.327442344143, 5854.238948936653, 4880.902381952341, 5128.589712822965, 5138.897222055538, 5142.7685754140775, 5149.150390185615, 25095.62356564653, 25268.494630107478, 25348.239552813444, 25693.972241110332, 25761.227163185133, 2205.63607004844, 2349.4009027698, 2431.197704757426, 2453.092355828355, 2454.312792418126, 9674.467904265262, 10301.484925753683, 10533.631322903662, 13459.057865949388, 14298.428062877472, 1830.7436958825774, 1836.9081545922784, 1857.7120546315343, 1881.1158755384947, 1893.2033997947435, 116326.0, 118227.40886295514, 122451.38774306161, 123945.38027309805, 126041.10938335932, 10160.4919754012, 10588.364698118137, 11241.325520468798, 11734.765304693858, 11767.588134415426, 14598.124112553282, 14634.780478292834, 14972.925135374253, 15011.549653510412, 15038.32327545263, 8362.958185209034, 8472.364572657076, 8566.443181193203, 8641.524716140548, 8718.956405217934, 8190.8771368429525, 8295.875561866576, 8299.419040667217, 8300.543470109202, 8454.112318206622, 4489.0, 4543.0, 4549.567791059911, 4649.907001859944, 4659.2312268476, 1865.0066643038, 1921.7213504041836, 1933.3136736458637, 1950.561123747174, 1977.4166620846884, 798.5607915646372, 799.6641410607559, 878.5519385113638, 948.8671585977969, 965.8840939087354, 19819.0, 21268.950139855257, 21344.78655213428, 21406.357809265748, 21458.78541214599, 874.6239117179547, 926.3839546701369, 980.7057882635181, 981.7300242433388, 1030.3663247103127, 10578.0, 10793.190510711727, 11058.889411105785, 11123.499442525106, 11144.164187685794, 589515.0, 601264.0, 601700.0, 609141.7714557172, 611571.0, 72809.6359518199, 118877.0, 130035.69964300236, 130322.34838825745, 134601.65398346088, 948.2935213266161, 953.0564740906452, 986.9506524673737, 988.461288597716, 989.3124278626285, 17939.5515112118, 18103.909480452512, 18444.446666600023, 18450.630987380446, 18512.259509619464, 53635.73182134065, 55529.0, 55621.0, 56818.0, 56959.0, 75051.87422188562, 76361.85457218258, 80142.0, 80432.0, 80592.59703701679, 6860.108185935796, 7783.961080194563, 7859.921400786147, 8127.634256458356, 8160.347172226089, 12356.196847204903, 12456.937715311366, 12483.0, 12600.243985360908, 12809.359532023547, 10624.893751062391, 10775.625206070768, 10937.234393592691, 10989.890101098887, 11118.277311974696, 10607.0, 10717.624883129365, 10837.566497340333, 10900.563977440814, 10939.781204376028, 9154.496502692416, 9671.742673452407, 10850.620228291971, 11147.331160130418, 11309.773804524028, 7899.763007109796, 7926.960365198137, 8071.717489887826, 8153.470024448392, 8208.712695055645, 8143.389245806707, 10379.84430233532, 10700.0, 11010.229283950046, 11104.389258590532], "value": 9435.837119762607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.0683061610946, 1444.2634256529172, 1469.7354476194287, 1622.4402581109514, 1821.1167583721901, 7504.198992241863, 7928.484648497851, 7928.920710792898, 7935.484193527417, 7938.48399854009, 7752.651130699118, 7857.096433910102, 8244.958775206116, 8487.0, 8502.574871256444, 2303.7465878753324, 2332.8017118544944, 2333.055112679359, 2338.2985104468676, 2338.976610233893, 2317.9536409271805, 2351.9647205291935, 2364.4679947011955, 2375.287413775869, 2379.6430535419654, 2279.2706333973133, 2289.53064621753, 2306.2965795432387, 2308.53829234153, 2314.0396735354893, 2287.0508738873345, 2291.3698732848434, 2315.5947709150832, 2318.0611852199886, 2326.4067662745892, 2315.1549684365255, 2330.8368414211013, 2337.263761915008, 2338.941526461835, 2343.906243750248, 8280.378971577096, 8470.152984701543, 8476.618552165106, 8483.703070392507, 8489.575521223976, 5021.723805190713, 5074.13739664258, 5244.659097158673, 5251.711155886424, 5257.7108259045735, 3469.340825243221, 3561.269939662389, 3567.2152126532123, 3571.6785489305826, 3573.6962358199585, 1052.921030922684, 1069.502681253221, 1103.426218366453, 1103.6523495099018, 1103.9116870650328, 10925.399103049409, 11007.669769906915, 11020.393878336688, 11035.337879727242, 11079.335239885551, 4375.453068366454, 4487.551244875486, 4525.434320709911, 4535.682502224879, 4535.750533720677, 8767.912320876709, 8769.298456123495, 8772.254358379481, 8788.516631585324, 8791.208791208694, 5095.0574143783515, 5104.4895510449405, 5106.361704786902, 5107.131787596118, 5107.540321371094, 4003.739756915791, 4109.3425051991535, 4406.27296496081, 4682.0, 4737.3841400618385, 3650.2699460108083, 3664.4686520454916, 3757.56787969387, 3770.0951771574623, 3772.1135533149686, 972.4748635736623, 1120.4061847220985, 1136.664683918246, 1148.4257871064467, 1152.913531485142, 808.321010351296, 819.2913130142502, 879.3624622149018, 880.1022956584249, 906.5240748607034, 5485.725713714299, 5600.971995140079, 5649.209110724501, 5677.545796336283, 5884.411558844081, 947.9336446448682, 970.4080510888352, 984.2519685039422, 1001.7495626093477, 1001.8847832499356, 3317.6848199421015, 3622.8188590570367, 3655.908602284911, 3674.173311005056, 3772.6981841452616, 9807.607695692235, 10304.12414944723, 10305.639302624371, 10310.381377117397, 10315.690529283984, 9965.55155018026, 10074.345167564084, 10105.040021197974, 10173.135283500837, 10192.898071019343, 7475.215102414277, 7829.64766585505, 7839.843203135905, 7968.521888686697, 7993.120756716757, 5505.366882808528, 5592.0, 5653.660780353192, 5703.657780533182, 5880.529557635465, 8312.25189732927, 8956.641734330553, 9328.160465558132, 9502.85745713801, 9510.667126650535, 7452.956586077845, 8076.27313541784, 9682.854757178507, 9711.3202075854, 9712.223022158352, 6935.757248496278, 7081.539699919489, 7223.2776722329445, 7273.418126549969, 7277.745278915212, 7877.369810415038, 8038.115807261313, 8042.758717238258, 8056.476329038594, 8064.15326390744, 7049.330313620198, 7154.67803948834, 7169.139703235436, 7173.892391614234, 7308.415326773739, 7048.189458212166, 7084.752033678797, 7085.716571337089, 7099.929000709927, 7102.431805455654, 6622.569532980341, 6686.565373250918, 6689.933100668931, 6761.830954226184, 6762.053312536347, 4822.180229361087, 4841.467438581823, 4869.732164730974, 4879.194932836042, 4905.288733133747, 4781.258904869751, 4799.856004319876, 4882.92675609859, 4976.850694479172, 4993.925091123563], "value": 4389.83877500897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.56700125282632, 294.17923992062146, 304.72574682785495, 308.8640997960897, 312.2334668389102, 4471.473617406164, 4660.627149828014, 4915.238138088602, 5104.285400043992, 5162.767675454605, 4753.429588449382, 4870.269459581064, 4914.483979182188, 4927.2855435961765, 5164.0, 3861.903452413684, 3875.360565506688, 3889.4943657324648, 3889.8994542946775, 3923.5684074751753, 3841.5390153181656, 3859.749116307445, 3864.85014713008, 3896.1103864625634, 3900.4929359183407, 3719.753882449369, 3869.148787266811, 3873.1479074603544, 3884.9417258741, 3895.9351543681896, 3413.9317213655713, 3858.864939727096, 3861.691064714816, 3908.355121404965, 3925.1953349563414, 2936.8546266955905, 3213.4215841148584, 3367.3433680432327, 3374.4263475209273, 3408.352413041514, 4916.532929371704, 4934.284528743348, 4946.3817022872145, 4957.851264462036, 4967.627427942883, 4004.619561141687, 4051.858184963512, 4111.8972025699295, 4272.829086836523, 4450.688451808374, 4362.498312694017, 4373.737575745434, 4639.628829693616, 5320.707361095138, 5332.92000619991, 3717.275131349388, 3729.1727053743743, 3729.6829769469628, 3738.3084129436143, 3767.4193177673105, 4707.952920470786, 5322.939309896786, 5470.56235501159, 5475.6440831345835, 5518.613697041209, 3476.8261586920553, 3762.0030691866677, 3762.793046382475, 3764.6235376462682, 3764.8705388383923, 3822.1591249924973, 3829.5787463379006, 3829.8744196970392, 3848.615138486185, 3859.1895701902354, 3588.659077387644, 3781.489498917611, 4295.291276939332, 4401.6478681705385, 4434.5343738907595, 4821.7589120543835, 4900.877478063006, 5152.510511501401, 5298.390685071189, 5311.787528498894, 1188.294796966356, 1196.2702751321688, 1234.4259919137464, 1245.9439325230387, 1264.5510843650557, 804.9919500805034, 819.3281509162549, 831.2477208126655, 850.965961361551, 870.3515880668815, 4677.555632214934, 4685.765711714401, 4699.553542413465, 4731.455882573479, 4740.45484769249, 4447.264297989705, 4480.9103817924115, 5157.369741431897, 5204.297419848348, 5231.659942103751, 4143.606357396043, 4177.164567086595, 4599.08018396322, 4622.659428765687, 4633.590532922929, 2242.3048854855047, 2359.3484560807506, 2686.408990022192, 2711.5119278530055, 2760.7239276072232, 4740.70520987917, 4887.238710128766, 4986.4514903360605, 5329.307190065267, 5336.252924590561, 4467.910641787146, 4556.67609519141, 4720.811167553259, 4938.678985865908, 5282.31329927107, 4215.430916826251, 4240.0, 4748.287756836433, 5193.948060519422, 5196.558292545176, 4348.412964249786, 5016.0, 5055.646104772631, 5056.115179843439, 5063.316452278895, 4272.38050482672, 4347.869533935562, 4815.398075240595, 4992.525710057539, 5205.271262023244, 4415.624671902924, 4601.493835678006, 4855.077535268288, 5184.351956005499, 5184.896302074013, 3556.7154627630243, 3577.373959557119, 3587.959491747364, 3635.927281454409, 3659.432787917877, 4302.569743025798, 4518.457785065813, 5046.4701206374275, 5048.72232027242, 5163.509466600667, 4815.398075240595, 5219.799446127336, 5330.307060082165, 5346.278252436027, 5365.168398898177, 5306.97346513265, 5365.7048862311385, 5385.791825351587, 5386.8383948481605, 5387.407385187705, 3945.270125026879, 4891.706497610155, 5127.974360128175, 5222.29499017643, 5344.278522399582, 4969.676970996874, 5106.591472682251, 5110.948890511196, 5177.792888284426, 5343.385510666323, 4352.825886964486, 5217.452167522356, 5218.8956220876125, 5222.529972302511, 5263.631455821437], "value": 3782.4612530159084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.981850453739, 742.4728442805612, 755.5882044285863, 784.5528049012064, 803.0724513187271, 14402.0, 14554.345054472547, 14599.78100328496, 14621.78067328991, 14769.409223631055, 12914.354282285894, 12975.286359250238, 12984.28586427746, 12997.935010324958, 13024.804627930589, 639.3318981664149, 664.717495064598, 795.387551585279, 796.5141263829059, 824.8432797768435, 823.2467292427451, 839.1314988986401, 839.5382539603224, 839.7858546070744, 840.3781201910604, 850.9234168924795, 853.5988085599789, 854.5001174313035, 855.3883972959333, 855.4653341661461, 587.7707693999322, 603.3966033966034, 679.4021261290058, 704.9541779784298, 706.9893951590731, 613.6471528870873, 634.4385219081147, 637.9649119298437, 638.00152760929, 638.6678926958002, 14066.648333791634, 14071.929640351835, 14092.788608170886, 14121.717565648732, 14122.22327771972, 10062.849057264148, 12522.81215781764, 12635.1787133836, 12644.367781610974, 12770.80843787344, 11878.465469053826, 12025.158238923279, 12099.213551119148, 12123.878761212363, 12157.331346775924, 4217.093324935123, 4244.405783190356, 4280.443542339507, 4364.105358401552, 4462.219111655448, 84324.0, 86618.0, 87995.0, 88967.0, 89631.55184224037, 9506.287028472892, 10014.499275036365, 10201.642942496977, 10203.38779673222, 10240.129588984872, 19001.714974275397, 19016.619667606847, 19026.904865475582, 19039.90480047591, 19043.0, 6641.535092543572, 6875.209350924608, 6889.586624802528, 6899.413549848218, 7055.2239253682055, 3593.8921832345072, 4295.52749197588, 4334.609885110292, 4374.58441448062, 4375.606195442362, 3170.936581268362, 3204.1669166017004, 3271.689189526991, 3280.048785852076, 3285.901422957315, 627.7802769030802, 668.2749217099405, 680.6766785776716, 681.1655721740827, 692.8891377379595, 572.1989215098895, 638.5370606310481, 646.7639311651213, 647.6955830759536, 661.8682053688151, 8350.33197344211, 8677.262432693291, 8834.0, 8880.555972201364, 8953.59708813105, 570.7574280930588, 592.6503363015842, 609.6045029187384, 625.2965413909352, 650.0703993289546, 4197.370394440797, 4211.873643790691, 4406.223591986915, 4534.45586529612, 4551.47658019332, 62628.68685656634, 110368.0, 113354.0, 114410.42794786139, 114439.0, 93986.0, 96788.0, 97006.0, 98826.0, 102471.0, 50731.999999999265, 51875.48124518707, 86439.0, 88258.0, 89659.10340896508, 9201.861972070557, 9554.665586704432, 9647.565859536197, 9663.0, 9679.370840895319, 50295.49704502908, 51053.234201486266, 51355.972880542926, 52681.0, 54722.0, 63816.0, 72938.0, 76911.0, 77484.61257693675, 77994.4401111986, 11830.46762895689, 12092.939535302266, 12209.938950305192, 12289.0, 12813.0, 12988.870111299144, 13703.520376786764, 14448.0, 14627.853721462649, 14949.005774529536, 12204.962578180599, 12226.0, 12919.0, 13129.868701312864, 13327.466901323838, 11191.32852028881, 12796.61610151697, 13349.929516211132, 13711.588652340446, 13851.376688049264, 12205.280142852183, 12767.361631918182, 13331.400086995915, 13375.799363009368, 13595.11631743973, 10798.622048228275, 11154.442277886235, 11278.605248816251, 11493.367864767519, 11587.015103716278, 7494.400447964259, 9136.223421009023, 9582.856257156287, 11199.593358183705, 11208.55165793359], "value": 7121.5234428803915, "unit": "score"}], "name": "dromaeo_css", "value": 6981.138165095615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 117.0, 163.0, 166.0, 114.0, 113.0, 115.0, 113.0], "value": 124.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 138.0, 137.0, 145.0, 109.0, 111.0, 114.0, 109.0, 140.0, 127.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 188.0, 181.0, 182.0, 184.0, 182.0, 185.0, 181.0, 181.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 98.0, 52.0, 61.0, 78.0, 81.0, 107.0, 80.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 92.0, 68.0, 67.0, 69.0, 116.0, 94.0, 96.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 89.0, 85.0, 89.0, 85.0, 87.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 78.0, 79.0, 81.0, 82.0, 83.0, 85.0, 83.0, 84.0], "value": 82.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 80.0, 75.0, 73.0, 69.0, 94.0, 101.0, 101.0, 76.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 85.0, 83.0, 82.0, 81.0, 83.0, 85.0, 85.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 140.0, 139.0, 139.0, 138.0, 144.0, 141.0, 177.0, 144.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 170.0, 222.0, 206.0, 164.0, 165.0, 162.0, 173.0, 163.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 66.0, 69.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1465.6999999999998, "alertThreshold": 2.0}]} 17:09:15 INFO - Return code: 0 17:09:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:09:16 INFO - # TBPL SUCCESS # 17:09:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:09:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:09:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:09:16 INFO - 2017-01-20 17:09:16.021 screenresolution[1656:9855] starting screenresolution argv=screenresolution get 17:09:16 INFO - 2017-01-20 17:09:16.025 screenresolution[1656:9855] Display 0: 1600x1200x32@60 17:09:16 INFO - 2017-01-20 17:09:16.031 screenresolution[1657:9858] starting screenresolution argv=screenresolution list 17:09:16 INFO - Available Modes on Display 0 17:09:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:09:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:09:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:09:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:09:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:09:16 INFO - Intel Iris: 17:09:16 INFO - Chipset Model: Intel Iris 17:09:16 INFO - Type: GPU 17:09:16 INFO - Bus: Built-In 17:09:16 INFO - VRAM (Dynamic, Max): 1536 MB 17:09:16 INFO - Vendor: Intel (0x8086) 17:09:16 INFO - Device ID: 0x0a2e 17:09:16 INFO - Revision ID: 0x0009 17:09:16 INFO - Displays: 17:09:16 INFO - Display: 17:09:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:09:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:09:16 INFO - Display Serial Number: 1600x1200 60 17:09:16 INFO - Main Display: Yes 17:09:16 INFO - Mirror: Off 17:09:16 INFO - Online: Yes 17:09:16 INFO - Rotation: Supported 17:09:16 INFO - Return code: 0 17:09:16 INFO - Running post-action listener: _resource_record_post_action 17:09:16 INFO - [mozharness: 2017-01-21 01:09:16.280634Z] Finished run-tests step (success) 17:09:16 INFO - Running post-run listener: _resource_record_post_run 17:09:16 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 37921792; Write bytes: 657609728; Read time: 241; Write time: 1837 17:09:16 INFO - TinderboxPrint: CPU usage
53.2% 17:09:16 INFO - TinderboxPrint: I/O read bytes / time
37,921,792 / 241 17:09:16 INFO - TinderboxPrint: I/O write bytes / time
657,609,728 / 1,837 17:09:16 INFO - TinderboxPrint: CPU idle
2,268.6 (46.8%) 17:09:16 INFO - TinderboxPrint: CPU system
963.2 (19.9%) 17:09:16 INFO - TinderboxPrint: CPU user
1,613.9 (33.3%) 17:09:16 INFO - TinderboxPrint: Swap in / out
387,108,864 / 0 17:09:16 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345489920; Write bytes: 346019328; Read time: 26995; Write time: 698 17:09:16 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 35857408; Write bytes: 304537088; Read time: 222; Write time: 1110 17:09:16 INFO - Running post-run listener: _upload_blobber_files 17:09:16 INFO - Blob upload gear active. 17:09:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:16 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 17:09:16 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'] 17:09:16 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 17:09:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:09:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:09:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:18 INFO - (blobuploader) - INFO - Done attempting. 17:09:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:09:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:19 INFO - (blobuploader) - INFO - Done attempting. 17:09:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:09:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:09:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:21 INFO - (blobuploader) - INFO - Done attempting. 17:09:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:21 INFO - Return code: 0 17:09:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1db00fd24829ad47dda4f35c5e3a0951e46fc29d7b38bd3a953c03e31b003c7ec053c63ecf1e6604d7db1f5ca0f6cc9b98c86b88e3ec149082a2c178964a1e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d26501117310623c562c967bf8a363a2e1437083af95eb20632fb95a122e700a4ee4dd7d04ccd3c922dc6901e71cefa9da68fa52a72fc2fb04d5c318121500e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13934fba50a6c6ae2526e848913a59fded51ec87b8c7978faff3539526c06e99d6deccd5e09e76e965b94d8185d004bb7b6485dda20e6187aeeafe7eda72021f"} 17:09:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:21 INFO - Contents: 17:09:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1db00fd24829ad47dda4f35c5e3a0951e46fc29d7b38bd3a953c03e31b003c7ec053c63ecf1e6604d7db1f5ca0f6cc9b98c86b88e3ec149082a2c178964a1e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d26501117310623c562c967bf8a363a2e1437083af95eb20632fb95a122e700a4ee4dd7d04ccd3c922dc6901e71cefa9da68fa52a72fc2fb04d5c318121500e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13934fba50a6c6ae2526e848913a59fded51ec87b8c7978faff3539526c06e99d6deccd5e09e76e965b94d8185d004bb7b6485dda20e6187aeeafe7eda72021f"} 17:09:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:21 INFO - Copying logs to upload dir... 17:09:21 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.401689 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-20 17:09:21.761524) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 17:09:21.765066) ========= 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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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/1db00fd24829ad47dda4f35c5e3a0951e46fc29d7b38bd3a953c03e31b003c7ec053c63ecf1e6604d7db1f5ca0f6cc9b98c86b88e3ec149082a2c178964a1e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d26501117310623c562c967bf8a363a2e1437083af95eb20632fb95a122e700a4ee4dd7d04ccd3c922dc6901e71cefa9da68fa52a72fc2fb04d5c318121500e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13934fba50a6c6ae2526e848913a59fded51ec87b8c7978faff3539526c06e99d6deccd5e09e76e965b94d8185d004bb7b6485dda20e6187aeeafe7eda72021f"} build_url:https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010893 build_url: 'https://queue.taskcluster.net/v1/task/VXqHMeAWRCGQhcysnSpgWQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1db00fd24829ad47dda4f35c5e3a0951e46fc29d7b38bd3a953c03e31b003c7ec053c63ecf1e6604d7db1f5ca0f6cc9b98c86b88e3ec149082a2c178964a1e1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d26501117310623c562c967bf8a363a2e1437083af95eb20632fb95a122e700a4ee4dd7d04ccd3c922dc6901e71cefa9da68fa52a72fc2fb04d5c318121500e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13934fba50a6c6ae2526e848913a59fded51ec87b8c7978faff3539526c06e99d6deccd5e09e76e965b94d8185d004bb7b6485dda20e6187aeeafe7eda72021f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 17:09:21.797929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:09:21.798212) ========= 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.6bkOd2HjUv/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.U5c2ot1Rf1/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.005291 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:09:21.846261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 17:09:21.846538) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 17:09:21.846835) ========= ========= Total master_lag: 0.18 =========