builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0302 starttime: 1487952947.73 results: success (0) buildid: 20170224065322 builduid: 2473b1bc356c463ea003dd7054c787e2 revision: 6d4e454134d2a383419a49f4daf634771d254d94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.726104) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.726528) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.726799) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.753436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.753808) ========= 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.ENDLqiXqov/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.ZJ74EJHueh/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-24 08:15:47-- 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% 66.8M=0s 2017-02-24 08:15:47 (66.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.905812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.906171) ========= 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.ENDLqiXqov/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.ZJ74EJHueh/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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.024896 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:47.954593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 08:15:47.954990) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d4e454134d2a383419a49f4daf634771d254d94 --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-beta --rev 6d4e454134d2a383419a49f4daf634771d254d94 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ENDLqiXqov/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.ZJ74EJHueh/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-24 08:15:48,063 truncating revision to first 12 chars 2017-02-24 08:15:48,063 Setting DEBUG logging. 2017-02-24 08:15:48,063 attempt 1/10 2017-02-24 08:15:48,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6d4e454134d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 08:15:48,730 unpacking tar archive at: mozilla-beta-6d4e454134d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948900 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 08:15:49.086284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:49.086828) ========= script_repo_revision: 6d4e454134d2a383419a49f4daf634771d254d94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:49.087471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:49.087930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 08:15:49.148681) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-24 08:15:49.149049) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ENDLqiXqov/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.ZJ74EJHueh/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:15:49 INFO - MultiFileLogger online at 20170224 08:15:49 in /builds/slave/test 08:15:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:15:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:49 INFO - {'append_to_log': False, 08:15:49 INFO - 'base_work_dir': '/builds/slave/test', 08:15:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:15:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:49 INFO - 'branch': 'Mozilla-Beta', 08:15:49 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:49 INFO - 'config_files': ('talos/mac_config.py',), 08:15:49 INFO - 'default_actions': ('clobber', 08:15:49 INFO - 'read-buildbot-config', 08:15:49 INFO - 'download-and-extract', 08:15:49 INFO - 'populate-webroot', 08:15:49 INFO - 'create-virtualenv', 08:15:49 INFO - 'install', 08:15:49 INFO - 'run-tests'), 08:15:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:49 INFO - 'download_minidump_stackwalk': True, 08:15:49 INFO - 'download_symbols': 'ondemand', 08:15:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:49 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:49 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:49 INFO - 'installer_path': 'installer.exe', 08:15:49 INFO - 'log_level': 'info', 08:15:49 INFO - 'log_name': 'talos', 08:15:49 INFO - 'log_to_console': True, 08:15:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:15:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:15:49 INFO - 'opt_config_files': (), 08:15:49 INFO - 'pip_index': False, 08:15:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:49 INFO - 'cmd': ('bash', 08:15:49 INFO - '-c', 08:15:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:49 INFO - 'enabled': True, 08:15:49 INFO - 'halt_on_failure': False, 08:15:49 INFO - 'name': 'check_screen_resolution'},), 08:15:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:15:49 INFO - 'cmd': ('bash', 08:15:49 INFO - '-c', 08:15:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:15:49 INFO - 'enabled': True, 08:15:49 INFO - 'halt_on_failure': False, 08:15:49 INFO - 'name': 'check_screen_resolution'},), 08:15:49 INFO - 'run_cmd_checks_enabled': True, 08:15:49 INFO - 'sps_profile': False, 08:15:49 INFO - 'sps_profile_interval': 0, 08:15:49 INFO - 'suite': 'dromaeojs', 08:15:49 INFO - 'system_bits': '32', 08:15:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:49 INFO - 'title': 't-yosemite-r7-0302', 08:15:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:49 INFO - 'use_talos_json': True, 08:15:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:49 INFO - 'work_dir': 'build'} 08:15:49 INFO - [mozharness: 2017-02-24 16:15:49.359858Z] Running clobber step. 08:15:49 INFO - Running pre-action listener: _resource_record_pre_action 08:15:49 INFO - Running main action method: clobber 08:15:49 INFO - rmtree: /builds/slave/test/build 08:15:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:51 INFO - Running post-action listener: _resource_record_post_action 08:15:51 INFO - [mozharness: 2017-02-24 16:15:51.737400Z] Finished clobber step (success) 08:15:51 INFO - [mozharness: 2017-02-24 16:15:51.737563Z] Running read-buildbot-config step. 08:15:51 INFO - Running pre-action listener: _resource_record_pre_action 08:15:51 INFO - Running main action method: read_buildbot_config 08:15:51 INFO - Using buildbot properties: 08:15:51 INFO - { 08:15:51 INFO - "project": "", 08:15:51 INFO - "product": "firefox", 08:15:51 INFO - "script_repo_revision": "production", 08:15:51 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:15:51 INFO - "repository": "", 08:15:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:15:51 INFO - "buildid": "20170224065322", 08:15:51 INFO - "pgo_build": "False", 08:15:51 INFO - "basedir": "/builds/slave/test", 08:15:51 INFO - "buildnumber": 9, 08:15:51 INFO - "slavename": "t-yosemite-r7-0302", 08:15:51 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:15:51 INFO - "platform": "yosemite_r7", 08:15:51 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:15:51 INFO - "branch": "mozilla-beta", 08:15:51 INFO - "repo_path": "releases/mozilla-beta", 08:15:51 INFO - "revision": "6d4e454134d2a383419a49f4daf634771d254d94", 08:15:51 INFO - "stage_platform": "macosx64", 08:15:51 INFO - "builduid": "2473b1bc356c463ea003dd7054c787e2", 08:15:51 INFO - "slavebuilddir": "test" 08:15:51 INFO - } 08:15:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:15:51 INFO - Running post-action listener: _resource_record_post_action 08:15:51 INFO - [mozharness: 2017-02-24 16:15:51.741106Z] Finished read-buildbot-config step (success) 08:15:51 INFO - [mozharness: 2017-02-24 16:15:51.741260Z] Running download-and-extract step. 08:15:51 INFO - Running pre-action listener: _resource_record_pre_action 08:15:51 INFO - Running main action method: download_and_extract 08:15:51 INFO - mkdir: /builds/slave/test/build/tests 08:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:51 INFO - trying https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:15:51 INFO - Downloading https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:15:52 INFO - Downloaded 1165 bytes. 08:15:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:15:52 INFO - Using the following test package requirements: 08:15:52 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:15:52 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:15:52 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:15:52 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:15:52 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:15:52 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:15:52 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:15:52 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:15:52 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:15:52 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:15:52 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:15:52 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:15:52 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:15:52 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:15:52 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:15:52 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:15:52 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:15:52 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:15:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:15:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:15:52 INFO - Fetch https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:15:53 INFO - Http code: 200 08:15:53 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 08:15:53 INFO - x-amz-cf-id: nFUu99MtiHcndyU8srRreZJaSDglmDodYuEUYePNz6noX2KI1uLzkQ== 08:15:53 INFO - x-amz-version-id: Kq0t_Qze3C9pfIwi2uhAPkRloC4Pb892 08:15:53 INFO - Expected file size: 16093331 08:15:53 INFO - Obtained file size: 16093331 08:16:00 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:16:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:16:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:16:00 INFO - Fetch https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:16:00 INFO - Http code: 200 08:16:00 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:16:00 INFO - x-amz-cf-id: OCo66Khp918o2nJMb2ZDTJVytcDEUjj_pUaopqwRB2UuYmfEc_mmhg== 08:16:00 INFO - x-amz-version-id: Kq0t_Qze3C9pfIwi2uhAPkRloC4Pb892 08:16:01 INFO - Expected file size: 16093331 08:16:01 INFO - Obtained file size: 16093331 08:16:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:16:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:16:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:16:07 INFO - Http code: 200 08:16:07 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 08:16:07 INFO - x-amz-cf-id: Cv_kiaWbb7k69MJSQHrMKjZ4mInDYZ5jb4T6jmJKP_hCLz1MTxdCBg== 08:16:07 INFO - x-amz-version-id: Gquc_r9bhYhKQvJxzg0.hM28k5cD72kX 08:16:08 INFO - Expected file size: 14402992 08:16:08 INFO - Obtained file size: 14402992 08:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:08 INFO - trying https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:16:08 INFO - Downloading https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:16:10 INFO - Downloaded 82108712 bytes. 08:16:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:16:10 INFO - mkdir: /builds/slave/test/properties 08:16:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:10 INFO - Contents: 08:16:10 INFO - build_url:https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:16:11 INFO - Running post-action listener: _resource_record_post_action 08:16:11 INFO - Running post-action listener: set_extra_try_arguments 08:16:11 INFO - [mozharness: 2017-02-24 16:16:11.518347Z] Finished download-and-extract step (success) 08:16:11 INFO - [mozharness: 2017-02-24 16:16:11.518467Z] Running populate-webroot step. 08:16:11 INFO - Running pre-action listener: _resource_record_pre_action 08:16:11 INFO - Running main action method: populate_webroot 08:16:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:11 INFO - '--tppagecycles', 08:16:11 INFO - '7'], 08:16:11 INFO - 'tests': ['tsvgm']}}, 08:16:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['damp', 'tps']}, 08:16:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'tests': ['damp', 'tps']}, 08:16:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['dromaeo_dom']}, 08:16:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['basic_compositor_video']}, 08:16:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['a11yr', 08:16:11 INFO - 'ts_paint', 08:16:11 INFO - 'tpaint', 08:16:11 INFO - 'sessionrestore', 08:16:11 INFO - 'sessionrestore_no_auto_restore', 08:16:11 INFO - 'tabpaint']}, 08:16:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:11 INFO - 'ts_paint', 08:16:11 INFO - 'tpaint', 08:16:11 INFO - 'sessionrestore', 08:16:11 INFO - 'sessionrestore_no_auto_restore', 08:16:11 INFO - 'tabpaint']}, 08:16:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:11 INFO - 'ts_paint', 08:16:11 INFO - 'tpaint', 08:16:11 INFO - 'sessionrestore', 08:16:11 INFO - 'sessionrestore_no_auto_restore', 08:16:11 INFO - 'tabpaint']}, 08:16:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:11 INFO - 'ts_paint', 08:16:11 INFO - 'tpaint', 08:16:11 INFO - 'sessionrestore', 08:16:11 INFO - 'sessionrestore_no_auto_restore', 08:16:11 INFO - 'tabpaint']}, 08:16:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['a11yr', 08:16:11 INFO - 'ts_paint', 08:16:11 INFO - 'tpaint', 08:16:11 INFO - 'sessionrestore', 08:16:11 INFO - 'sessionrestore_no_auto_restore', 08:16:11 INFO - 'tabpaint']}, 08:16:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['a11yr', 08:16:11 INFO - 'ts_paint', 08:16:11 INFO - 'tpaint', 08:16:11 INFO - 'sessionrestore', 08:16:11 INFO - 'sessionrestore_no_auto_restore', 08:16:11 INFO - 'tabpaint']}, 08:16:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['tsvgx', 08:16:11 INFO - 'tsvgr_opacity', 08:16:11 INFO - 'tart', 08:16:11 INFO - 'tscrollx', 08:16:11 INFO - 'cart']}, 08:16:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:11 INFO - 'tsvgr_opacity', 08:16:11 INFO - 'tart', 08:16:11 INFO - 'tscrollx', 08:16:11 INFO - 'cart']}, 08:16:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'talos_options': ['--disable-e10s'], 08:16:11 INFO - 'tests': ['tp5o']}, 08:16:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'tests': ['tp5o']}, 08:16:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'talos_options': ['--disable-e10s', 08:16:11 INFO - '--xperf_path', 08:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:11 INFO - 'tests': ['tp5n']}, 08:16:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:11 INFO - 'talos_options': ['--xperf_path', 08:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:11 INFO - 'tests': ['tp5n']}}, 08:16:11 INFO - 'talos.zip': {'path': '', 08:16:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:11 INFO - Running post-action listener: _resource_record_post_action 08:16:11 INFO - [mozharness: 2017-02-24 16:16:11.537361Z] Finished populate-webroot step (success) 08:16:11 INFO - [mozharness: 2017-02-24 16:16:11.537466Z] Running create-virtualenv step. 08:16:11 INFO - Running pre-action listener: _resource_record_pre_action 08:16:11 INFO - Running main action method: create_virtualenv 08:16:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:16:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:11 INFO - Using real prefix '/tools/python27' 08:16:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:15 INFO - Installing pip.................done. 08:16:15 INFO - Return code: 0 08:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:16:15 INFO - Reading from file tmpfile_stdout 08:16:15 INFO - Output received: 08:16:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:16:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:15 INFO - 'HOME': '/Users/cltbld', 08:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:15 INFO - 'LOGNAME': 'cltbld', 08:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:15 INFO - 'MOZ_NO_REMOTE': '1', 08:16:15 INFO - 'NO_EM_RESTART': '1', 08:16:15 INFO - 'PAGER': '/bin/cat', 08:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:15 INFO - 'PWD': '/builds/slave/test', 08:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:15 INFO - 'SHELL': '/bin/bash', 08:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:15 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:15 INFO - 'USER': 'cltbld', 08:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:15 INFO - 'XPC_FLAGS': '0x0', 08:16:15 INFO - 'XPC_SERVICE_NAME': '0', 08:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:16:15 INFO - Cleaning up... 08:16:15 INFO - Return code: 0 08:16:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:15 INFO - 'HOME': '/Users/cltbld', 08:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:15 INFO - 'LOGNAME': 'cltbld', 08:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:15 INFO - 'MOZ_NO_REMOTE': '1', 08:16:15 INFO - 'NO_EM_RESTART': '1', 08:16:15 INFO - 'PAGER': '/bin/cat', 08:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:15 INFO - 'PWD': '/builds/slave/test', 08:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:15 INFO - 'SHELL': '/bin/bash', 08:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:15 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:15 INFO - 'USER': 'cltbld', 08:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:15 INFO - 'XPC_FLAGS': '0x0', 08:16:15 INFO - 'XPC_SERVICE_NAME': '0', 08:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:16 INFO - Downloading/unpacking psutil>=3.1.1 08:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:19 INFO - Installing collected packages: psutil 08:16:19 INFO - Running setup.py install for psutil 08:16:19 INFO - building 'psutil._psutil_osx' extension 08:16:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:16:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:16:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:16:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:16:20 INFO - building 'psutil._psutil_posix' extension 08:16:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:16:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:16:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:16:20 INFO - ^ 08:16:20 INFO - 1 warning generated. 08:16:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:16:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:20 INFO - Successfully installed psutil 08:16:20 INFO - Cleaning up... 08:16:20 INFO - Return code: 0 08:16:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:16:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:20 INFO - 'HOME': '/Users/cltbld', 08:16:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:20 INFO - 'LOGNAME': 'cltbld', 08:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:20 INFO - 'MOZ_NO_REMOTE': '1', 08:16:20 INFO - 'NO_EM_RESTART': '1', 08:16:20 INFO - 'PAGER': '/bin/cat', 08:16:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:20 INFO - 'PWD': '/builds/slave/test', 08:16:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:20 INFO - 'SHELL': '/bin/bash', 08:16:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:20 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:20 INFO - 'USER': 'cltbld', 08:16:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:20 INFO - 'XPC_FLAGS': '0x0', 08:16:20 INFO - 'XPC_SERVICE_NAME': '0', 08:16:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:23 INFO - Installing collected packages: mozsystemmonitor 08:16:23 INFO - Running setup.py install for mozsystemmonitor 08:16:23 INFO - Successfully installed mozsystemmonitor 08:16:23 INFO - Cleaning up... 08:16:23 INFO - Return code: 0 08:16:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:16:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:23 INFO - 'HOME': '/Users/cltbld', 08:16:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:23 INFO - 'LOGNAME': 'cltbld', 08:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:23 INFO - 'MOZ_NO_REMOTE': '1', 08:16:23 INFO - 'NO_EM_RESTART': '1', 08:16:23 INFO - 'PAGER': '/bin/cat', 08:16:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:23 INFO - 'PWD': '/builds/slave/test', 08:16:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:23 INFO - 'SHELL': '/bin/bash', 08:16:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:23 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:23 INFO - 'USER': 'cltbld', 08:16:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:23 INFO - 'XPC_FLAGS': '0x0', 08:16:23 INFO - 'XPC_SERVICE_NAME': '0', 08:16:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:27 INFO - warning: no files found matching '*.txt' 08:16:27 INFO - no previously-included directories found matching 'build' 08:16:27 INFO - no previously-included directories found matching 'dist' 08:16:27 INFO - no previously-included directories found matching '.git*' 08:16:27 INFO - Installing collected packages: jsonschema, functools32 08:16:27 INFO - Running setup.py install for functools32 08:16:27 INFO - warning: no files found matching '*.txt' 08:16:27 INFO - no previously-included directories found matching 'build' 08:16:27 INFO - no previously-included directories found matching 'dist' 08:16:27 INFO - no previously-included directories found matching '.git*' 08:16:27 INFO - Successfully installed jsonschema functools32 08:16:27 INFO - Cleaning up... 08:16:27 INFO - Return code: 0 08:16:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:16:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:27 INFO - 'HOME': '/Users/cltbld', 08:16:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:27 INFO - 'LOGNAME': 'cltbld', 08:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:27 INFO - 'MOZ_NO_REMOTE': '1', 08:16:27 INFO - 'NO_EM_RESTART': '1', 08:16:27 INFO - 'PAGER': '/bin/cat', 08:16:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:27 INFO - 'PWD': '/builds/slave/test', 08:16:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:27 INFO - 'SHELL': '/bin/bash', 08:16:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:27 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:27 INFO - 'USER': 'cltbld', 08:16:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:27 INFO - 'XPC_FLAGS': '0x0', 08:16:27 INFO - 'XPC_SERVICE_NAME': '0', 08:16:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:16:27 INFO - Cleaning up... 08:16:27 INFO - Return code: 0 08:16:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:16:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:27 INFO - 'HOME': '/Users/cltbld', 08:16:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:27 INFO - 'LOGNAME': 'cltbld', 08:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:27 INFO - 'MOZ_NO_REMOTE': '1', 08:16:27 INFO - 'NO_EM_RESTART': '1', 08:16:27 INFO - 'PAGER': '/bin/cat', 08:16:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:27 INFO - 'PWD': '/builds/slave/test', 08:16:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:27 INFO - 'SHELL': '/bin/bash', 08:16:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:27 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:27 INFO - 'USER': 'cltbld', 08:16:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:27 INFO - 'XPC_FLAGS': '0x0', 08:16:27 INFO - 'XPC_SERVICE_NAME': '0', 08:16:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:31 INFO - Downloading docopt-0.6.1.tar.gz 08:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:32 INFO - Running setup.py install for blobuploader 08:16:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:32 INFO - Running setup.py install for requests 08:16:32 INFO - Running setup.py install for docopt 08:16:32 INFO - Successfully installed blobuploader requests docopt 08:16:32 INFO - Cleaning up... 08:16:32 INFO - Return code: 0 08:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:32 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:32 INFO - 'HOME': '/Users/cltbld', 08:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:32 INFO - 'LOGNAME': 'cltbld', 08:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:32 INFO - 'MOZ_NO_REMOTE': '1', 08:16:32 INFO - 'NO_EM_RESTART': '1', 08:16:32 INFO - 'PAGER': '/bin/cat', 08:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:32 INFO - 'PWD': '/builds/slave/test', 08:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:32 INFO - 'SHELL': '/bin/bash', 08:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:32 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:32 INFO - 'USER': 'cltbld', 08:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:32 INFO - 'XPC_FLAGS': '0x0', 08:16:32 INFO - 'XPC_SERVICE_NAME': '0', 08:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-hawSfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Oel3M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-X2n2TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-c7emob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Jp9CVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-8oukQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Hj7Z2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:33 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-stA45_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-kg5QDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-3I59Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-dJCAob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-_VJnhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-3akqWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-P7Mgpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-aKBI0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Es59c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:34 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-tHdk7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:34 INFO - Running setup.py install for manifestparser 08:16:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Running setup.py install for mozcrash 08:16:35 INFO - Running setup.py install for mozdebug 08:16:35 INFO - Running setup.py install for mozdevice 08:16:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Running setup.py install for mozfile 08:16:35 INFO - Running setup.py install for mozhttpd 08:16:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:35 INFO - Running setup.py install for mozinfo 08:16:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Running setup.py install for mozInstall 08:16:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Running setup.py install for mozleak 08:16:36 INFO - Running setup.py install for mozlog 08:16:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Running setup.py install for moznetwork 08:16:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Running setup.py install for mozprocess 08:16:36 INFO - Running setup.py install for mozprofile 08:16:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:36 INFO - Running setup.py install for mozrunner 08:16:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:37 INFO - Running setup.py install for mozscreenshot 08:16:37 INFO - Running setup.py install for moztest 08:16:37 INFO - Running setup.py install for mozversion 08:16:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:37 INFO - Cleaning up... 08:16:37 INFO - Return code: 0 08:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:37 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:16:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:37 INFO - 'HOME': '/Users/cltbld', 08:16:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:37 INFO - 'LOGNAME': 'cltbld', 08:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:37 INFO - 'MOZ_NO_REMOTE': '1', 08:16:37 INFO - 'NO_EM_RESTART': '1', 08:16:37 INFO - 'PAGER': '/bin/cat', 08:16:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:37 INFO - 'PWD': '/builds/slave/test', 08:16:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:37 INFO - 'SHELL': '/bin/bash', 08:16:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:37 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:37 INFO - 'USER': 'cltbld', 08:16:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:37 INFO - 'XPC_FLAGS': '0x0', 08:16:37 INFO - 'XPC_SERVICE_NAME': '0', 08:16:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:37 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-ZVP3rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:37 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Rme4NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-eM65ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-qO8U0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:38 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)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-k3CbMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-1fdqez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-H_Iuba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-YBsg36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-vQilZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-3jxIRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:38 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-2m0KK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:39 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-7gLdWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:39 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)) 08:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:39 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-6eIdAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:39 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-QF4tEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:39 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Jrhear-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:39 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-I1rScd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:39 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-Eb4ApT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:16:39 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)) 08:16:39 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)) 08:16:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:42 INFO - Downloading blessings-1.6.tar.gz 08:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:42 INFO - Installing collected packages: blessings 08:16:42 INFO - Running setup.py install for blessings 08:16:42 INFO - Successfully installed blessings 08:16:42 INFO - Cleaning up... 08:16:42 INFO - Return code: 0 08:16:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:42 INFO - Reading from file tmpfile_stdout 08:16:42 INFO - Current package versions: 08:16:42 INFO - blessings == 1.6 08:16:42 INFO - blobuploader == 1.2.4 08:16:42 INFO - docopt == 0.6.1 08:16:42 INFO - functools32 == 3.2.3-2 08:16:42 INFO - jsonschema == 2.5.1 08:16:42 INFO - manifestparser == 1.1 08:16:42 INFO - mozInstall == 1.12 08:16:42 INFO - mozcrash == 1.0 08:16:42 INFO - mozdebug == 0.1 08:16:42 INFO - mozdevice == 0.48 08:16:42 INFO - mozfile == 1.2 08:16:42 INFO - mozhttpd == 0.7 08:16:42 INFO - mozinfo == 0.9 08:16:42 INFO - mozleak == 0.1 08:16:42 INFO - mozlog == 3.4 08:16:42 INFO - moznetwork == 0.27 08:16:42 INFO - mozprocess == 0.23 08:16:42 INFO - mozprofile == 0.28 08:16:42 INFO - mozrunner == 6.13 08:16:42 INFO - mozscreenshot == 0.1 08:16:42 INFO - mozsystemmonitor == 0.3 08:16:42 INFO - moztest == 0.8 08:16:42 INFO - mozversion == 1.4 08:16:42 INFO - psutil == 3.1.1 08:16:42 INFO - requests == 1.2.3 08:16:42 INFO - wsgiref == 0.1.2 08:16:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:43 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 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:43 INFO - 'HOME': '/Users/cltbld', 08:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:43 INFO - 'LOGNAME': 'cltbld', 08:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:43 INFO - 'MOZ_NO_REMOTE': '1', 08:16:43 INFO - 'NO_EM_RESTART': '1', 08:16:43 INFO - 'PAGER': '/bin/cat', 08:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:43 INFO - 'PWD': '/builds/slave/test', 08:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:43 INFO - 'SHELL': '/bin/bash', 08:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:43 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:43 INFO - 'USER': 'cltbld', 08:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:43 INFO - 'XPC_FLAGS': '0x0', 08:16:43 INFO - 'XPC_SERVICE_NAME': '0', 08:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:16:43 INFO - Cleaning up... 08:16:43 INFO - Return code: 0 08:16:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e2585df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, '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.ENDLqiXqov/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.ZJ74EJHueh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:16: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'] in /builds/slave/test/build 08:16: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 08:16:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:16:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:16:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:16:44 INFO - 'HOME': '/Users/cltbld', 08:16:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:16:44 INFO - 'LOGNAME': 'cltbld', 08:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:44 INFO - 'MOZ_NO_REMOTE': '1', 08:16:44 INFO - 'NO_EM_RESTART': '1', 08:16:44 INFO - 'PAGER': '/bin/cat', 08:16:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:44 INFO - 'PWD': '/builds/slave/test', 08:16:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:16:44 INFO - 'SHELL': '/bin/bash', 08:16:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:16:44 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:16:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:16:44 INFO - 'USER': 'cltbld', 08:16:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:16:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:44 INFO - 'XPC_FLAGS': '0x0', 08:16:44 INFO - 'XPC_SERVICE_NAME': '0', 08:16:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:44 INFO - Cleaning up... 08:16:44 INFO - Return code: 0 08:16:44 INFO - Running post-action listener: _resource_record_post_action 08:16:44 INFO - Running post-action listener: _start_resource_monitoring 08:16:44 INFO - Starting resource monitoring. 08:16:44 INFO - [mozharness: 2017-02-24 16:16:44.490120Z] Finished create-virtualenv step (success) 08:16:44 INFO - [mozharness: 2017-02-24 16:16:44.491043Z] Running install step. 08:16:44 INFO - Running pre-action listener: _resource_record_pre_action 08:16:44 INFO - Running main action method: install 08:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:44 INFO - Reading from file tmpfile_stdout 08:16:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:44 INFO - Reading from file tmpfile_stdout 08:16:44 INFO - Output received: 08:16:44 INFO - Usage: mozinstall [options] installer 08:16:44 INFO - Options: 08:16:44 INFO - -h, --help show this help message and exit 08:16:44 INFO - -d DEST, --destination=DEST 08:16:44 INFO - Directory to install application into. [default: 08:16:44 INFO - "/builds/slave/test"] 08:16:44 INFO - --app=APP Application being installed. [default: firefox] 08:16:44 INFO - mkdir: /builds/slave/test/build/application 08:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:17:06 INFO - Reading from file tmpfile_stdout 08:17:06 INFO - Output received: 08:17:06 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:17:06 INFO - Running post-action listener: _resource_record_post_action 08:17:06 INFO - [mozharness: 2017-02-24 16:17:06.213440Z] Finished install step (success) 08:17:06 INFO - [mozharness: 2017-02-24 16:17:06.213567Z] Running run-tests step. 08:17:06 INFO - Running pre-action listener: _resource_record_pre_action 08:17:06 INFO - Running main action method: run_tests 08:17:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:06 INFO - 2017-02-24 08:17:06.227 screenresolution[1638:7287] starting screenresolution argv=screenresolution get 08:17:06 INFO - 2017-02-24 08:17:06.230 screenresolution[1638:7287] Display 0: 1600x1200x32@60 08:17:06 INFO - 2017-02-24 08:17:06.235 screenresolution[1639:7289] starting screenresolution argv=screenresolution list 08:17:06 INFO - Available Modes on Display 0 08:17:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:06 INFO - Intel Iris: 08:17:06 INFO - Chipset Model: Intel Iris 08:17:06 INFO - Type: GPU 08:17:06 INFO - Bus: Built-In 08:17:06 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:06 INFO - Vendor: Intel (0x8086) 08:17:06 INFO - Device ID: 0x0a2e 08:17:06 INFO - Revision ID: 0x0009 08:17:06 INFO - Displays: 08:17:06 INFO - Display: 08:17:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:06 INFO - Display Serial Number: 1600x1200 60 08:17:06 INFO - Main Display: Yes 08:17:06 INFO - Mirror: Off 08:17:06 INFO - Online: Yes 08:17:06 INFO - Rotation: Supported 08:17:06 INFO - Return code: 0 08:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:06 INFO - Python 2.7.3 08:17:06 INFO - Return code: 0 08:17:06 INFO - grabbing minidump binary from tooltool 08:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:06 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 0x103b5fd30>, '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 0x1039c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b57b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:17:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:17:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:17:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:06 INFO - Return code: 0 08:17:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:17:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:17:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0302', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0302 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ENDLqiXqov/Render', 08:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:06 INFO - 'HOME': '/Users/cltbld', 08:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:06 INFO - 'LOGNAME': 'cltbld', 08:17:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:06 INFO - 'MOZ_NO_REMOTE': '1', 08:17:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:06 INFO - 'NO_EM_RESTART': '1', 08:17:06 INFO - 'PAGER': '/bin/cat', 08:17:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:06 INFO - 'PWD': '/builds/slave/test', 08:17:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:06 INFO - 'SHELL': '/bin/bash', 08:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJ74EJHueh/Listeners', 08:17:06 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 08:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:06 INFO - 'USER': 'cltbld', 08:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:06 INFO - 'XPC_FLAGS': '0x0', 08:17:06 INFO - 'XPC_SERVICE_NAME': '0', 08:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0302', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:17:06 INFO - mozversion application_buildid: 20170224065322 08:17:06 INFO - mozversion application_changeset: 6d4e454134d2a383419a49f4daf634771d254d94 08:17:06 INFO - mozversion application_display_name: Firefox 08:17:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:06 INFO - mozversion application_name: Firefox 08:17:06 INFO - mozversion application_remotingname: firefox 08:17:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:17:06 INFO - mozversion application_vendor: Mozilla 08:17:06 INFO - mozversion application_version: 52.0 08:17:06 INFO - mozversion platform_buildid: 20170224065322 08:17:06 INFO - mozversion platform_changeset: 6d4e454134d2a383419a49f4daf634771d254d94 08:17:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:17:06 INFO - mozversion platform_version: 52.0 08:17:06 INFO - using testdate: 1487953026 08:17:06 INFO - actual date: 1487953026 08:17:06 INFO - starting webserver on 'localhost:49237' 08:17:06 INFO - SUITE-START | Running 2 tests 08:17:06 INFO - TEST-START | dromaeo_css 08:17:06 INFO - operating with platform_type : mac_ 08:17:06 INFO - Initialising browser for dromaeo_css test... 08:17:06 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpokTnrq/profile http://localhost:49237/getInfo.html) 08:17:09 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:17:09 INFO - PROCESS | 1649 | colorDepth:24 08:17:09 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:17:09 INFO - PROCESS | 1649 | __metrics 08:17:09 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:17:09 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:17:10 INFO - TEST-INFO | 1649: exit 0 08:17:10 INFO - Browser initialized. 08:17:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:10 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpokTnrq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:22 INFO - PROCESS | 1653 | RSS: Main: 167833600 08:17:22 INFO - PROCESS | 1653 | 08:20:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 08:20:28 INFO - PROCESS | 1653 | RSS: Main: 305750016 08:20:28 INFO - PROCESS | 1653 | 08:23:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 08:23:31 INFO - PROCESS | 1653 | RSS: Main: 307978240 08:23:31 INFO - PROCESS | 1653 | 08:26:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 08:26:34 INFO - PROCESS | 1653 | RSS: Main: 299134976 08:26:34 INFO - PROCESS | 1653 | 08:29:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 08:29:37 INFO - PROCESS | 1653 | RSS: Main: 279760896 08:29:37 INFO - PROCESS | 1653 | 08:32:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 08:32:41 INFO - PROCESS | 1653 | RSS: Main: 259833856 08:32:41 INFO - PROCESS | 1653 | 08:35:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 08:35:45 INFO - PROCESS | 1653 | RSS: Main: 367583232 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | __start_tp_report 08:35:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:35:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:35:45 INFO - PROCESS | 1653 | |i|pagename|runs| 08:35:45 INFO - PROCESS | 1653 | |0;dojo.html;3081.2913030003083;3495.8951231463057;3505.8597656093775;3519.999999999999;3569.9464508032383;5784.363719990803;5906.4388883056145;5920.792772252972;5923.3188183358925;5951.13708512266;5798.217240672508;5884.911726324098;5945.108233764938;5949.940500594993;5958.5828991970475;5324.440933701963;5360.892782144355;5418.972905135469;5443.673379597217;5467.371252305996;5206.3231779868565;5310.415854256029;5327.547158491513;5336.573074154058;5350.91973620396;5390.245365648792;5468.28912241408;5468.890622187554;5477.178423236506;5514.035043867328;5454.34547854256;5456.536194423479;5473.863153421156;5477.698726570037;5479.205515200313;5228.738563071831;5249.816256431007;5318.335208098988;5431.8098866539485;5442.292501974757;5804.2744656917885;5824.155497452888;5835.970820145914;5842.620229685057;5844;6215.067739839015;6222.719977601018;6243.5005199584375;6279.937200627981;6284.842878928018;5264.868378290574;6328.683565821737;6343.14367560378;6368.426841584233;6384.648844313561;6059.575829691968;6065.423784740487;6067.18093057436;6080.361562036011;6097.878042439171;6270.31026587075;6319.58922670025;6386.07401926718;6398;6473.741050358027;6038.943184942617;6298.874022519524;6303.275123360872;6310.9368906311265;6315.305316415191;5537.861553461115;6356.269029061625;6358.109864618957;6385.074164246251;6397.96801015992;6191;6198.473129783929;6240.594361366497;6278.089676996809;6279.215098112736;5287.391949925731;6261.060840873814;6265.96867015662;6267.9373206268265;6284.4344009039405;4987.326710893983;5082.923756143661;5098.1842905135;5109;5112.079825631347;4521.706089104197;4522.005158865044;4546.1135078659345;4557.248054071041;4603.700759450625;6007.789727359522;6067.362926892701;6093.8476538086015;6094.329623741385;6126.754929802758;5239.633225674243;6326.493880489642;6372.012338087604;6398.8720225595225;6399.648019358887;5817.272840894888;6030.216071910711;6034.306054803666;6044.214252147192;6044.335123136451;5505.476979686923;5531.308586426697;5568.081266591048;5597.3003374578175;5597.916031259534;6581.177352830896;6583.242927063449;6596.406323430914;6597.439217666552;6603.867922641521;6333.145025421693;6390.5526613136635;6394.968025159845;6397.104405383343;6397.4562162216735;6298.842528936813;6325.746970121144;6396.520260980538;6452.677366131768;6463.806085817433;6223.813285601439;6284.308726040041;6310.968445157745;6311.053341998737;6319.46284565817;6316.7157477914525;6330.683465826783;6337.524685648503;6346.238451385863;6353.745850165941;4880.951190488192;6162.753489860355;6258.468030217483;6270.0908368287255;6273.278572963985;6107.310189946737;6142.191841058572;6180.6600636965395;6184.938150618436;6219.751209951552;6209.130721698875;6211.16149319836;6221.222347206599;6234.314225435108;6238.064290356301;6188.504919606331;6256.217972753406;6259.96870015647;6268.059791031382;6275.623462592259;6044.969775151096;6056.818295451144;6119.076065312483;6124.601900876429;6184.628922264498 08:35:45 INFO - PROCESS | 1653 | |1;ext.html;468.197042072845;539.8110661268556;540.8458589302049;552.3509875895821;567.1549391406802;29431.70568294319;33405;40259.59740402599;41493;41574;43412;43823.78088109563;43884.341734874004;43896.12207755843;44145;9470.242380609568;9608.135267825894;9639.277054220962;9652.131308182263;9667.226621870268;8847.601857916408;9082.591283392263;11658.941705291461;11819.645410637695;11859.110566707532;11714.121440891968;11775.646730598095;11785.764284714343;11797.587084452045;11806.704832379173;11790.997765189926;11897.405129743565;11898.286102833814;11908.702282442922;11913.463894124785;11627.360495172763;11694.824577631342;11702.239354441934;11708.297502149899;11710.121740869468;40753.796231018656;41111.1777764446;41127.383089253686;41187.7940610298;41198.38202426966;3224.758143139274;3352.094934367707;3462.9826850865584;3502.369573476773;4019.3970904364287;24004.7599524006;28820.991265305613;29706.40587188244;31558.526622100686;31718.682813171803;3177.8569964351427;3234.7897386669792;3281.704646581819;3410.1133705236816;3416.538767266412;505583.47208263725;507397.46301268257;507515;507643.99999999633;508137;64187.71624567483;64283.35716642867;64381.67809160924;64924.35075649278;64997.675011625586;66307;66426.66786666035;66446.33553664498;66495.66752166208;66498.33501664922;16954.982701037978;17135.400260991053;17150.39973600943;17158.914205429144;17210.91394543019;11892.04863610909;13083.738325233633;13168.012399070109;13177;13207.339633018311;15448;15913.204339782964;17584.64830703379;17847;18068.90965545164;6963.408110310579;6999.790006299819;7014.579125252501;7035.437165026786;7074.823129421806;861.8104017116225;938.7934654376027;958.8945216026372;969.5443141723379;1060.6977011551826;28990.985315513855;30184.54723179154;30289;30477;30542.235337514063;910.6311943662827;949.5442187749919;980.2745967983641;1030.3302853145515;1053.0522529723157;13823.51617693396;13868.583942481742;14622.634434139232;14963.850361496463;16654.50036498907;637641;642969;643111;643871.5612843812;845505;46126;48785.780355490686;60256.39743602595;60265;63803;1266.670665626962;1350.9121907076205;1353.4315587453293;1387.8265216847894;1394.532831501438;28509.572356414257;31254.218644533157;31787.364252715277;31856;32813;52751.94496110133;53010.46989530055;53062.73468632632;53076.93846123133;53086.73456632692;560363;563514.1824291017;563525;563719;564129;26886.731132688423;27179;27377.315567110185;27547;27571.31071723223;47050.05899882052;47434.3397981069;48074.03851923012;48396.27405588848;48582;38651.420228697156;39175.804120980356;39492.40761388524;39548.81353559398;41081.589184107776;35734;38604.80697596494;38790.6120938787;39834.60165398309;40110.59889401068;38865.805670971466;39589.40615890706;39610.60389396069;39773;39810.800945995084;31142.22144446407;31750.888718894726;34326.82836585901;34997;35127.29745405026;25441.36396590026;25532.23403297904;25705.61441578415;25851.19041667065;26007.349816254744 08:35:45 INFO - PROCESS | 1653 | |2;jquery.html;357.07517529598346;366.1541838353403;377.7129381669932;390.233191778156;402.68992875485856;19391.903040484794;20412.591748165047;20435.386938391835;20898.791012089874;21109.366718998415;20734.274300399487;20893.582128357422;21056.157753689833;21237.256696015644;21257.68113478299;4748.620110391178;5833.7958171464115;6072.696365181745;6151.938480615181;6167.599106058092;6041.6375017499095;6131.7240724167295;6138.447539721425;6140.7850725224625;6147.047207682816;5803.245578074844;5965.373635768247;6046.365131661179;6067.787627433041;6069.726862291208;4716.622670186377;5124.410692770304;6018.458338749511;6093.664848433335;6100.054491553817;5091.8981620367385;5252.448492908228;5262.815801446931;5265.710385928773;5266.605004624668;24705.135320263886;24857.627135592982;24938.5012299753;25021.62467562988;25175.99296028157;2249.201533455632;2360.8229382796358;2378.1795280628157;2410.5660981023407;2477.9008839646394;14296.070755400866;15543.911926165172;15947.282372293159;16047.985400950329;16365.181740913025;1806.8735188536807;1878.5021969178179;1879.5019319880244;1902.457799527142;1914.9138288777037;115742;116383;118270.40864795707;122040.38979805044;122235.38882305531;10783.78432431347;10845.457727113771;11317.94341028306;11336.659900203007;11549.307041577533;14320.713585728226;14336.354864031144;14340.067895586753;14342.21117838508;14364.994450388582;8479.872801907977;8737.082606326372;8785.912140878638;8876.689315874042;8911.019787823334;8655.221030107321;8665.35009874262;8668.393212475192;8850.159234872677;8869.246114080246;6635.435987940982;6806.149231346082;6811.897821532681;6813.977903314542;6815.931840681629;1621.9189040547926;1737.4700716281402;1900.6958886578082;1914.4735197820432;1915.79884112169;766.5167900113298;833.9658823059362;881.9426737262057;975.3075316525204;977.4721650308753;21776.782232177477;22234.444138896655;22474.32577022692;22606.66090008651;22611.547769044526;906.6373450619673;953.6791543712009;955.2978560757838;974.8294048541477;978.2663002747939;8962.910370896208;11123.833142502868;11615.419229038514;11804.822927656092;11811.409429528489;583149;585763;588415.2896177544;592693;605110;80116.5994170037;80280;90119.09880901239;95839.52080239553;119535.40232298782;934.45334479329;956.1824639932896;1002.2132625888643;1007.3401921741271;1008.8436292374694;19467.221311147394;19984.800151998294;20057.613454377642;20156.182255821903;20275.59448810986;51780.44658660246;52356;52524.212136817216;53061;53732;73657.6317118411;75178.62410687911;75842.62078689571;78047.21952780627;78260.60869695614;7983.560904150328;8022.27799498048;8221.260086592236;8304.83390332202;8388.70639527638;12920.806187907378;13018.414171362121;13220.669483262995;13265.933670331586;13658.726825463635;11134.944325278322;11302.717432064264;11444.313341199555;11780.587679431179;11798.823017654571;11144.164187685794;11324.207305488537;11351.179916152103;11558.133140014701;11774.058075354122;11570.76858462843;11633.243839150427;11712.297262164297;11788.528458861892;11854.40727963581;8076.27313541784;8160.30637395828;8244.093149753402;8299.419040667095;8354.665813367397;11282.210245282751;11405.714857128638;11462.025727813229;11566.595169169039;11588.594399195988 08:35:45 INFO - PROCESS | 1653 | |3;mootools.html;1359.2388262572954;1499.6625759204178;1521.1025494957973;1689.7972243330803;1863.7297591849174;7346.4122870170395;7709.961450192748;8069.435139540235;8078.272955434017;8255.545944973024;8029.116797152323;8091.190880911906;8101.513909165455;8111.188881111901;8128.837423251546;2113.6723807809776;2239.1826983151195;2341.508283260517;2342.824288178385;2345.777151170636;2310.6765052892524;2358.7169539655265;2361.161787565415;2370.8696021718797;2374.976250237493;2293.8508996915148;2308.1805958884606;2326.685897403846;2329.743728189898;2333.591621466245;2037.7467857267823;2189.2665956904298;2260.638297872341;2320.060375547906;2325.4651430171157;2329.0450915124716;2349.283468542094;2352.7059117610297;2356.7761062699014;2361.53949979754;8133.837323253561;8168.06067302256;8225.424220304581;8231.794205144859;8248.175182481764;4977.054359671651;4982.750862456863;5144.279800827887;5148.871278218037;5153.9742301288625;3463.3939060664284;3555.484454754072;3559.3771090059395;3565.5008298838184;3566.465030245458;980.3970558106785;1010.8584798128268;1063.4363787192801;1110.5280255891214;1118.2954738514684;10635.94682026585;10717.35695858251;10749.086327662159;10750.086242669382;10757.246992710514;4071.694622903294;4283.100548884707;4306.289462238696;4338.219120558267;4401.537838526972;8366.247037766509;8377.413581049268;8379.95810020946;8394.412391132562;8394.538300393537;4966.329545511382;4966.975165124223;4972.229304457815;4972.279019542146;4974.925376119361;3937.3897045957924;4282.657387409;4301.268784306675;4662.603678687282;4663.51033141522;3616.788375894105;3631.6913062389463;3721.6092310307567;3733.906652333659;3735.9626403736156;952.842780941137;1134.9319040857574;1141.9143564232716;1145.1754736589808;1148.4602236948622;808.5189312359137;888.2804928008334;905.6513242401722;907.1971305394774;944.3059351376733;5354.571634269249;5581.845290037568;5582.27430434041;5652.406497317723;5778.566607504454;445.8216713314635;457.65447087448763;464.5563486870031;469.05485446824673;470.4237309296085;3371.258323168899;3737.1591391936595;3741.8129093545213;3777.4522694209186;3813.694904407641;8713;9702.854457183148;9815.312928094965;10080.495975201356;10097.394156350496;9317.44095354281;9565.856512152322;9571.712848614552;10054.095131438205;10064.496775161213;7380.9261907381315;7701.807454813675;7707.768766937001;7725.884111738328;7736.4584479085925;5228.7973766033265;5282.9471705283995;5344.331958505187;5790.131480277992;5872.559558033079;8938.776530586787;9164.358494905293;9184.265258779415;9298.116678915492;9328.78725765646;8901.465912045298;9061.275097992013;9267.212286955684;9401.34190606651;9429.481378523973;7585.544867307979;7665.195154508696;7690.730824421118;7702.884456733042;7781;7715.537067775951;7778.105517865291;7788.493747906368;7791.415643826849;7810.414218933716;6584.242812076673;6960.443164546926;7091.2554181810165;7112.395446387115;7146.892796608159;6812.523123381514;6813.4549236061985;6854.931450685429;6862.691178896862;6965.825854353681;6400.839979000562;6476.4495017924;6562.179727534059;6574.4740420765265;6579.046038324512;4596.701214421052;4644.58198762113;4683.742394168217;4713.080949215007;4812.989272252726;4697;4775.47469778331;4786.1624215762795;4814.422269327703;4868.464468908346 08:35:45 INFO - PROCESS | 1653 | |4;prototype.html;282.32101795182587;308.77150908327815;317.7140573483864;320.86363295599364;324.41119368346466;4516.661250406216;5121.692698438096;5129.410117836441;5141.151709967856;5152.896942061157;4819.710817350961;4887.731174785395;4987.8254261100865;5098.898022039557;5141.922871156936;3992.7005474589378;4013.8595149169787;4014.478117844676;4036.9798151009204;4064.9187016259657;3861.58650843223;3984.5417776955587;4010.5509262034625;4016.6987475939422;4022.839086436539;3283.4910588858647;3928.351821949375;3935.7048221383366;4002.739821911581;4007.438958545791;3283.835808209592;3889.4165875118674;3973.662238709684;3987.601239876018;3991.1818077294083;2661.188337557044;2887.56686497025;2940.6324209473814;3249.5775549178456;3353.782004169721;4969.453360130383;4971.7762700678195;4974.37820272466;4980.975095124538;4987.800487980477;3869.1487872667967;4217.725847819913;4413.337999300099;4451.910961780746;4462.732236065814;5068;5338.065838478251;5402.432744561843;5435.891282174374;5463.644863083887;3327.3345330933666;3613.241219343941;3733.5519737631384;3782.0544863784053;3792;5628.705397758538;5664.801731939404;5681.431856814327;5710.743016564223;5727.713614319267;3213.951790723141;3661.487391765155;3823.3118038752737;3828.1960788234783;3842.634949679776;3177.3009937813645;3591.4074177760376;3854.730168888207;3877.3796192609047;3879.4568760373572;3658.359787037258;4411.889702757457;4445.088756804847;4450.265706158512;4456.286994080931;5452.890942181213;5456.91814622781;5478.794665173735;5501;5528.723563821793;1163.6043745126697;1200.033972652006;1237.9442925068213;1242.167747609104;1255.6546949588935;778.7936196907824;844.7001314533375;849.4987957105337;852.4075767341639;867.2671592504324;4073.3889916512762;4110.917781644351;4489.485887902785;4660.347551342815;4810.921010553248;4345.717528360647;4464.973056197093;4468.888277793016;5181.2746215529105;5282.550983166397;4365.323374876899;4393.747781882148;4785.49752276013;4831.806727730851;4887.218045112765;2391.8564886106888;2407;2672.104844876988;2769.459955308736;2776.7778577713734;4575.748333841604;4781.708938586562;5087.516685914832;5518.365387980353;5521.503064724194;5088.516590923857;5285.471452854684;5365.919511207335;5437.483439073281;5474.7262636868;4463.799129039201;4751.671680876346;5396.576440677094;5405.837824865261;5509.256250406143;4851.830185943475;5134.820281290137;5278.047122564676;5288.603354748486;5303.867403314948;4413.977930110329;4864.175934024741;5196.5449674091315;5224.764885580082;5258.342707161605;4876.292937523968;5012.523810238022;5189.624749441326;5422.481705122572;5486.406403805514;2990.626171728534;3202.9359412812078;3220.790648607833;3591.676749092594;3617.7286703496816;4788.377510923697;4820.987592605452;5206.921896171485;5258.685328667833;5284.916592098533;4395.956040439554;4471.8434854779925;4831.903361932812;5372.758225879923;5391.784328626811;4613.700109492872;4977.9751101244265;5015.047141043336;5413.269208656939;5514.593778586434;4682.484926658133;5115.7953681852305;5178.663386879841;5292.41783403833;5322.201669749568;4283.935740963826;4624.1445332613575;5084.466131056186;5398.784048638167;5413.864653383697;4606.08847328355;4638.791254393493;5140.121531942124;5303.734813259244;5303.7878484860175 08:35:45 INFO - PROCESS | 1653 | |5;yui.html;676.7428377216656;688.9069975553299;713.7323503686117;751.8947347371369;815.4943934760447;14179.787303190447;15226.619334516643;15239.542813715592;15273.159976201305;15288.541343759678;13622.386992585332;13826.170429774196;13831.79252311216;13833.754962053414;13840.031197816157;696.0811728518357;714.8963400306978;847.4915050969431;853.4111463090479;868.700298397052;849.6304107713133;858.9441686290403;863.654538184728;865.8268346330727;867.9757885694878;924.4961495984671;924.7780532672144;927.3786563002805;927.4528028463205;931.6552875436098;924.6671198368615;925.0564424287256;925.2274350916992;925.4401087342128;925.5418567808911;678.9083473731032;680.5032326401705;683.3542302524116;683.8803209438378;684.0662495693343;14417.495387661487;14661.70676586473;14778.261086945717;14822.777658335133;14856.851431485655;13225;14012.859871401257;14107.012509124366;14165.291735413291;14234.644133896736;11409.771804563945;11412.54349826006;11516.884831151749;11754.412279385997;11839.94080029603;3689.3543629864666;3749.7750134991716;3767.868124615625;3801.82891769871;3851.171998020411;77076.07309817243;86766.56616716876;90475;94199;94510;9121.024955347768;10607.787844243072;10685.893141068489;10742.892571074346;10757;19842.305519306756;21205.257815976365;21208.681869771965;21223.363299101053;21239.044243009103;7807.531548107132;7844.686212551434;7846.882296765439;7870.173631768582;8101.149379315205;4302.7633480158265;4329.177456283296;4428.424304840414;4443.4445694288215;4562.58936695699;3176.9205769855475;3245.7403407727325;3280.3603297356785;3286.392017476727;3288.8026718396495;532.6724064700181;614.443928244939;623.3859648246473;633.7876811268277;636.9808905732835;575.5683237571822;598.5989387110646;613.6716856481761;620.5935112501319;632.838626150338;8168.9183108169345;8630;8703.95648021756;8763.386562940661;8951.149640784115;498.5986281043722;568.9632060530529;635.3246469175796;637.7735903754101;658.1016911915201;4072.129148949983;4204.705670603028;4270.316749320094;4289.506706728704;4313.741175529478;74727;76697.61651191708;84736.57631711802;111351;118767;74263.62868185625;91458;92698;93030;99936;89248.10751892527;89529.55235223782;90312.09687903037;91440;95672;8445.1977062179;9452.763680907758;9588.280878933969;9673;9716.951415242878;32117.67882321147;40586.39120413255;49920.50079499158;52035.21947170871;52221;73769.89345159935;78012;79335.20664793278;79370.52989883289;79438.6028069856;12090.06801908149;12103.697407564528;12299.323537205539;12513.624591262276;12959.416826242654;13868.306584670929;14409.351579179172;14418.42326306936;14589.781153282496;14819.25903704832;13227.86772132305;13893;13896.37466313998;14187.64530886736;14462.85537144615;13328.200307981551;13716;13988.440462381392;14001.859981400463;14174.291285435893;12685.80971285413;13343.933280333536;13436.664083397993;13509;14056.78914816299;10664.413457259925;10972.670819875417;10976.341419514536;11184.496697648789;11199.272047316897;10671.146308295163;11300.434978251218;11585.131115166228;11618.70953226176;11626.76746465083 08:35:45 INFO - PROCESS | 1653 | __end_tp_report 08:35:45 INFO - PROCESS | 1653 | __start_cc_report 08:35:45 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1453 08:35:45 INFO - PROCESS | 1653 | __end_cc_report 08:35:45 INFO - PROCESS | 1653 | __startTimestamp1487954145188__endTimestamp 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:35:45 INFO - PROCESS | 1653 | Number of tests: 6 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5871.48 Median:6107.31 stddev:642.94 (10.5%) stddev-sans-first:606.52 08:35:45 INFO - PROCESS | 1653 | Values: 3081.3 3495.9 3505.9 3520.0 3569.9 5784.4 5906.4 5920.8 5923.3 5951.1 5798.2 5884.9 5945.1 5949.9 5958.6 5324.4 5360.9 5419.0 5443.7 5467.4 5206.3 5310.4 5327.5 5336.6 5350.9 5390.2 5468.3 5468.9 5477.2 5514.0 5454.3 5456.5 5473.9 5477.7 5479.2 5228.7 5249.8 5318.3 5431.8 5442.3 5804.3 5824.2 5836.0 5842.6 5844.0 6215.1 6222.7 6243.5 6279.9 6284.8 5264.9 6328.7 6343.1 6368.4 6384.6 6059.6 6065.4 6067.2 6080.4 6097.9 6270.3 6319.6 6386.1 6398.0 6473.7 6038.9 6298.9 6303.3 6310.9 6315.3 5537.9 6356.3 6358.1 6385.1 6398.0 6191.0 6198.5 6240.6 6278.1 6279.2 5287.4 6261.1 6266.0 6267.9 6284.4 4987.3 5082.9 5098.2 5109.0 5112.1 4521.7 4522.0 4546.1 4557.2 4603.7 6007.8 6067.4 6093.8 6094.3 6126.8 5239.6 6326.5 6372.0 6398.9 6399.6 5817.3 6030.2 6034.3 6044.2 6044.3 5505.5 5531.3 5568.1 5597.3 5597.9 6581.2 6583.2 6596.4 6597.4 6603.9 6333.1 6390.6 6395.0 6397.1 6397.5 6298.8 6325.7 6396.5 6452.7 6463.8 6223.8 6284.3 6311.0 6311.1 6319.5 6316.7 6330.7 6337.5 6346.2 6353.7 4881.0 6162.8 6258.5 6270.1 6273.3 6107.3 6142.2 6180.7 6184.9 6219.8 6209.1 6211.2 6221.2 6234.3 6238.1 6188.5 6256.2 6260.0 6268.1 6275.6 6045.0 6056.8 6119.1 6124.6 6184.6 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:72016.36 Median:38828.21 stddev:157996.69 (406.9%) stddev-sans-first:158348.59 08:35:45 INFO - PROCESS | 1653 | Values: 468.2 539.8 540.8 552.4 567.2 29431.7 33405.0 40259.6 41493.0 41574.0 43412.0 43823.8 43884.3 43896.1 44145.0 9470.2 9608.1 9639.3 9652.1 9667.2 8847.6 9082.6 11658.9 11819.6 11859.1 11714.1 11775.6 11785.8 11797.6 11806.7 11791.0 11897.4 11898.3 11908.7 11913.5 11627.4 11694.8 11702.2 11708.3 11710.1 40753.8 41111.2 41127.4 41187.8 41198.4 3224.8 3352.1 3463.0 3502.4 4019.4 24004.8 28821.0 29706.4 31558.5 31718.7 3177.9 3234.8 3281.7 3410.1 3416.5 505583.5 507397.5 507515.0 507644.0 508137.0 64187.7 64283.4 64381.7 64924.4 64997.7 66307.0 66426.7 66446.3 66495.7 66498.3 16955.0 17135.4 17150.4 17158.9 17210.9 11892.0 13083.7 13168.0 13177.0 13207.3 15448.0 15913.2 17584.6 17847.0 18068.9 6963.4 6999.8 7014.6 7035.4 7074.8 861.8 938.8 958.9 969.5 1060.7 28991.0 30184.5 30289.0 30477.0 30542.2 910.6 949.5 980.3 1030.3 1053.1 13823.5 13868.6 14622.6 14963.9 16654.5 637641.0 642969.0 643111.0 643871.6 845505.0 46126.0 48785.8 60256.4 60265.0 63803.0 1266.7 1350.9 1353.4 1387.8 1394.5 28509.6 31254.2 31787.4 31856.0 32813.0 52751.9 53010.5 53062.7 53076.9 53086.7 560363.0 563514.2 563525.0 563719.0 564129.0 26886.7 27179.0 27377.3 27547.0 27571.3 47050.1 47434.3 48074.0 48396.3 48582.0 38651.4 39175.8 39492.4 39548.8 41081.6 35734.0 38604.8 38790.6 39834.6 40110.6 38865.8 39589.4 39610.6 39773.0 39810.8 31142.2 31750.9 34326.8 34997.0 35127.3 25441.4 25532.2 25705.6 25851.2 26007.3 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:34194.64 Median:24980.06 stddev:97912.67 (392.0%) stddev-sans-first:98154.37 08:35:45 INFO - PROCESS | 1653 | Values: 357.1 366.2 377.7 390.2 402.7 19391.9 20412.6 20435.4 20898.8 21109.4 20734.3 20893.6 21056.2 21237.3 21257.7 4748.6 5833.8 6072.7 6151.9 6167.6 6041.6 6131.7 6138.4 6140.8 6147.0 5803.2 5965.4 6046.4 6067.8 6069.7 4716.6 5124.4 6018.5 6093.7 6100.1 5091.9 5252.4 5262.8 5265.7 5266.6 24705.1 24857.6 24938.5 25021.6 25176.0 2249.2 2360.8 2378.2 2410.6 2477.9 14296.1 15543.9 15947.3 16048.0 16365.2 1806.9 1878.5 1879.5 1902.5 1914.9 115742.0 116383.0 118270.4 122040.4 122235.4 10783.8 10845.5 11317.9 11336.7 11549.3 14320.7 14336.4 14340.1 14342.2 14365.0 8479.9 8737.1 8785.9 8876.7 8911.0 8655.2 8665.4 8668.4 8850.2 8869.2 6635.4 6806.1 6811.9 6814.0 6815.9 1621.9 1737.5 1900.7 1914.5 1915.8 766.5 834.0 881.9 975.3 977.5 21776.8 22234.4 22474.3 22606.7 22611.5 906.6 953.7 955.3 974.8 978.3 8962.9 11123.8 11615.4 11804.8 11811.4 583149.0 585763.0 588415.3 592693.0 605110.0 80116.6 80280.0 90119.1 95839.5 119535.4 934.5 956.2 1002.2 1007.3 1008.8 19467.2 19984.8 20057.6 20156.2 20275.6 51780.4 52356.0 52524.2 53061.0 53732.0 73657.6 75178.6 75842.6 78047.2 78260.6 7983.6 8022.3 8221.3 8304.8 8388.7 12920.8 13018.4 13220.7 13265.9 13658.7 11134.9 11302.7 11444.3 11780.6 11798.8 11144.2 11324.2 11351.2 11558.1 11774.1 11570.8 11633.2 11712.3 11788.5 11854.4 8076.3 8160.3 8244.1 8299.4 8354.7 11282.2 11405.7 11462.0 11566.6 11588.6 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5315.92 Median:4973.60 stddev:2914.38 (58.6%) stddev-sans-first:2907.38 08:35:45 INFO - PROCESS | 1653 | Values: 1359.2 1499.7 1521.1 1689.8 1863.7 7346.4 7710.0 8069.4 8078.3 8255.5 8029.1 8091.2 8101.5 8111.2 8128.8 2113.7 2239.2 2341.5 2342.8 2345.8 2310.7 2358.7 2361.2 2370.9 2375.0 2293.9 2308.2 2326.7 2329.7 2333.6 2037.7 2189.3 2260.6 2320.1 2325.5 2329.0 2349.3 2352.7 2356.8 2361.5 8133.8 8168.1 8225.4 8231.8 8248.2 4977.1 4982.8 5144.3 5148.9 5154.0 3463.4 3555.5 3559.4 3565.5 3566.5 980.4 1010.9 1063.4 1110.5 1118.3 10635.9 10717.4 10749.1 10750.1 10757.2 4071.7 4283.1 4306.3 4338.2 4401.5 8366.2 8377.4 8380.0 8394.4 8394.5 4966.3 4967.0 4972.2 4972.3 4974.9 3937.4 4282.7 4301.3 4662.6 4663.5 3616.8 3631.7 3721.6 3733.9 3736.0 952.8 1134.9 1141.9 1145.2 1148.5 808.5 888.3 905.7 907.2 944.3 5354.6 5581.8 5582.3 5652.4 5778.6 445.8 457.7 464.6 469.1 470.4 3371.3 3737.2 3741.8 3777.5 3813.7 8713.0 9702.9 9815.3 10080.5 10097.4 9317.4 9565.9 9571.7 10054.1 10064.5 7380.9 7701.8 7707.8 7725.9 7736.5 5228.8 5282.9 5344.3 5790.1 5872.6 8938.8 9164.4 9184.3 9298.1 9328.8 8901.5 9061.3 9267.2 9401.3 9429.5 7585.5 7665.2 7690.7 7702.9 7781.0 7715.5 7778.1 7788.5 7791.4 7810.4 6584.2 6960.4 7091.3 7112.4 7146.9 6812.5 6813.5 6854.9 6862.7 6965.8 6400.8 6476.4 6562.2 6574.5 6579.0 4596.7 4644.6 4683.7 4713.1 4813.0 4697.0 4775.5 4786.2 4814.4 4868.5 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4247.25 Median:4717.08 stddev:1300.68 (27.6%) stddev-sans-first:1269.83 08:35:45 INFO - PROCESS | 1653 | Values: 282.3 308.8 317.7 320.9 324.4 4516.7 5121.7 5129.4 5141.2 5152.9 4819.7 4887.7 4987.8 5098.9 5141.9 3992.7 4013.9 4014.5 4037.0 4064.9 3861.6 3984.5 4010.6 4016.7 4022.8 3283.5 3928.4 3935.7 4002.7 4007.4 3283.8 3889.4 3973.7 3987.6 3991.2 2661.2 2887.6 2940.6 3249.6 3353.8 4969.5 4971.8 4974.4 4981.0 4987.8 3869.1 4217.7 4413.3 4451.9 4462.7 5068.0 5338.1 5402.4 5435.9 5463.6 3327.3 3613.2 3733.6 3782.1 3792.0 5628.7 5664.8 5681.4 5710.7 5727.7 3214.0 3661.5 3823.3 3828.2 3842.6 3177.3 3591.4 3854.7 3877.4 3879.5 3658.4 4411.9 4445.1 4450.3 4456.3 5452.9 5456.9 5478.8 5501.0 5528.7 1163.6 1200.0 1237.9 1242.2 1255.7 778.8 844.7 849.5 852.4 867.3 4073.4 4110.9 4489.5 4660.3 4810.9 4345.7 4465.0 4468.9 5181.3 5282.6 4365.3 4393.7 4785.5 4831.8 4887.2 2391.9 2407.0 2672.1 2769.5 2776.8 4575.7 4781.7 5087.5 5518.4 5521.5 5088.5 5285.5 5365.9 5437.5 5474.7 4463.8 4751.7 5396.6 5405.8 5509.3 4851.8 5134.8 5278.0 5288.6 5303.9 4414.0 4864.2 5196.5 5224.8 5258.3 4876.3 5012.5 5189.6 5422.5 5486.4 2990.6 3202.9 3220.8 3591.7 3617.7 4788.4 4821.0 5206.9 5258.7 5284.9 4396.0 4471.8 4831.9 5372.8 5391.8 4613.7 4978.0 5015.0 5413.3 5514.6 4682.5 5115.8 5178.7 5292.4 5322.2 4283.9 4624.1 5084.5 5398.8 5413.9 4606.1 4638.8 5140.1 5303.7 5303.8 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:20161.65 Median:4435.93 stddev:28962.04 (652.9%) stddev-sans-first:29006.34 08:35:45 INFO - PROCESS | 1653 | Values: 676.7 688.9 713.7 751.9 815.5 14179.8 15226.6 15239.5 15273.2 15288.5 13622.4 13826.2 13831.8 13833.8 13840.0 696.1 714.9 847.5 853.4 868.7 849.6 858.9 863.7 865.8 868.0 924.5 924.8 927.4 927.5 931.7 924.7 925.1 925.2 925.4 925.5 678.9 680.5 683.4 683.9 684.1 14417.5 14661.7 14778.3 14822.8 14856.9 13225.0 14012.9 14107.0 14165.3 14234.6 11409.8 11412.5 11516.9 11754.4 11839.9 3689.4 3749.8 3767.9 3801.8 3851.2 77076.1 86766.6 90475.0 94199.0 94510.0 9121.0 10607.8 10685.9 10742.9 10757.0 19842.3 21205.3 21208.7 21223.4 21239.0 7807.5 7844.7 7846.9 7870.2 8101.1 4302.8 4329.2 4428.4 4443.4 4562.6 3176.9 3245.7 3280.4 3286.4 3288.8 532.7 614.4 623.4 633.8 637.0 575.6 598.6 613.7 620.6 632.8 8168.9 8630.0 8704.0 8763.4 8951.1 498.6 569.0 635.3 637.8 658.1 4072.1 4204.7 4270.3 4289.5 4313.7 74727.0 76697.6 84736.6 111351.0 118767.0 74263.6 91458.0 92698.0 93030.0 99936.0 89248.1 89529.6 90312.1 91440.0 95672.0 8445.2 9452.8 9588.3 9673.0 9717.0 32117.7 40586.4 49920.5 52035.2 52221.0 73769.9 78012.0 79335.2 79370.5 79438.6 12090.1 12103.7 12299.3 12513.6 12959.4 13868.3 14409.4 14418.4 14589.8 14819.3 13227.9 13893.0 13896.4 14187.6 14462.9 13328.2 13716.0 13988.4 14001.9 14174.3 12685.8 13343.9 13436.7 13509.0 14056.8 10664.4 10972.7 10976.3 11184.5 11199.3 10671.1 11300.4 11585.1 11618.7 11626.8 08:35:45 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:35:45 INFO - PROCESS | 1653 | 08:35:45 INFO - TEST-INFO | 1653: exit 0 08:35:45 INFO - TEST-OK | dromaeo_css | took 1118952ms 08:35:45 INFO - TEST-START | kraken 08:35:45 INFO - operating with platform_type : mac_ 08:35:45 INFO - Initialising browser for kraken test... 08:35:45 INFO - TEST-INFO | started process 1775 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpWS5nbf/profile http://localhost:49237/getInfo.html) 08:35:48 INFO - PROCESS | 1775 | __metrics Screen width/height:1600/1200 08:35:48 INFO - PROCESS | 1775 | colorDepth:24 08:35:48 INFO - PROCESS | 1775 | Browser inner width/height: 1024/689 08:35:48 INFO - PROCESS | 1775 | __metrics 08:35:48 INFO - PROCESS | 1775 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:35:48 INFO - PROCESS | 1775 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:49 INFO - TEST-INFO | 1775: exit 0 08:35:49 INFO - Browser initialized. 08:35:49 INFO - Running cycle 1/1 for kraken test... 08:35:49 INFO - TEST-INFO | started process 1777 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpWS5nbf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:01 INFO - PROCESS | 1777 | RSS: Main: 167862272 08:36:01 INFO - PROCESS | 1777 | 08:36:03 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:04 INFO - PROCESS | 1777 | RSS: Main: 217993216 08:36:04 INFO - PROCESS | 1777 | 08:36:07 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 08:36:07 INFO - PROCESS | 1777 | RSS: Main: 231641088 08:36:07 INFO - PROCESS | 1777 | 08:36:11 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 08:36:11 INFO - PROCESS | 1777 | RSS: Main: 328609792 08:36:11 INFO - PROCESS | 1777 | 08:36:13 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 08:36:14 INFO - PROCESS | 1777 | RSS: Main: 231936000 08:36:14 INFO - PROCESS | 1777 | 08:36:16 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:16 INFO - PROCESS | 1777 | RSS: Main: 233263104 08:36:16 INFO - PROCESS | 1777 | 08:36:19 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:20 INFO - PROCESS | 1777 | RSS: Main: 271151104 08:36:20 INFO - PROCESS | 1777 | 08:36:23 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:23 INFO - PROCESS | 1777 | RSS: Main: 271900672 08:36:23 INFO - PROCESS | 1777 | 08:36:26 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 08:36:27 INFO - PROCESS | 1777 | RSS: Main: 270024704 08:36:27 INFO - PROCESS | 1777 | 08:36:28 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:29 INFO - PROCESS | 1777 | RSS: Main: 249794560 08:36:29 INFO - PROCESS | 1777 | 08:36:31 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:31 INFO - PROCESS | 1777 | RSS: Main: 250474496 08:36:31 INFO - PROCESS | 1777 | 08:36:33 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:34 INFO - PROCESS | 1777 | RSS: Main: 253235200 08:36:34 INFO - PROCESS | 1777 | 08:36:37 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:37 INFO - PROCESS | 1777 | RSS: Main: 271101952 08:36:37 INFO - PROCESS | 1777 | 08:36:40 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:41 INFO - PROCESS | 1777 | RSS: Main: 264011776 08:36:41 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 08:36:43 INFO - PROCESS | 1777 | RSS: Main: 308117504 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | __start_tp_report 08:36:43 INFO - PROCESS | 1777 | _x_x_mozilla_page_load 08:36:43 INFO - PROCESS | 1777 | _x_x_mozilla_page_load_details 08:36:43 INFO - PROCESS | 1777 | |i|pagename|runs| 08:36:43 INFO - PROCESS | 1777 | |0;ai-astar;102;114;114;112;114;114;113;115;114;114 08:36:43 INFO - PROCESS | 1777 | |1;audio-beat-detection;142;108;107;163;140;108;107;107;135;107 08:36:43 INFO - PROCESS | 1777 | |2;audio-dft;182;182;180;183;179;182;181;182;183;186 08:36:43 INFO - PROCESS | 1777 | |3;audio-fft;76;57;59;88;60;61;58;59;83;77 08:36:43 INFO - PROCESS | 1777 | |4;audio-oscillator;82;68;93;70;68;69;88;67;68;90 08:36:43 INFO - PROCESS | 1777 | |5;imaging-gaussian-blur;89;85;89;86;88;90;136;87;89;85 08:36:43 INFO - PROCESS | 1777 | |6;imaging-darkroom;147;112;94;95;94;95;95;95;95;94 08:36:43 INFO - PROCESS | 1777 | |7;imaging-desaturate;83;82;79;82;79;83;82;85;83;83 08:36:43 INFO - PROCESS | 1777 | |8;json-parse-financial;45;42;43;49;61;65;72;87;87;85 08:36:43 INFO - PROCESS | 1777 | |9;json-stringify-tinderbox;64;68;68;74;71;68;69;68;68;68 08:36:43 INFO - PROCESS | 1777 | |10;stanford-crypto-aes;83;80;81;82;84;80;82;81;82;81 08:36:43 INFO - PROCESS | 1777 | |11;stanford-crypto-ccm;139;135;135;136;135;139;135;136;183;138 08:36:43 INFO - PROCESS | 1777 | |12;stanford-crypto-pbkdf2;166;167;165;164;166;164;168;182;165;166 08:36:43 INFO - PROCESS | 1777 | |13;stanford-crypto-sha256-iterative;67;68;67;66;66;66;65;66;65;66 08:36:43 INFO - PROCESS | 1777 | __end_tp_report 08:36:43 INFO - PROCESS | 1777 | __start_cc_report 08:36:43 INFO - PROCESS | 1777 | _x_x_mozilla_cycle_collect,1966 08:36:43 INFO - PROCESS | 1777 | __end_cc_report 08:36:43 INFO - PROCESS | 1777 | __startTimestamp1487954203351__endTimestamp 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | ------- Summary: start ------- 08:36:43 INFO - PROCESS | 1777 | Number of tests: 14 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.81 (3.3%) stddev-sans-first:0.83 08:36:43 INFO - PROCESS | 1777 | Values: 102.0 114.0 114.0 112.0 114.0 114.0 113.0 115.0 114.0 114.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:121.50 stddev:20.72 (17.1%) stddev-sans-first:20.73 08:36:43 INFO - PROCESS | 1777 | Values: 142.0 108.0 107.0 163.0 140.0 108.0 107.0 107.0 135.0 107.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#2] audio-dft Cycles:10 Average:182.00 Median:182.00 stddev:1.89 (1.0%) stddev-sans-first:2.00 08:36:43 INFO - PROCESS | 1777 | Values: 182.0 182.0 180.0 183.0 179.0 182.0 181.0 182.0 183.0 186.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#3] audio-fft Cycles:10 Average:67.80 Median:68.50 stddev:11.86 (17.3%) stddev-sans-first:12.20 08:36:43 INFO - PROCESS | 1777 | Values: 76.0 57.0 59.0 88.0 60.0 61.0 58.0 59.0 83.0 77.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:76.00 stddev:10.66 (14.0%) stddev-sans-first:11.10 08:36:43 INFO - PROCESS | 1777 | Values: 82.0 68.0 93.0 70.0 68.0 69.0 88.0 67.0 68.0 90.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:88.50 stddev:15.42 (17.4%) stddev-sans-first:16.31 08:36:43 INFO - PROCESS | 1777 | Values: 89.0 85.0 89.0 86.0 88.0 90.0 136.0 87.0 89.0 85.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:95.00 stddev:16.87 (17.8%) stddev-sans-first:5.81 08:36:43 INFO - PROCESS | 1777 | Values: 147.0 112.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#7] imaging-desaturate Cycles:10 Average:82.10 Median:83.00 stddev:1.85 (2.2%) stddev-sans-first:1.94 08:36:43 INFO - PROCESS | 1777 | Values: 83.0 82.0 79.0 82.0 79.0 83.0 82.0 85.0 83.0 83.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:68.50 stddev:18.51 (27.0%) stddev-sans-first:18.36 08:36:43 INFO - PROCESS | 1777 | Values: 45.0 42.0 43.0 49.0 61.0 65.0 72.0 87.0 87.0 85.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:2.55 (3.7%) stddev-sans-first:2.09 08:36:43 INFO - PROCESS | 1777 | Values: 64.0 68.0 68.0 74.0 71.0 68.0 69.0 68.0 68.0 68.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.26 (1.5%) stddev-sans-first:1.24 08:36:43 INFO - PROCESS | 1777 | Values: 83.0 80.0 81.0 82.0 84.0 80.0 82.0 81.0 82.0 81.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:137.00 stddev:14.81 (10.8%) stddev-sans-first:15.69 08:36:43 INFO - PROCESS | 1777 | Values: 139.0 135.0 135.0 136.0 135.0 139.0 135.0 136.0 183.0 138.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:166.00 stddev:5.31 (3.2%) stddev-sans-first:5.61 08:36:43 INFO - PROCESS | 1777 | Values: 166.0 167.0 165.0 164.0 166.0 164.0 168.0 182.0 165.0 166.0 08:36:43 INFO - PROCESS | 1777 | 08:36:43 INFO - PROCESS | 1777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 08:36:43 INFO - PROCESS | 1777 | Values: 67.0 68.0 67.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 08:36:43 INFO - PROCESS | 1777 | -------- Summary: end -------- 08:36:43 INFO - PROCESS | 1777 | 08:36:44 INFO - TEST-INFO | 1777: exit 0 08:36:44 INFO - TEST-OK | kraken | took 58761ms 08:36:44 INFO - SUITE-END | took 1177s 08:36:45 INFO - Completed test suite (00:19:38) 08:36:45 INFO - javascript benchmark 08:36:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.2913030003083, 3495.8951231463057, 3505.8597656093775, 3519.999999999999, 3569.9464508032383, 5784.363719990803, 5906.4388883056145, 5920.792772252972, 5923.3188183358925, 5951.13708512266, 5798.217240672508, 5884.911726324098, 5945.108233764938, 5949.940500594993, 5958.5828991970475, 5324.440933701963, 5360.892782144355, 5418.972905135469, 5443.673379597217, 5467.371252305996, 5206.3231779868565, 5310.415854256029, 5327.547158491513, 5336.573074154058, 5350.91973620396, 5390.245365648792, 5468.28912241408, 5468.890622187554, 5477.178423236506, 5514.035043867328, 5454.34547854256, 5456.536194423479, 5473.863153421156, 5477.698726570037, 5479.205515200313, 5228.738563071831, 5249.816256431007, 5318.335208098988, 5431.8098866539485, 5442.292501974757, 5804.2744656917885, 5824.155497452888, 5835.970820145914, 5842.620229685057, 5844.0, 6215.067739839015, 6222.719977601018, 6243.5005199584375, 6279.937200627981, 6284.842878928018, 5264.868378290574, 6328.683565821737, 6343.14367560378, 6368.426841584233, 6384.648844313561, 6059.575829691968, 6065.423784740487, 6067.18093057436, 6080.361562036011, 6097.878042439171, 6270.31026587075, 6319.58922670025, 6386.07401926718, 6398.0, 6473.741050358027, 6038.943184942617, 6298.874022519524, 6303.275123360872, 6310.9368906311265, 6315.305316415191, 5537.861553461115, 6356.269029061625, 6358.109864618957, 6385.074164246251, 6397.96801015992, 6191.0, 6198.473129783929, 6240.594361366497, 6278.089676996809, 6279.215098112736, 5287.391949925731, 6261.060840873814, 6265.96867015662, 6267.9373206268265, 6284.4344009039405, 4987.326710893983, 5082.923756143661, 5098.1842905135, 5109.0, 5112.079825631347, 4521.706089104197, 4522.005158865044, 4546.1135078659345, 4557.248054071041, 4603.700759450625, 6007.789727359522, 6067.362926892701, 6093.8476538086015, 6094.329623741385, 6126.754929802758, 5239.633225674243, 6326.493880489642, 6372.012338087604, 6398.8720225595225, 6399.648019358887, 5817.272840894888, 6030.216071910711, 6034.306054803666, 6044.214252147192, 6044.335123136451, 5505.476979686923, 5531.308586426697, 5568.081266591048, 5597.3003374578175, 5597.916031259534, 6581.177352830896, 6583.242927063449, 6596.406323430914, 6597.439217666552, 6603.867922641521, 6333.145025421693, 6390.5526613136635, 6394.968025159845, 6397.104405383343, 6397.4562162216735, 6298.842528936813, 6325.746970121144, 6396.520260980538, 6452.677366131768, 6463.806085817433, 6223.813285601439, 6284.308726040041, 6310.968445157745, 6311.053341998737, 6319.46284565817, 6316.7157477914525, 6330.683465826783, 6337.524685648503, 6346.238451385863, 6353.745850165941, 4880.951190488192, 6162.753489860355, 6258.468030217483, 6270.0908368287255, 6273.278572963985, 6107.310189946737, 6142.191841058572, 6180.6600636965395, 6184.938150618436, 6219.751209951552, 6209.130721698875, 6211.16149319836, 6221.222347206599, 6234.314225435108, 6238.064290356301, 6188.504919606331, 6256.217972753406, 6259.96870015647, 6268.059791031382, 6275.623462592259, 6044.969775151096, 6056.818295451144, 6119.076065312483, 6124.601900876429, 6184.628922264498], "value": 5832.332910772292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.197042072845, 539.8110661268556, 540.8458589302049, 552.3509875895821, 567.1549391406802, 29431.70568294319, 33405.0, 40259.59740402599, 41493.0, 41574.0, 43412.0, 43823.78088109563, 43884.341734874004, 43896.12207755843, 44145.0, 9470.242380609568, 9608.135267825894, 9639.277054220962, 9652.131308182263, 9667.226621870268, 8847.601857916408, 9082.591283392263, 11658.941705291461, 11819.645410637695, 11859.110566707532, 11714.121440891968, 11775.646730598095, 11785.764284714343, 11797.587084452045, 11806.704832379173, 11790.997765189926, 11897.405129743565, 11898.286102833814, 11908.702282442922, 11913.463894124785, 11627.360495172763, 11694.824577631342, 11702.239354441934, 11708.297502149899, 11710.121740869468, 40753.796231018656, 41111.1777764446, 41127.383089253686, 41187.7940610298, 41198.38202426966, 3224.758143139274, 3352.094934367707, 3462.9826850865584, 3502.369573476773, 4019.3970904364287, 24004.7599524006, 28820.991265305613, 29706.40587188244, 31558.526622100686, 31718.682813171803, 3177.8569964351427, 3234.7897386669792, 3281.704646581819, 3410.1133705236816, 3416.538767266412, 505583.47208263725, 507397.46301268257, 507515.0, 507643.99999999633, 508137.0, 64187.71624567483, 64283.35716642867, 64381.67809160924, 64924.35075649278, 64997.675011625586, 66307.0, 66426.66786666035, 66446.33553664498, 66495.66752166208, 66498.33501664922, 16954.982701037978, 17135.400260991053, 17150.39973600943, 17158.914205429144, 17210.91394543019, 11892.04863610909, 13083.738325233633, 13168.012399070109, 13177.0, 13207.339633018311, 15448.0, 15913.204339782964, 17584.64830703379, 17847.0, 18068.90965545164, 6963.408110310579, 6999.790006299819, 7014.579125252501, 7035.437165026786, 7074.823129421806, 861.8104017116225, 938.7934654376027, 958.8945216026372, 969.5443141723379, 1060.6977011551826, 28990.985315513855, 30184.54723179154, 30289.0, 30477.0, 30542.235337514063, 910.6311943662827, 949.5442187749919, 980.2745967983641, 1030.3302853145515, 1053.0522529723157, 13823.51617693396, 13868.583942481742, 14622.634434139232, 14963.850361496463, 16654.50036498907, 637641.0, 642969.0, 643111.0, 643871.5612843812, 845505.0, 46126.0, 48785.780355490686, 60256.39743602595, 60265.0, 63803.0, 1266.670665626962, 1350.9121907076205, 1353.4315587453293, 1387.8265216847894, 1394.532831501438, 28509.572356414257, 31254.218644533157, 31787.364252715277, 31856.0, 32813.0, 52751.94496110133, 53010.46989530055, 53062.73468632632, 53076.93846123133, 53086.73456632692, 560363.0, 563514.1824291017, 563525.0, 563719.0, 564129.0, 26886.731132688423, 27179.0, 27377.315567110185, 27547.0, 27571.31071723223, 47050.05899882052, 47434.3397981069, 48074.03851923012, 48396.27405588848, 48582.0, 38651.420228697156, 39175.804120980356, 39492.40761388524, 39548.81353559398, 41081.589184107776, 35734.0, 38604.80697596494, 38790.6120938787, 39834.60165398309, 40110.59889401068, 38865.805670971466, 39589.40615890706, 39610.60389396069, 39773.0, 39810.800945995084, 31142.22144446407, 31750.888718894726, 34326.82836585901, 34997.0, 35127.29745405026, 25441.36396590026, 25532.23403297904, 25705.61441578415, 25851.19041667065, 26007.349816254744], "value": 20474.65216473286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.07517529598346, 366.1541838353403, 377.7129381669932, 390.233191778156, 402.68992875485856, 19391.903040484794, 20412.591748165047, 20435.386938391835, 20898.791012089874, 21109.366718998415, 20734.274300399487, 20893.582128357422, 21056.157753689833, 21237.256696015644, 21257.68113478299, 4748.620110391178, 5833.7958171464115, 6072.696365181745, 6151.938480615181, 6167.599106058092, 6041.6375017499095, 6131.7240724167295, 6138.447539721425, 6140.7850725224625, 6147.047207682816, 5803.245578074844, 5965.373635768247, 6046.365131661179, 6067.787627433041, 6069.726862291208, 4716.622670186377, 5124.410692770304, 6018.458338749511, 6093.664848433335, 6100.054491553817, 5091.8981620367385, 5252.448492908228, 5262.815801446931, 5265.710385928773, 5266.605004624668, 24705.135320263886, 24857.627135592982, 24938.5012299753, 25021.62467562988, 25175.99296028157, 2249.201533455632, 2360.8229382796358, 2378.1795280628157, 2410.5660981023407, 2477.9008839646394, 14296.070755400866, 15543.911926165172, 15947.282372293159, 16047.985400950329, 16365.181740913025, 1806.8735188536807, 1878.5021969178179, 1879.5019319880244, 1902.457799527142, 1914.9138288777037, 115742.0, 116383.0, 118270.40864795707, 122040.38979805044, 122235.38882305531, 10783.78432431347, 10845.457727113771, 11317.94341028306, 11336.659900203007, 11549.307041577533, 14320.713585728226, 14336.354864031144, 14340.067895586753, 14342.21117838508, 14364.994450388582, 8479.872801907977, 8737.082606326372, 8785.912140878638, 8876.689315874042, 8911.019787823334, 8655.221030107321, 8665.35009874262, 8668.393212475192, 8850.159234872677, 8869.246114080246, 6635.435987940982, 6806.149231346082, 6811.897821532681, 6813.977903314542, 6815.931840681629, 1621.9189040547926, 1737.4700716281402, 1900.6958886578082, 1914.4735197820432, 1915.79884112169, 766.5167900113298, 833.9658823059362, 881.9426737262057, 975.3075316525204, 977.4721650308753, 21776.782232177477, 22234.444138896655, 22474.32577022692, 22606.66090008651, 22611.547769044526, 906.6373450619673, 953.6791543712009, 955.2978560757838, 974.8294048541477, 978.2663002747939, 8962.910370896208, 11123.833142502868, 11615.419229038514, 11804.822927656092, 11811.409429528489, 583149.0, 585763.0, 588415.2896177544, 592693.0, 605110.0, 80116.5994170037, 80280.0, 90119.09880901239, 95839.52080239553, 119535.40232298782, 934.45334479329, 956.1824639932896, 1002.2132625888643, 1007.3401921741271, 1008.8436292374694, 19467.221311147394, 19984.800151998294, 20057.613454377642, 20156.182255821903, 20275.59448810986, 51780.44658660246, 52356.0, 52524.212136817216, 53061.0, 53732.0, 73657.6317118411, 75178.62410687911, 75842.62078689571, 78047.21952780627, 78260.60869695614, 7983.560904150328, 8022.27799498048, 8221.260086592236, 8304.83390332202, 8388.70639527638, 12920.806187907378, 13018.414171362121, 13220.669483262995, 13265.933670331586, 13658.726825463635, 11134.944325278322, 11302.717432064264, 11444.313341199555, 11780.587679431179, 11798.823017654571, 11144.164187685794, 11324.207305488537, 11351.179916152103, 11558.133140014701, 11774.058075354122, 11570.76858462843, 11633.243839150427, 11712.297262164297, 11788.528458861892, 11854.40727963581, 8076.27313541784, 8160.30637395828, 8244.093149753402, 8299.419040667095, 8354.665813367397, 11282.210245282751, 11405.714857128638, 11462.025727813229, 11566.595169169039, 11588.594399195988], "value": 9783.224535724838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.2388262572954, 1499.6625759204178, 1521.1025494957973, 1689.7972243330803, 1863.7297591849174, 7346.4122870170395, 7709.961450192748, 8069.435139540235, 8078.272955434017, 8255.545944973024, 8029.116797152323, 8091.190880911906, 8101.513909165455, 8111.188881111901, 8128.837423251546, 2113.6723807809776, 2239.1826983151195, 2341.508283260517, 2342.824288178385, 2345.777151170636, 2310.6765052892524, 2358.7169539655265, 2361.161787565415, 2370.8696021718797, 2374.976250237493, 2293.8508996915148, 2308.1805958884606, 2326.685897403846, 2329.743728189898, 2333.591621466245, 2037.7467857267823, 2189.2665956904298, 2260.638297872341, 2320.060375547906, 2325.4651430171157, 2329.0450915124716, 2349.283468542094, 2352.7059117610297, 2356.7761062699014, 2361.53949979754, 8133.837323253561, 8168.06067302256, 8225.424220304581, 8231.794205144859, 8248.175182481764, 4977.054359671651, 4982.750862456863, 5144.279800827887, 5148.871278218037, 5153.9742301288625, 3463.3939060664284, 3555.484454754072, 3559.3771090059395, 3565.5008298838184, 3566.465030245458, 980.3970558106785, 1010.8584798128268, 1063.4363787192801, 1110.5280255891214, 1118.2954738514684, 10635.94682026585, 10717.35695858251, 10749.086327662159, 10750.086242669382, 10757.246992710514, 4071.694622903294, 4283.100548884707, 4306.289462238696, 4338.219120558267, 4401.537838526972, 8366.247037766509, 8377.413581049268, 8379.95810020946, 8394.412391132562, 8394.538300393537, 4966.329545511382, 4966.975165124223, 4972.229304457815, 4972.279019542146, 4974.925376119361, 3937.3897045957924, 4282.657387409, 4301.268784306675, 4662.603678687282, 4663.51033141522, 3616.788375894105, 3631.6913062389463, 3721.6092310307567, 3733.906652333659, 3735.9626403736156, 952.842780941137, 1134.9319040857574, 1141.9143564232716, 1145.1754736589808, 1148.4602236948622, 808.5189312359137, 888.2804928008334, 905.6513242401722, 907.1971305394774, 944.3059351376733, 5354.571634269249, 5581.845290037568, 5582.27430434041, 5652.406497317723, 5778.566607504454, 445.8216713314635, 457.65447087448763, 464.5563486870031, 469.05485446824673, 470.4237309296085, 3371.258323168899, 3737.1591391936595, 3741.8129093545213, 3777.4522694209186, 3813.694904407641, 8713.0, 9702.854457183148, 9815.312928094965, 10080.495975201356, 10097.394156350496, 9317.44095354281, 9565.856512152322, 9571.712848614552, 10054.095131438205, 10064.496775161213, 7380.9261907381315, 7701.807454813675, 7707.768766937001, 7725.884111738328, 7736.4584479085925, 5228.7973766033265, 5282.9471705283995, 5344.331958505187, 5790.131480277992, 5872.559558033079, 8938.776530586787, 9164.358494905293, 9184.265258779415, 9298.116678915492, 9328.78725765646, 8901.465912045298, 9061.275097992013, 9267.212286955684, 9401.34190606651, 9429.481378523973, 7585.544867307979, 7665.195154508696, 7690.730824421118, 7702.884456733042, 7781.0, 7715.537067775951, 7778.105517865291, 7788.493747906368, 7791.415643826849, 7810.414218933716, 6584.242812076673, 6960.443164546926, 7091.2554181810165, 7112.395446387115, 7146.892796608159, 6812.523123381514, 6813.4549236061985, 6854.931450685429, 6862.691178896862, 6965.825854353681, 6400.839979000562, 6476.4495017924, 6562.179727534059, 6574.4740420765265, 6579.046038324512, 4596.701214421052, 4644.58198762113, 4683.742394168217, 4713.080949215007, 4812.989272252726, 4697.0, 4775.47469778331, 4786.1624215762795, 4814.422269327703, 4868.464468908346], "value": 4249.761747324103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.32101795182587, 308.77150908327815, 317.7140573483864, 320.86363295599364, 324.41119368346466, 4516.661250406216, 5121.692698438096, 5129.410117836441, 5141.151709967856, 5152.896942061157, 4819.710817350961, 4887.731174785395, 4987.8254261100865, 5098.898022039557, 5141.922871156936, 3992.7005474589378, 4013.8595149169787, 4014.478117844676, 4036.9798151009204, 4064.9187016259657, 3861.58650843223, 3984.5417776955587, 4010.5509262034625, 4016.6987475939422, 4022.839086436539, 3283.4910588858647, 3928.351821949375, 3935.7048221383366, 4002.739821911581, 4007.438958545791, 3283.835808209592, 3889.4165875118674, 3973.662238709684, 3987.601239876018, 3991.1818077294083, 2661.188337557044, 2887.56686497025, 2940.6324209473814, 3249.5775549178456, 3353.782004169721, 4969.453360130383, 4971.7762700678195, 4974.37820272466, 4980.975095124538, 4987.800487980477, 3869.1487872667967, 4217.725847819913, 4413.337999300099, 4451.910961780746, 4462.732236065814, 5068.0, 5338.065838478251, 5402.432744561843, 5435.891282174374, 5463.644863083887, 3327.3345330933666, 3613.241219343941, 3733.5519737631384, 3782.0544863784053, 3792.0, 5628.705397758538, 5664.801731939404, 5681.431856814327, 5710.743016564223, 5727.713614319267, 3213.951790723141, 3661.487391765155, 3823.3118038752737, 3828.1960788234783, 3842.634949679776, 3177.3009937813645, 3591.4074177760376, 3854.730168888207, 3877.3796192609047, 3879.4568760373572, 3658.359787037258, 4411.889702757457, 4445.088756804847, 4450.265706158512, 4456.286994080931, 5452.890942181213, 5456.91814622781, 5478.794665173735, 5501.0, 5528.723563821793, 1163.6043745126697, 1200.033972652006, 1237.9442925068213, 1242.167747609104, 1255.6546949588935, 778.7936196907824, 844.7001314533375, 849.4987957105337, 852.4075767341639, 867.2671592504324, 4073.3889916512762, 4110.917781644351, 4489.485887902785, 4660.347551342815, 4810.921010553248, 4345.717528360647, 4464.973056197093, 4468.888277793016, 5181.2746215529105, 5282.550983166397, 4365.323374876899, 4393.747781882148, 4785.49752276013, 4831.806727730851, 4887.218045112765, 2391.8564886106888, 2407.0, 2672.104844876988, 2769.459955308736, 2776.7778577713734, 4575.748333841604, 4781.708938586562, 5087.516685914832, 5518.365387980353, 5521.503064724194, 5088.516590923857, 5285.471452854684, 5365.919511207335, 5437.483439073281, 5474.7262636868, 4463.799129039201, 4751.671680876346, 5396.576440677094, 5405.837824865261, 5509.256250406143, 4851.830185943475, 5134.820281290137, 5278.047122564676, 5288.603354748486, 5303.867403314948, 4413.977930110329, 4864.175934024741, 5196.5449674091315, 5224.764885580082, 5258.342707161605, 4876.292937523968, 5012.523810238022, 5189.624749441326, 5422.481705122572, 5486.406403805514, 2990.626171728534, 3202.9359412812078, 3220.790648607833, 3591.676749092594, 3617.7286703496816, 4788.377510923697, 4820.987592605452, 5206.921896171485, 5258.685328667833, 5284.916592098533, 4395.956040439554, 4471.8434854779925, 4831.903361932812, 5372.758225879923, 5391.784328626811, 4613.700109492872, 4977.9751101244265, 5015.047141043336, 5413.269208656939, 5514.593778586434, 4682.484926658133, 5115.7953681852305, 5178.663386879841, 5292.41783403833, 5322.201669749568, 4283.935740963826, 4624.1445332613575, 5084.466131056186, 5398.784048638167, 5413.864653383697, 4606.08847328355, 4638.791254393493, 5140.121531942124, 5303.734813259244, 5303.7878484860175], "value": 3838.7297249822927, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.7428377216656, 688.9069975553299, 713.7323503686117, 751.8947347371369, 815.4943934760447, 14179.787303190447, 15226.619334516643, 15239.542813715592, 15273.159976201305, 15288.541343759678, 13622.386992585332, 13826.170429774196, 13831.79252311216, 13833.754962053414, 13840.031197816157, 696.0811728518357, 714.8963400306978, 847.4915050969431, 853.4111463090479, 868.700298397052, 849.6304107713133, 858.9441686290403, 863.654538184728, 865.8268346330727, 867.9757885694878, 924.4961495984671, 924.7780532672144, 927.3786563002805, 927.4528028463205, 931.6552875436098, 924.6671198368615, 925.0564424287256, 925.2274350916992, 925.4401087342128, 925.5418567808911, 678.9083473731032, 680.5032326401705, 683.3542302524116, 683.8803209438378, 684.0662495693343, 14417.495387661487, 14661.70676586473, 14778.261086945717, 14822.777658335133, 14856.851431485655, 13225.0, 14012.859871401257, 14107.012509124366, 14165.291735413291, 14234.644133896736, 11409.771804563945, 11412.54349826006, 11516.884831151749, 11754.412279385997, 11839.94080029603, 3689.3543629864666, 3749.7750134991716, 3767.868124615625, 3801.82891769871, 3851.171998020411, 77076.07309817243, 86766.56616716876, 90475.0, 94199.0, 94510.0, 9121.024955347768, 10607.787844243072, 10685.893141068489, 10742.892571074346, 10757.0, 19842.305519306756, 21205.257815976365, 21208.681869771965, 21223.363299101053, 21239.044243009103, 7807.531548107132, 7844.686212551434, 7846.882296765439, 7870.173631768582, 8101.149379315205, 4302.7633480158265, 4329.177456283296, 4428.424304840414, 4443.4445694288215, 4562.58936695699, 3176.9205769855475, 3245.7403407727325, 3280.3603297356785, 3286.392017476727, 3288.8026718396495, 532.6724064700181, 614.443928244939, 623.3859648246473, 633.7876811268277, 636.9808905732835, 575.5683237571822, 598.5989387110646, 613.6716856481761, 620.5935112501319, 632.838626150338, 8168.9183108169345, 8630.0, 8703.95648021756, 8763.386562940661, 8951.149640784115, 498.5986281043722, 568.9632060530529, 635.3246469175796, 637.7735903754101, 658.1016911915201, 4072.129148949983, 4204.705670603028, 4270.316749320094, 4289.506706728704, 4313.741175529478, 74727.0, 76697.61651191708, 84736.57631711802, 111351.0, 118767.0, 74263.62868185625, 91458.0, 92698.0, 93030.0, 99936.0, 89248.10751892527, 89529.55235223782, 90312.09687903037, 91440.0, 95672.0, 8445.1977062179, 9452.763680907758, 9588.280878933969, 9673.0, 9716.951415242878, 32117.67882321147, 40586.39120413255, 49920.50079499158, 52035.21947170871, 52221.0, 73769.89345159935, 78012.0, 79335.20664793278, 79370.52989883289, 79438.6028069856, 12090.06801908149, 12103.697407564528, 12299.323537205539, 12513.624591262276, 12959.416826242654, 13868.306584670929, 14409.351579179172, 14418.42326306936, 14589.781153282496, 14819.25903704832, 13227.86772132305, 13893.0, 13896.37466313998, 14187.64530886736, 14462.85537144615, 13328.200307981551, 13716.0, 13988.440462381392, 14001.859981400463, 14174.291285435893, 12685.80971285413, 13343.933280333536, 13436.664083397993, 13509.0, 14056.78914816299, 10664.413457259925, 10972.670819875417, 10976.341419514536, 11184.496697648789, 11199.272047316897, 10671.146308295163, 11300.434978251218, 11585.131115166228, 11618.70953226176, 11626.76746465083], "value": 7336.025523144713, "unit": "score"}], "name": "dromaeo_css", "value": 7204.454735660948, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 114.0, 112.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 107.0, 163.0, 140.0, 108.0, 107.0, 107.0, 135.0, 107.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 180.0, 183.0, 179.0, 182.0, 181.0, 182.0, 183.0, 186.0], "value": 182.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 57.0, 59.0, 88.0, 60.0, 61.0, 58.0, 59.0, 83.0, 77.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 68.0, 93.0, 70.0, 68.0, 69.0, 88.0, 67.0, 68.0, 90.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 90.0, 136.0, 87.0, 89.0, 85.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 79.0, 82.0, 79.0, 83.0, 82.0, 85.0, 83.0, 83.0], "value": 82.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 42.0, 43.0, 49.0, 61.0, 65.0, 72.0, 87.0, 87.0, 85.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 68.0, 74.0, 71.0, 68.0, 69.0, 68.0, 68.0, 68.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 81.0, 82.0, 84.0, 80.0, 82.0, 81.0, 82.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 135.0, 136.0, 135.0, 139.0, 135.0, 136.0, 183.0, 138.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 165.0, 164.0, 166.0, 164.0, 168.0, 182.0, 165.0, 166.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1425.6, "alertThreshold": 2.0}]} 08:36:45 INFO - Return code: 0 08:36:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:45 INFO - # TBPL SUCCESS # 08:36:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:45 INFO - 2017-02-24 08:36:45.184 screenresolution[1787:9843] starting screenresolution argv=screenresolution get 08:36:45 INFO - 2017-02-24 08:36:45.187 screenresolution[1787:9843] Display 0: 1600x1200x32@60 08:36:45 INFO - 2017-02-24 08:36:45.193 screenresolution[1788:9846] starting screenresolution argv=screenresolution list 08:36:45 INFO - Available Modes on Display 0 08:36:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:45 INFO - Intel Iris: 08:36:45 INFO - Chipset Model: Intel Iris 08:36:45 INFO - Type: GPU 08:36:45 INFO - Bus: Built-In 08:36:45 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:45 INFO - Vendor: Intel (0x8086) 08:36:45 INFO - Device ID: 0x0a2e 08:36:45 INFO - Revision ID: 0x0009 08:36:45 INFO - Displays: 08:36:45 INFO - Display: 08:36:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:45 INFO - Display Serial Number: 1600x1200 60 08:36:45 INFO - Main Display: Yes 08:36:45 INFO - Mirror: Off 08:36:45 INFO - Online: Yes 08:36:45 INFO - Rotation: Supported 08:36:45 INFO - Return code: 0 08:36:45 INFO - Running post-action listener: _resource_record_post_action 08:36:45 INFO - [mozharness: 2017-02-24 16:36:45.427227Z] Finished run-tests step (success) 08:36:45 INFO - Running post-run listener: _resource_record_post_run 08:36:45 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 37905408; Write bytes: 506539520; Read time: 245; Write time: 1653 08:36:45 INFO - TinderboxPrint: CPU usage
53.3% 08:36:45 INFO - TinderboxPrint: I/O read bytes / time
37,905,408 / 245 08:36:45 INFO - TinderboxPrint: I/O write bytes / time
506,539,520 / 1,653 08:36:45 INFO - TinderboxPrint: CPU idle
2,241.2 (46.7%) 08:36:45 INFO - TinderboxPrint: CPU system
957.2 (19.9%) 08:36:45 INFO - TinderboxPrint: CPU user
1,603.1 (33.4%) 08:36:45 INFO - TinderboxPrint: Swap in / out
229,617,664 / 0 08:36:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183564800; Write bytes: 178661376; Read time: 17027; Write time: 398 08:36:45 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 36983808; Write bytes: 310117888; Read time: 233; Write time: 1200 08:36:45 INFO - Running post-run listener: _upload_blobber_files 08:36:45 INFO - Blob upload gear active. 08:36:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:45 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 08:36:45 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:36:45 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:36:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:46 INFO - (blobuploader) - INFO - Done attempting. 08:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:48 INFO - (blobuploader) - INFO - Done attempting. 08:36:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:50 INFO - (blobuploader) - INFO - Done attempting. 08:36:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:50 INFO - Return code: 0 08:36:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a376da2de2272c59bfd43b287aa27b4b10cde222ca46040841007c41e12e9daa248a010577f26d01461e751a490c2323013264efc907e10d8ca9466f6a817c51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ed6211d6efcbc5d35e466b58387aecb66dd1df2a58f8fdd748ee3722f301566f4079147d989d2c84ba60b1627d3ad47c2b4fc3c409ab4ee474433aee2fac6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d45067ef56b1eafc9226b3289514f424e2db8bf3b029f89f13089660967321fa2a06070d37101aee150363de8ec93906b6d8be22074b14e9cc43b6c2432a1b"} 08:36:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:50 INFO - Contents: 08:36:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a376da2de2272c59bfd43b287aa27b4b10cde222ca46040841007c41e12e9daa248a010577f26d01461e751a490c2323013264efc907e10d8ca9466f6a817c51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ed6211d6efcbc5d35e466b58387aecb66dd1df2a58f8fdd748ee3722f301566f4079147d989d2c84ba60b1627d3ad47c2b4fc3c409ab4ee474433aee2fac6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d45067ef56b1eafc9226b3289514f424e2db8bf3b029f89f13089660967321fa2a06070d37101aee150363de8ec93906b6d8be22074b14e9cc43b6c2432a1b"} 08:36:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:50 INFO - Copying logs to upload dir... 08:36:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.112127 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-24 08:36:50.301492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 08:36:50.307068) ========= 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.ENDLqiXqov/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.ZJ74EJHueh/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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-Beta/sha512/a376da2de2272c59bfd43b287aa27b4b10cde222ca46040841007c41e12e9daa248a010577f26d01461e751a490c2323013264efc907e10d8ca9466f6a817c51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ed6211d6efcbc5d35e466b58387aecb66dd1df2a58f8fdd748ee3722f301566f4079147d989d2c84ba60b1627d3ad47c2b4fc3c409ab4ee474433aee2fac6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d45067ef56b1eafc9226b3289514f424e2db8bf3b029f89f13089660967321fa2a06070d37101aee150363de8ec93906b6d8be22074b14e9cc43b6c2432a1b"} build_url:https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010889 build_url: 'https://queue.taskcluster.net/v1/task/NMq72fryR0qgRY044LFHiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a376da2de2272c59bfd43b287aa27b4b10cde222ca46040841007c41e12e9daa248a010577f26d01461e751a490c2323013264efc907e10d8ca9466f6a817c51", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6ed6211d6efcbc5d35e466b58387aecb66dd1df2a58f8fdd748ee3722f301566f4079147d989d2c84ba60b1627d3ad47c2b4fc3c409ab4ee474433aee2fac6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d45067ef56b1eafc9226b3289514f424e2db8bf3b029f89f13089660967321fa2a06070d37101aee150363de8ec93906b6d8be22074b14e9cc43b6c2432a1b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 08:36:50.343937) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:36:50.344384) ========= 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.ENDLqiXqov/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.ZJ74EJHueh/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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.004799 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:36:50.394500) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 08:36:50.394833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 08:36:50.395167) ========= ========= Total master_lag: 0.34 =========