builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0344 starttime: 1487256406.03 results: success (0) buildid: 20170216033818 builduid: d31087c738154a178c0233749a736c25 revision: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.031692) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.032156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.032464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.058755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.059098) ========= 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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-16 06:46:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-02-16 06:46:46 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.192471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.192855) ========= 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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.025629 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.241150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.241511) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e --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 b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6fSL5JVSbD/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.MI7KGWOoYa/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-16 06:46:46,344 truncating revision to first 12 chars 2017-02-16 06:46:46,345 Setting DEBUG logging. 2017-02-16 06:46:46,345 attempt 1/10 2017-02-16 06:46:46,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b5dec8abc97b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 06:46:46,646 unpacking tar archive at: mozilla-beta-b5dec8abc97b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.843923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.844258) ========= script_repo_revision: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.844680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.845030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 06:46:46.864385) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-16 06:46:46.864785) ========= /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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:46:47 INFO - MultiFileLogger online at 20170216 06:46:47 in /builds/slave/test 06:46:47 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 06:46:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:46:47 INFO - {'append_to_log': False, 06:46:47 INFO - 'base_work_dir': '/builds/slave/test', 06:46:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:46:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:46:47 INFO - 'branch': 'Mozilla-Beta', 06:46:47 INFO - 'buildbot_json_path': 'buildprops.json', 06:46:47 INFO - 'config_files': ('talos/mac_config.py',), 06:46:47 INFO - 'default_actions': ('clobber', 06:46:47 INFO - 'read-buildbot-config', 06:46:47 INFO - 'download-and-extract', 06:46:47 INFO - 'populate-webroot', 06:46:47 INFO - 'create-virtualenv', 06:46:47 INFO - 'install', 06:46:47 INFO - 'run-tests'), 06:46:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:46:47 INFO - 'download_minidump_stackwalk': True, 06:46:47 INFO - 'download_symbols': 'ondemand', 06:46:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:46:47 INFO - 'tooltool.py': '/tools/tooltool.py', 06:46:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:46:47 INFO - '/tools/misc-python/virtualenv.py')}, 06:46:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:46:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:46:47 INFO - 'installer_path': 'installer.exe', 06:46:47 INFO - 'log_level': 'info', 06:46:47 INFO - 'log_name': 'talos', 06:46:47 INFO - 'log_to_console': True, 06:46:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:46:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:46:47 INFO - 'opt_config_files': (), 06:46:47 INFO - 'pip_index': False, 06:46:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:46:47 INFO - 'cmd': ('bash', 06:46:47 INFO - '-c', 06:46:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:46:47 INFO - 'enabled': True, 06:46:47 INFO - 'halt_on_failure': False, 06:46:47 INFO - 'name': 'check_screen_resolution'},), 06:46:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:46:47 INFO - 'cmd': ('bash', 06:46:47 INFO - '-c', 06:46:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:46:47 INFO - 'enabled': True, 06:46:47 INFO - 'halt_on_failure': False, 06:46:47 INFO - 'name': 'check_screen_resolution'},), 06:46:47 INFO - 'run_cmd_checks_enabled': True, 06:46:47 INFO - 'sps_profile': False, 06:46:47 INFO - 'sps_profile_interval': 0, 06:46:47 INFO - 'suite': 'dromaeojs', 06:46:47 INFO - 'system_bits': '32', 06:46:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:46:47 INFO - 'title': 't-yosemite-r7-0344', 06:46:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:46:47 INFO - 'use_talos_json': True, 06:46:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:46:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:46:47 INFO - 'work_dir': 'build'} 06:46:47 INFO - [mozharness: 2017-02-16 14:46:47.074087Z] Running clobber step. 06:46:47 INFO - Running pre-action listener: _resource_record_pre_action 06:46:47 INFO - Running main action method: clobber 06:46:47 INFO - rmtree: /builds/slave/test/build 06:46:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:46:49 INFO - Running post-action listener: _resource_record_post_action 06:46:49 INFO - [mozharness: 2017-02-16 14:46:49.607600Z] Finished clobber step (success) 06:46:49 INFO - [mozharness: 2017-02-16 14:46:49.607736Z] Running read-buildbot-config step. 06:46:49 INFO - Running pre-action listener: _resource_record_pre_action 06:46:49 INFO - Running main action method: read_buildbot_config 06:46:49 INFO - Using buildbot properties: 06:46:49 INFO - { 06:46:49 INFO - "project": "", 06:46:49 INFO - "product": "firefox", 06:46:49 INFO - "script_repo_revision": "production", 06:46:49 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:46:49 INFO - "repository": "", 06:46:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:46:49 INFO - "buildid": "20170216033818", 06:46:49 INFO - "pgo_build": "False", 06:46:49 INFO - "basedir": "/builds/slave/test", 06:46:49 INFO - "buildnumber": 9, 06:46:49 INFO - "slavename": "t-yosemite-r7-0344", 06:46:49 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:46:49 INFO - "platform": "yosemite_r7", 06:46:49 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:46:49 INFO - "branch": "mozilla-beta", 06:46:49 INFO - "repo_path": "releases/mozilla-beta", 06:46:49 INFO - "revision": "b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e", 06:46:49 INFO - "stage_platform": "macosx64", 06:46:49 INFO - "builduid": "d31087c738154a178c0233749a736c25", 06:46:49 INFO - "slavebuilddir": "test" 06:46:49 INFO - } 06:46:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 06:46:49 INFO - Running post-action listener: _resource_record_post_action 06:46:49 INFO - [mozharness: 2017-02-16 14:46:49.610922Z] Finished read-buildbot-config step (success) 06:46:49 INFO - [mozharness: 2017-02-16 14:46:49.611073Z] Running download-and-extract step. 06:46:49 INFO - Running pre-action listener: _resource_record_pre_action 06:46:49 INFO - Running main action method: download_and_extract 06:46:49 INFO - mkdir: /builds/slave/test/build/tests 06:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:49 INFO - trying https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 06:46:49 INFO - Downloading https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/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 06:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/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 06:46:50 INFO - Downloaded 1165 bytes. 06:46:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 06:46:50 INFO - Using the following test package requirements: 06:46:50 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 06:46:50 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:46:50 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 06:46:50 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:46:50 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 06:46:50 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:46:50 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:46:50 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 06:46:50 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 06:46:50 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:46:50 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 06:46:50 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:46:50 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 06:46:50 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:46:50 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 06:46:50 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:46:50 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 06:46:50 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 06:46:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 06:46:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 06:46:50 INFO - Fetch https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 06:46:51 INFO - Http code: 200 06:46:51 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 06:46:51 INFO - x-amz-cf-id: uialt8B9lYEQLcO0TbObpV7B6udwNs9tCZn8xYciSCNxp5j9EjYbNw== 06:46:51 INFO - x-amz-version-id: lBTnD9IlEzUJeZmyMyzb7EOi_Y.kivwo 06:46:51 INFO - Expected file size: 16094142 06:46:51 INFO - Obtained file size: 16094142 06:46:58 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 06:46:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 06:46:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 06:46:58 INFO - Fetch https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 06:46:59 INFO - Http code: 200 06:46:59 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 06:46:59 INFO - x-amz-cf-id: KE3G3BnxsU8v24eFKmo5xCaHrF9ZbUK1emqLWw1NttJWIyRxZreDRA== 06:46:59 INFO - x-amz-version-id: lBTnD9IlEzUJeZmyMyzb7EOi_Y.kivwo 06:46:59 INFO - Expected file size: 16094142 06:46:59 INFO - Obtained file size: 16094142 06:47:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 06:47:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 06:47:05 INFO - Fetch https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 06:47:06 INFO - Http code: 200 06:47:06 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 06:47:06 INFO - x-amz-cf-id: ZMiWoDnhyIN-PbuqHQpoItuNrhYiot4DhKuVw_0P3dP8_wVcdVKS1w== 06:47:06 INFO - x-amz-version-id: HWooJjD6jedBcvO0QnN.eBEbkyESMcW6 06:47:06 INFO - Expected file size: 14403005 06:47:06 INFO - Obtained file size: 14403005 06:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:07 INFO - trying https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:47:07 INFO - Downloading https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 06:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/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 06:47:09 INFO - Downloaded 82113135 bytes. 06:47:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:47:09 INFO - mkdir: /builds/slave/test/properties 06:47:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:47:09 INFO - Writing to file /builds/slave/test/properties/build_url 06:47:09 INFO - Contents: 06:47:09 INFO - build_url:https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:47:09 INFO - Running post-action listener: _resource_record_post_action 06:47:09 INFO - Running post-action listener: set_extra_try_arguments 06:47:09 INFO - [mozharness: 2017-02-16 14:47:09.867177Z] Finished download-and-extract step (success) 06:47:09 INFO - [mozharness: 2017-02-16 14:47:09.867322Z] Running populate-webroot step. 06:47:09 INFO - Running pre-action listener: _resource_record_pre_action 06:47:09 INFO - Running main action method: populate_webroot 06:47:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:09 INFO - '--tppagecycles', 06:47:09 INFO - '7'], 06:47:09 INFO - 'tests': ['tsvgm']}}, 06:47:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:47:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:47:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:47:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['damp', 'tps']}, 06:47:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'tests': ['damp', 'tps']}, 06:47:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['dromaeo_dom']}, 06:47:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['basic_compositor_video']}, 06:47:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:47:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['a11yr', 06:47:09 INFO - 'ts_paint', 06:47:09 INFO - 'tpaint', 06:47:09 INFO - 'sessionrestore', 06:47:09 INFO - 'sessionrestore_no_auto_restore', 06:47:09 INFO - 'tabpaint']}, 06:47:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:47:09 INFO - 'ts_paint', 06:47:09 INFO - 'tpaint', 06:47:09 INFO - 'sessionrestore', 06:47:09 INFO - 'sessionrestore_no_auto_restore', 06:47:09 INFO - 'tabpaint']}, 06:47:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:47:09 INFO - 'ts_paint', 06:47:09 INFO - 'tpaint', 06:47:09 INFO - 'sessionrestore', 06:47:09 INFO - 'sessionrestore_no_auto_restore', 06:47:09 INFO - 'tabpaint']}, 06:47:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:47:09 INFO - 'ts_paint', 06:47:09 INFO - 'tpaint', 06:47:09 INFO - 'sessionrestore', 06:47:09 INFO - 'sessionrestore_no_auto_restore', 06:47:09 INFO - 'tabpaint']}, 06:47:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['a11yr', 06:47:09 INFO - 'ts_paint', 06:47:09 INFO - 'tpaint', 06:47:09 INFO - 'sessionrestore', 06:47:09 INFO - 'sessionrestore_no_auto_restore', 06:47:09 INFO - 'tabpaint']}, 06:47:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['a11yr', 06:47:09 INFO - 'ts_paint', 06:47:09 INFO - 'tpaint', 06:47:09 INFO - 'sessionrestore', 06:47:09 INFO - 'sessionrestore_no_auto_restore', 06:47:09 INFO - 'tabpaint']}, 06:47:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['tsvgx', 06:47:09 INFO - 'tsvgr_opacity', 06:47:09 INFO - 'tart', 06:47:09 INFO - 'tscrollx', 06:47:09 INFO - 'cart']}, 06:47:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:47:09 INFO - 'tsvgr_opacity', 06:47:09 INFO - 'tart', 06:47:09 INFO - 'tscrollx', 06:47:09 INFO - 'cart']}, 06:47:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'talos_options': ['--disable-e10s'], 06:47:09 INFO - 'tests': ['tp5o']}, 06:47:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'tests': ['tp5o']}, 06:47:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'talos_options': ['--disable-e10s', 06:47:09 INFO - '--xperf_path', 06:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:09 INFO - 'tests': ['tp5n']}, 06:47:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:09 INFO - 'talos_options': ['--xperf_path', 06:47:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:09 INFO - 'tests': ['tp5n']}}, 06:47:09 INFO - 'talos.zip': {'path': '', 06:47:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:09 INFO - Running post-action listener: _resource_record_post_action 06:47:09 INFO - [mozharness: 2017-02-16 14:47:09.885576Z] Finished populate-webroot step (success) 06:47:09 INFO - [mozharness: 2017-02-16 14:47:09.885687Z] Running create-virtualenv step. 06:47:09 INFO - Running pre-action listener: _resource_record_pre_action 06:47:09 INFO - Running main action method: create_virtualenv 06:47:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:47:09 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 06:47:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:47:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:10 INFO - Using real prefix '/tools/python27' 06:47:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:47:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:13 INFO - Installing pip.................done. 06:47:13 INFO - Return code: 0 06:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:47:13 INFO - Reading from file tmpfile_stdout 06:47:13 INFO - Output received: 06:47:13 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) 06:47:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:47:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:13 INFO - 'HOME': '/Users/cltbld', 06:47:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:13 INFO - 'LOGNAME': 'cltbld', 06:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:13 INFO - 'MOZ_NO_REMOTE': '1', 06:47:13 INFO - 'NO_EM_RESTART': '1', 06:47:13 INFO - 'PAGER': '/bin/cat', 06:47:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:13 INFO - 'PWD': '/builds/slave/test', 06:47:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:13 INFO - 'SHELL': '/bin/bash', 06:47:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:13 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:13 INFO - 'USER': 'cltbld', 06:47:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:13 INFO - 'XPC_FLAGS': '0x0', 06:47:13 INFO - 'XPC_SERVICE_NAME': '0', 06:47:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:14 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 06:47:14 INFO - Cleaning up... 06:47:14 INFO - Return code: 0 06:47:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:14 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 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:14 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 06:47:14 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 06:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:14 INFO - 'HOME': '/Users/cltbld', 06:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:14 INFO - 'LOGNAME': 'cltbld', 06:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:14 INFO - 'MOZ_NO_REMOTE': '1', 06:47:14 INFO - 'NO_EM_RESTART': '1', 06:47:14 INFO - 'PAGER': '/bin/cat', 06:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:14 INFO - 'PWD': '/builds/slave/test', 06:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:14 INFO - 'SHELL': '/bin/bash', 06:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:14 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:14 INFO - 'USER': 'cltbld', 06:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:14 INFO - 'XPC_FLAGS': '0x0', 06:47:14 INFO - 'XPC_SERVICE_NAME': '0', 06:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:14 INFO - Downloading/unpacking psutil>=3.1.1 06:47:14 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 06:47:14 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 06:47:14 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 06:47:14 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 06:47:14 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 06:47:14 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 06:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:17 INFO - Installing collected packages: psutil 06:47:17 INFO - Running setup.py install for psutil 06:47:18 INFO - building 'psutil._psutil_osx' extension 06:47:18 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 06:47:18 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 06:47:18 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 06:47:18 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 06:47:18 INFO - building 'psutil._psutil_posix' extension 06:47:18 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 06:47:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:47:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:47:18 INFO - ^ 06:47:18 INFO - 1 warning generated. 06:47:18 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 06:47:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:19 INFO - Successfully installed psutil 06:47:19 INFO - Cleaning up... 06:47:19 INFO - Return code: 0 06:47:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:19 INFO - 'HOME': '/Users/cltbld', 06:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:19 INFO - 'LOGNAME': 'cltbld', 06:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:19 INFO - 'MOZ_NO_REMOTE': '1', 06:47:19 INFO - 'NO_EM_RESTART': '1', 06:47:19 INFO - 'PAGER': '/bin/cat', 06:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:19 INFO - 'PWD': '/builds/slave/test', 06:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:19 INFO - 'SHELL': '/bin/bash', 06:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:19 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:19 INFO - 'USER': 'cltbld', 06:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:19 INFO - 'XPC_FLAGS': '0x0', 06:47:19 INFO - 'XPC_SERVICE_NAME': '0', 06:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:47:19 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 06:47:19 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 06:47:19 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 06:47:19 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 06:47:19 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 06:47:19 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 06:47:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:47:22 INFO - Installing collected packages: mozsystemmonitor 06:47:22 INFO - Running setup.py install for mozsystemmonitor 06:47:22 INFO - Successfully installed mozsystemmonitor 06:47:22 INFO - Cleaning up... 06:47:22 INFO - Return code: 0 06:47:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:47:22 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')]} 06:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:22 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')]} 06:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:22 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 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:22 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 06:47:22 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 06:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:22 INFO - 'HOME': '/Users/cltbld', 06:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:22 INFO - 'LOGNAME': 'cltbld', 06:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:22 INFO - 'MOZ_NO_REMOTE': '1', 06:47:22 INFO - 'NO_EM_RESTART': '1', 06:47:22 INFO - 'PAGER': '/bin/cat', 06:47:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:22 INFO - 'PWD': '/builds/slave/test', 06:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:22 INFO - 'SHELL': '/bin/bash', 06:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:22 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:22 INFO - 'USER': 'cltbld', 06:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:22 INFO - 'XPC_FLAGS': '0x0', 06:47:22 INFO - 'XPC_SERVICE_NAME': '0', 06:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:47:22 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 06:47:22 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 06:47:22 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 06:47:22 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 06:47:22 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 06:47:22 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 06:47:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:47:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:47:25 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 06:47:25 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 06:47:25 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 06:47:25 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 06:47:25 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 06:47:25 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 06:47:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:47:25 INFO - warning: no files found matching '*.txt' 06:47:25 INFO - no previously-included directories found matching 'build' 06:47:25 INFO - no previously-included directories found matching 'dist' 06:47:25 INFO - no previously-included directories found matching '.git*' 06:47:25 INFO - Installing collected packages: jsonschema, functools32 06:47:25 INFO - Running setup.py install for functools32 06:47:26 INFO - warning: no files found matching '*.txt' 06:47:26 INFO - no previously-included directories found matching 'build' 06:47:26 INFO - no previously-included directories found matching 'dist' 06:47:26 INFO - no previously-included directories found matching '.git*' 06:47:26 INFO - Successfully installed jsonschema functools32 06:47:26 INFO - Cleaning up... 06:47:26 INFO - Return code: 0 06:47:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:47:26 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')]} 06:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:26 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')]} 06:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:26 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 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:26 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 06:47:26 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 06:47:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:26 INFO - 'HOME': '/Users/cltbld', 06:47:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:26 INFO - 'LOGNAME': 'cltbld', 06:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:26 INFO - 'MOZ_NO_REMOTE': '1', 06:47:26 INFO - 'NO_EM_RESTART': '1', 06:47:26 INFO - 'PAGER': '/bin/cat', 06:47:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:26 INFO - 'PWD': '/builds/slave/test', 06:47:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:26 INFO - 'SHELL': '/bin/bash', 06:47:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:26 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:26 INFO - 'USER': 'cltbld', 06:47:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:26 INFO - 'XPC_FLAGS': '0x0', 06:47:26 INFO - 'XPC_SERVICE_NAME': '0', 06:47:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:47:26 INFO - Cleaning up... 06:47:26 INFO - Return code: 0 06:47:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:47:26 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')]} 06:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:26 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')]} 06:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:26 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 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:26 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 06:47:26 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 06:47:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:26 INFO - 'HOME': '/Users/cltbld', 06:47:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:26 INFO - 'LOGNAME': 'cltbld', 06:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:26 INFO - 'MOZ_NO_REMOTE': '1', 06:47:26 INFO - 'NO_EM_RESTART': '1', 06:47:26 INFO - 'PAGER': '/bin/cat', 06:47:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:26 INFO - 'PWD': '/builds/slave/test', 06:47:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:26 INFO - 'SHELL': '/bin/bash', 06:47:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:26 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:26 INFO - 'USER': 'cltbld', 06:47:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:26 INFO - 'XPC_FLAGS': '0x0', 06:47:26 INFO - 'XPC_SERVICE_NAME': '0', 06:47:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:26 INFO - Downloading/unpacking blobuploader==1.2.4 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:47:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:47:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:47:29 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 06:47:29 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 06:47:29 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 06:47:29 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 06:47:29 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 06:47:29 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 06:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:47:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:47:30 INFO - Downloading docopt-0.6.1.tar.gz 06:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:47:30 INFO - Installing collected packages: blobuploader, requests, docopt 06:47:30 INFO - Running setup.py install for blobuploader 06:47:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:47:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:47:30 INFO - Running setup.py install for requests 06:47:31 INFO - Running setup.py install for docopt 06:47:31 INFO - Successfully installed blobuploader requests docopt 06:47:31 INFO - Cleaning up... 06:47:31 INFO - Return code: 0 06:47:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:31 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')]} 06:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:31 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')]} 06:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:31 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 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:31 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 06:47:31 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 06:47:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:31 INFO - 'HOME': '/Users/cltbld', 06:47:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:31 INFO - 'LOGNAME': 'cltbld', 06:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:31 INFO - 'MOZ_NO_REMOTE': '1', 06:47:31 INFO - 'NO_EM_RESTART': '1', 06:47:31 INFO - 'PAGER': '/bin/cat', 06:47:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:31 INFO - 'PWD': '/builds/slave/test', 06:47:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:31 INFO - 'SHELL': '/bin/bash', 06:47:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:31 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:31 INFO - 'USER': 'cltbld', 06:47:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:31 INFO - 'XPC_FLAGS': '0x0', 06:47:31 INFO - 'XPC_SERVICE_NAME': '0', 06:47:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:31 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-n3zePb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:31 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Slx7Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:31 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-JFyOSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-RK4Ytb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-aUXYl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-1WNJbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-GJKbBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Ndlm4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-OiT0yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-33FABQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-J9ZwqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-argpou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ZpiiKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ayCdbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-L0LE4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-j58XS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-a9pxgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:47:33 INFO - Running setup.py install for manifestparser 06:47:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:47:33 INFO - Running setup.py install for mozcrash 06:47:33 INFO - Running setup.py install for mozdebug 06:47:33 INFO - Running setup.py install for mozdevice 06:47:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Running setup.py install for mozfile 06:47:34 INFO - Running setup.py install for mozhttpd 06:47:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Running setup.py install for mozinfo 06:47:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Running setup.py install for mozInstall 06:47:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:47:34 INFO - Running setup.py install for mozleak 06:47:34 INFO - Running setup.py install for mozlog 06:47:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:47:35 INFO - Running setup.py install for moznetwork 06:47:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:47:35 INFO - Running setup.py install for mozprocess 06:47:35 INFO - Running setup.py install for mozprofile 06:47:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:47:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:47:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:47:35 INFO - Running setup.py install for mozrunner 06:47:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:47:35 INFO - Running setup.py install for mozscreenshot 06:47:35 INFO - Running setup.py install for moztest 06:47:35 INFO - Running setup.py install for mozversion 06:47:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:47:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:47:36 INFO - Cleaning up... 06:47:36 INFO - Return code: 0 06:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:36 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 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:36 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 06:47:36 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 06:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:36 INFO - 'HOME': '/Users/cltbld', 06:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:36 INFO - 'LOGNAME': 'cltbld', 06:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:36 INFO - 'MOZ_NO_REMOTE': '1', 06:47:36 INFO - 'NO_EM_RESTART': '1', 06:47:36 INFO - 'PAGER': '/bin/cat', 06:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:36 INFO - 'PWD': '/builds/slave/test', 06:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:36 INFO - 'SHELL': '/bin/bash', 06:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:36 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:36 INFO - 'USER': 'cltbld', 06:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:36 INFO - 'XPC_FLAGS': '0x0', 06:47:36 INFO - 'XPC_SERVICE_NAME': '0', 06:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:36 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-6rosnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:36 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)) 06:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:36 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Lhu6Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:36 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)) 06:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:36 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Zl6wIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:36 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)) 06:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:36 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-8YrU0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:36 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)) 06:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:36 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-v4sKJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:36 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)) 06:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:36 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Sa4HAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-FcTpGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-aAOx7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-HuPdRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-8swus2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-8sfxQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-m3VArW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-wsZ429-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-34NED4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:37 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)) 06:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-iKYjfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:38 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)) 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-kHTRJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:38 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)) 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-FTikoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:38 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)) 06:47:38 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)) 06:47:38 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)) 06:47:38 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)) 06:47:38 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)) 06:47:38 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)) 06:47:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:47:38 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 06:47:38 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 06:47:38 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 06:47:38 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 06:47:38 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 06:47:38 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 06:47:40 INFO - Downloading blessings-1.6.tar.gz 06:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:47:41 INFO - Installing collected packages: blessings 06:47:41 INFO - Running setup.py install for blessings 06:47:41 INFO - Successfully installed blessings 06:47:41 INFO - Cleaning up... 06:47:41 INFO - Return code: 0 06:47:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:47:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:41 INFO - Reading from file tmpfile_stdout 06:47:41 INFO - Current package versions: 06:47:41 INFO - blessings == 1.6 06:47:41 INFO - blobuploader == 1.2.4 06:47:41 INFO - docopt == 0.6.1 06:47:41 INFO - functools32 == 3.2.3-2 06:47:41 INFO - jsonschema == 2.5.1 06:47:41 INFO - manifestparser == 1.1 06:47:41 INFO - mozInstall == 1.12 06:47:41 INFO - mozcrash == 1.0 06:47:41 INFO - mozdebug == 0.1 06:47:41 INFO - mozdevice == 0.48 06:47:41 INFO - mozfile == 1.2 06:47:41 INFO - mozhttpd == 0.7 06:47:41 INFO - mozinfo == 0.9 06:47:41 INFO - mozleak == 0.1 06:47:41 INFO - mozlog == 3.4 06:47:41 INFO - moznetwork == 0.27 06:47:41 INFO - mozprocess == 0.23 06:47:41 INFO - mozprofile == 0.28 06:47:41 INFO - mozrunner == 6.13 06:47:41 INFO - mozscreenshot == 0.1 06:47:41 INFO - mozsystemmonitor == 0.3 06:47:41 INFO - moztest == 0.8 06:47:41 INFO - mozversion == 1.4 06:47:41 INFO - psutil == 3.1.1 06:47:41 INFO - requests == 1.2.3 06:47:41 INFO - wsgiref == 0.1.2 06:47:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:41 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 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:41 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 06:47:41 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 06:47:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:41 INFO - 'HOME': '/Users/cltbld', 06:47:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:41 INFO - 'LOGNAME': 'cltbld', 06:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:41 INFO - 'MOZ_NO_REMOTE': '1', 06:47:41 INFO - 'NO_EM_RESTART': '1', 06:47:41 INFO - 'PAGER': '/bin/cat', 06:47:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:41 INFO - 'PWD': '/builds/slave/test', 06:47:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:41 INFO - 'SHELL': '/bin/bash', 06:47:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:41 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:41 INFO - 'USER': 'cltbld', 06:47:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:41 INFO - 'XPC_FLAGS': '0x0', 06:47:41 INFO - 'XPC_SERVICE_NAME': '0', 06:47:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 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)) 06:47:41 INFO - Cleaning up... 06:47:41 INFO - Return code: 0 06:47:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1091cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109145570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faed2d90d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, '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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 06:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:47:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:47:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:41 INFO - 'HOME': '/Users/cltbld', 06:47:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:41 INFO - 'LOGNAME': 'cltbld', 06:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:41 INFO - 'MOZ_NO_REMOTE': '1', 06:47:41 INFO - 'NO_EM_RESTART': '1', 06:47:41 INFO - 'PAGER': '/bin/cat', 06:47:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:41 INFO - 'PWD': '/builds/slave/test', 06:47:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:41 INFO - 'SHELL': '/bin/bash', 06:47:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:47:41 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:47:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:41 INFO - 'USER': 'cltbld', 06:47:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:41 INFO - 'XPC_FLAGS': '0x0', 06:47:41 INFO - 'XPC_SERVICE_NAME': '0', 06:47:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:47:42 INFO - Cleaning up... 06:47:42 INFO - Return code: 0 06:47:42 INFO - Running post-action listener: _resource_record_post_action 06:47:42 INFO - Running post-action listener: _start_resource_monitoring 06:47:42 INFO - Starting resource monitoring. 06:47:42 INFO - [mozharness: 2017-02-16 14:47:42.114538Z] Finished create-virtualenv step (success) 06:47:42 INFO - [mozharness: 2017-02-16 14:47:42.115510Z] Running install step. 06:47:42 INFO - Running pre-action listener: _resource_record_pre_action 06:47:42 INFO - Running main action method: install 06:47:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:42 INFO - Reading from file tmpfile_stdout 06:47:42 INFO - Detecting whether we're running mozinstall >=1.0... 06:47:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:47:42 INFO - Reading from file tmpfile_stdout 06:47:42 INFO - Output received: 06:47:42 INFO - Usage: mozinstall [options] installer 06:47:42 INFO - Options: 06:47:42 INFO - -h, --help show this help message and exit 06:47:42 INFO - -d DEST, --destination=DEST 06:47:42 INFO - Directory to install application into. [default: 06:47:42 INFO - "/builds/slave/test"] 06:47:42 INFO - --app=APP Application being installed. [default: firefox] 06:47:42 INFO - mkdir: /builds/slave/test/build/application 06:47:42 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'] 06:47:42 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 06:48:03 INFO - Reading from file tmpfile_stdout 06:48:03 INFO - Output received: 06:48:03 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:48:03 INFO - Running post-action listener: _resource_record_post_action 06:48:03 INFO - [mozharness: 2017-02-16 14:48:03.842790Z] Finished install step (success) 06:48:03 INFO - [mozharness: 2017-02-16 14:48:03.842933Z] Running run-tests step. 06:48:03 INFO - Running pre-action listener: _resource_record_pre_action 06:48:03 INFO - Running main action method: run_tests 06:48:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:48:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:48:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:48:03 INFO - 2017-02-16 06:48:03.857 screenresolution[1623:7496] starting screenresolution argv=screenresolution get 06:48:03 INFO - 2017-02-16 06:48:03.860 screenresolution[1623:7496] Display 0: 1600x1200x32@60 06:48:03 INFO - 2017-02-16 06:48:03.865 screenresolution[1624:7498] starting screenresolution argv=screenresolution list 06:48:03 INFO - Available Modes on Display 0 06:48:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:48:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:48:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:48:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:48:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:48:04 INFO - Intel Iris: 06:48:04 INFO - Chipset Model: Intel Iris 06:48:04 INFO - Type: GPU 06:48:04 INFO - Bus: Built-In 06:48:04 INFO - VRAM (Dynamic, Max): 1536 MB 06:48:04 INFO - Vendor: Intel (0x8086) 06:48:04 INFO - Device ID: 0x0a2e 06:48:04 INFO - Revision ID: 0x0009 06:48:04 INFO - Displays: 06:48:04 INFO - Display: 06:48:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:48:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:48:04 INFO - Display Serial Number: 1600x1200 60 06:48:04 INFO - Main Display: Yes 06:48:04 INFO - Mirror: Off 06:48:04 INFO - Online: Yes 06:48:04 INFO - Rotation: Supported 06:48:04 INFO - Return code: 0 06:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:48:04 INFO - Python 2.7.3 06:48:04 INFO - Return code: 0 06:48:04 INFO - grabbing minidump binary from tooltool 06:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:04 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 0x108fe3d30>, '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 0x108e49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fdbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:48:04 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 06:48:04 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 06:48:04 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 06:48:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:48:04 INFO - Return code: 0 06:48:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:48:04 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/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 06:48:04 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/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --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 06:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6fSL5JVSbD/Render', 06:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:04 INFO - 'HOME': '/Users/cltbld', 06:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:04 INFO - 'LOGNAME': 'cltbld', 06:48:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:48:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:04 INFO - 'MOZ_NO_REMOTE': '1', 06:48:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:48:04 INFO - 'NO_EM_RESTART': '1', 06:48:04 INFO - 'PAGER': '/bin/cat', 06:48:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:04 INFO - 'PWD': '/builds/slave/test', 06:48:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:04 INFO - 'SHELL': '/bin/bash', 06:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MI7KGWOoYa/Listeners', 06:48:04 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 06:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:04 INFO - 'USER': 'cltbld', 06:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:04 INFO - 'XPC_FLAGS': '0x0', 06:48:04 INFO - 'XPC_SERVICE_NAME': '0', 06:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:04 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/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 06:48:04 INFO - mozversion application_buildid: 20170216033818 06:48:04 INFO - mozversion application_changeset: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e 06:48:04 INFO - mozversion application_display_name: Firefox 06:48:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:48:04 INFO - mozversion application_name: Firefox 06:48:04 INFO - mozversion application_remotingname: firefox 06:48:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:48:04 INFO - mozversion application_vendor: Mozilla 06:48:04 INFO - mozversion application_version: 52.0 06:48:04 INFO - mozversion platform_buildid: 20170216033818 06:48:04 INFO - mozversion platform_changeset: b5dec8abc97b2b8259d71b74c00b0ad90cc37d4e 06:48:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:48:04 INFO - mozversion platform_version: 52.0 06:48:04 INFO - using testdate: 1487256484 06:48:04 INFO - actual date: 1487256484 06:48:04 INFO - starting webserver on 'localhost:49242' 06:48:04 INFO - SUITE-START | Running 2 tests 06:48:04 INFO - TEST-START | dromaeo_css 06:48:04 INFO - operating with platform_type : mac_ 06:48:04 INFO - Initialising browser for dromaeo_css test... 06:48:04 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpRSGhll/profile http://localhost:49242/getInfo.html) 06:48:07 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 06:48:07 INFO - PROCESS | 1634 | colorDepth:24 06:48:07 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 06:48:07 INFO - PROCESS | 1634 | __metrics 06:48:07 INFO - PROCESS | 1634 | 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" 06:48:07 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:48:08 INFO - TEST-INFO | 1634: exit 0 06:48:08 INFO - Browser initialized. 06:48:08 INFO - Running cycle 1/1 for dromaeo_css test... 06:48:08 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpRSGhll/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:20 INFO - PROCESS | 1638 | RSS: Main: 168050688 06:48:20 INFO - PROCESS | 1638 | 06:51:23 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 06:51:25 INFO - PROCESS | 1638 | RSS: Main: 278966272 06:51:25 INFO - PROCESS | 1638 | 06:54:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 06:54:28 INFO - PROCESS | 1638 | RSS: Main: 301940736 06:54:28 INFO - PROCESS | 1638 | 06:57:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 06:57:31 INFO - PROCESS | 1638 | RSS: Main: 268263424 06:57:31 INFO - PROCESS | 1638 | 07:00:34 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 07:00:34 INFO - PROCESS | 1638 | RSS: Main: 266526720 07:00:34 INFO - PROCESS | 1638 | 07:03:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 07:03:38 INFO - PROCESS | 1638 | RSS: Main: 262475776 07:03:38 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 07:06:41 INFO - PROCESS | 1638 | RSS: Main: 307159040 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | __start_tp_report 07:06:41 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 07:06:41 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 07:06:41 INFO - PROCESS | 1638 | |i|pagename|runs| 07:06:41 INFO - PROCESS | 1638 | |0;dojo.html;2953.6307961504813;3457.8443970021344;3526.4005119129747;3549.0594992327024;3580.2660454606807;5754.1944127822135;5773;5802.767889284423;5804.390538993408;5845.269341332328;5732.541396688265;5792.4497172768515;5792.739326730297;5798.5361171106315;5801;5189.922151167735;5234.084035293828;5246.265522826789;5253.422123566424;5289.761960711778;5155.510226528474;5187.533122019017;5192.818251361203;5240.187770895517;5310.946890531103;5268.0780863348955;5274.129768588178;5274.4198138204765;5281.2342210379475;5282.181261904392;5218.191180367049;5258.526732594085;5280.049591073605;5281.260623512711;5289.629725919187;5140.331756871583;5199;5282.683039017633;5286.36563612369;5299.443558426348;5901.616394934315;5963.493103086243;5964.880702385928;5965.642061476326;5965.970170149165;6131.254333328308;6193;6209.751609935597;6316.526260530432;6316.936830631681;6252.093446450239;6260.311365749764;6285.214348206474;6288.9056664150075;6301.180846489973;5864.032434648278;5888.322842873039;5893.499052580493;5894.410558944071;5922.2597175353085;6236.251649802053;6251.562390632703;6328.462080723098;6337.746490140435;6373.745050198033;6192.225971753531;6252.374762523711;6272.8118156455375;6283.937160628427;6293.685315734195;5583.832485025456;5658.151277308437;5959.582829201914;6333.2400111985935;6354.904676429857;6127.372786728296;6131.662758548234;6170.074488826622;6285.340039295808;6314.02132669437;6198.783042593487;6255.405736455121;6277.843053923689;6324.3043265240785;6337.302896681362;4990.50094990498;5010.624203184776;5012.922221722347;5018;5020.071286811952;4452.933206001912;4500.4149460569915;4506.301523263899;4508.256137737237;4518.8418405356315;5842;5858.297004359504;5893.705314734332;5951.791687290924;6021.729022194012;6275.560710750204;6278.623282603058;6292.182016337847;6311.589746666452;6325.557210995278;5995.950708625973;6030.879382412327;6048.455638992512;6052.303985041776;6076.088586712029;5372.435894231127;5459.099248623933;5472.288602481732;5517.034518959246;5532.3914369419335;6263.342349053375;6341;6341.492680585542;6346.746130154742;6350.618962862243;6249.25008998923;6288.11966324724;6293.244810622755;6294.937050629435;6337;6427.260865000398;6466.708998095003;6482.189726284215;6495.025746138117;6496.967515162583;5565.9721701392855;6096.9390306096375;6302.495800336053;6309.179806625109;6309.968450157719;5125.641205115606;6177.567570270217;6239.0953311768635;6255.030470277115;6302.275238347649;6237.095621135;6257.812265632038;6270.996640537492;6274.121622972879;6284;6154.107654389999;6159.5072394209255;6167.444929956326;6227.813165605039;6236.314005459487;4327.896386421442;5964.075568286922;6026.15633811258;6122.959096953439;6143.907841382472;6109.716387860143;6200.255969283715;6208.565400421927;6212.9068063978175;6214.471769899428;6020.4280593343565;6054.1826853376;6071.666058366833;6080.939190608215;6115.235595550556 07:06:41 INFO - PROCESS | 1638 | |1;ext.html;480.89901120764637;497.7287378378784;521.9686818790871;559.7397210297208;602.9035354343306;25078.498430031388;32478;39017.414738778905;40251.39622905659;40339.59660403402;42368.576314236845;42636.78681606596;42879.571204287946;42880;42956;9452.66915657952;9616.374935629197;9634.566444510014;9639.855402168972;9643.758906027335;8919.42023768453;9241.722748317561;9466.29002824791;11431.828522572168;11657;11701.707457313592;11747.353895535742;11766.705832354217;11766.764664706701;11768.705782355424;11619.244749091282;11681.065514758799;11697.94151029248;11715.941420292844;11748.588799392066;11540.422978851107;11604.767904641943;11615.128865335133;11615.6515304541;11617.941910290394;39608.60391396078;39890;39911.401328980086;39977;40025.79987100046;3292.720118789882;3312.3706495765728;3489.249811290559;3579.2483578448555;3709.870154544578;28038.299042523897;29089;29127.271818204503;30584.8470757647;31001.224969375722;3276.4921437177036;3310.7351411886993;3383.069655844638;3430.1939044324563;3502.702270307027;499547;499785;500726.4963675158;500805;501136;58416.707916460145;58769;58928;58965;59030.40969590335;62166.68916655388;62229;62346.376536234966;62404.375956239855;62456.750864982445;16336.264868080965;16540.503784886474;16557.08936008507;16565.751513727304;16587.751183732253;11649.708757281136;12924.870751292367;12947.287899165636;12972.481100755864;13002.414891329912;14167.866570674321;14645.560633181021;15335.515804642753;20318.796812031986;20332.9833508324;8105.8378832424205;8162.510249385056;8198.221168988937;8216.301614362847;8218.082580683891;813.2355585749376;964.2093483343731;1004.8695217879886;1034.2760067952463;1037.6523864505475;32337.676623233467;32569.51145732816;32712.509312360333;32728.672713273038;33261.833690831394;1001.649422702063;1102.9338239705644;1120.3278033180027;1137.6302701622005;1165.1727273635645;14955.40178392852;15094.622634434227;15252.237388130548;15489.380424782883;15494.84505154934;671486;675809;676039;677646;680111;56794.716026419606;57209;57234;57281;57360.71319643458;1225.6568160914958;1298.3508245877063;1361.5506882728873;1391.172252509755;1425.7219842130685;28674.99637512677;29006.56490152607;30568.541471877495;30626.387472250877;31252.843735781174;48964;49203.753981229864;49415.50584494109;49445.752771235915;49477.75261123815;561805;567961;568601;568711;569078;23958.08335333134;24141.275761727175;25452.363690907874;26387.868060659574;26926;45167;45412.54587454083;45572.632821015424;45752.313715294964;45781.31328030016;36291.27417451689;36731.08172295714;36914.8154259227;36970;37065.81467092647;34709.65290347064;36751.89744307675;37042;38054.42918356171;38101.4284785734;34150.63397464074;36704.449433257985;37145.257094857414;37355.626443735215;38134.61865381311;31942.201444964063;34030.65969340374;34058.65941340555;34650.78722244709;34835.477467837496;25356.366090847878;25384.873075634503;25500;25692.486150276516;26052.478950421264 07:06:41 INFO - PROCESS | 1638 | |2;jquery.html;378.5400738103204;381.35931634853455;390.34422170753135;405.3210871789751;406.50203500711615;19080.522986925334;20847.760360018758;21049.894750526266;21327;21559;19962.70055949162;20489.282875099336;20504.794952050514;20715.78905269682;20977.58044839102;5944.494717948979;5977.432143946318;6148;6203.379662033805;6205.596636218654;4358.4987726411555;4594.058218065288;4595.425571803525;6046.516278697693;6190.628562286255;6451.870962580769;6743.527953043289;6775.695093720769;6832.180138383401;6853.040574319574;6656.567323124005;6715.8321041974095;6756.966215168942;6766.627835469048;6779.118714567099;5885.264341957255;5886.911696324559;5941.3761555036535;5953.910691339634;5960.37416071315;25982.610260846104;25991.61012584813;26013.73986260151;26238.606420903703;26247.73752262472;2125.925592604267;2226.2875879718495;2301.838871279011;2318.3508617587104;2406.6390041493914;9879.950600247024;10255.897441025569;10290.279680422298;10517.158627309796;10652.467376631137;1857.6099019205983;1867.6451474219855;1885.8962757048357;1914;1973.9932634356437;112977;117935.41032294784;118380;120984;129496;11203.663890083311;11304.886951130384;11674.124440666985;11698.941505292589;11887.76224475523;14853.851461485463;14855.108693478425;14862.959592828614;14875.404983800527;14903.627409314853;8333.250007499355;8566.27186689126;8613.784655383666;8745.256653184424;8770.561471926378;8464.238218560358;8551.74344769658;8583;8653.74038778825;8674.913250867537;3722.3485889969147;4463.839401755502;4560.175929628109;4677.906441871143;4683.625309975194;1659.9170041498119;1772.9822701773076;1808.5749848785524;1814.5151349299126;1830.7544912557635;765.6324964017192;855.268745222838;937.779621788879;944.0323668240109;977.2231076294221;18570.628587428175;20244.595108097754;21342.89328553347;21698.89150554237;21822.890885545472;945.8155659646441;946.4226821638795;955.9665411710557;972.5380444288907;986.9901300986899;11210.103191744642;11451.370174640475;11498.712532186595;11518.88481115195;11561.190716649922;487915;558845;567866;568762;569197;111593;146362;149254;151720;152191;996.7607774134156;1001.5643195210107;1025.5231317437429;1051.8369652703843;1052.1740433759462;13610.606755920846;17093.829061709224;18961;19708.60582788365;19848.80151198527;39791.80104099461;51469.742651286506;52846.471535285695;52956.47043529515;54479.45520544744;73475.63262183654;75666.864997024;76146;76218.6189069051;77437;7173.5337203081635;7286.4170866329505;7430.96284518574;7444.461520918931;7749.496282741604;12569.49722011146;12980.15628984113;13094.214347139203;13112.737745245233;13599.388027538587;11342.476376054547;11387.316760994367;11563.479643415898;11661.883381166079;11662;11123.888761112285;11218.943905280421;11261.605843795427;11371.374574398487;11401.20191586581;10211.7447063824;11091;11304.660860174208;11566.826497602711;11681.415929203336;7477.327040566375;7520.8871866920945;7601.581912994839;7625.3137217648455;7708.03649543807;8992.46045237288;9178.908210918073;10851.131909447384;11100.555977761122;11419.143564232882 07:06:41 INFO - PROCESS | 1638 | |3;mootools.html;1461.7807328900662;1491.8284397294312;1621.7810595569601;1649.8432648898358;1826.3151318255655;7042.894356584656;7980.521168729881;8412.36907231957;8421.705240316582;8428.03077646071;7512.211217822119;7732.9226707732905;8021.959890200541;8218.30144437722;8232.341412686985;1990.5720270141917;2332.265336419027;2366.325597204797;2368.4315764216635;2371.3715865295712;2372.1578839511985;2384.523095380931;2408.7229968553665;2411.602085655865;2416.758324167578;2345.7654234576576;2346.3430239532872;2370.525894821034;2372.063035101134;2377.453185767266;2335.019291897407;2338.088145623208;2363.7399886012527;2363.917262895799;2367.6093444581625;2361.374235827507;2367.1596583212886;2388.0925248405497;2388.581998150317;2395.652630368604;8335.416520843544;8397.958010209972;8444.071152173317;8451.619677114544;8458.323334133316;5074.797008119671;5230.189320655304;5236.083685355047;5244.8688782780355;5245.4754524547625;3518.489818976234;3535.1515636247113;3537.451694987281;3603;3611.151379425859;1068.2415485005656;1075.714935542082;1089.0742868561738;1110.6445937300068;1123.820188769801;10780.975807298373;10884.292520986111;10908.290961087583;10922.781544369147;10946.124310055176;3835.424686297022;4372.562743725665;4575.5424457554645;4661.930071048937;4696.154692155376;9320.72037838866;9328.580213890391;9328.906710932939;9330.720078397659;9333.486658233862;5191.8182863599595;5206;5208.192730126836;5210.452902445264;5217.739113044408;4339.7613131278085;4388.253996820548;4658.091672123971;4767.356406885026;4794.2808578713475;3734.3651579231596;3784.299904517673;3887.2225554889137;3888.183481468867;3892.377219644843;1257.6478585995935;1272.573687814574;1276.3618190904547;1287.7102651903247;1288.2850018239778;787.4448513797759;866.4021824940771;901.8602116671926;919.3426699909596;931.1759093202564;5169.81905633301;5692.516136128475;5724.599278050497;5849.210356601804;6002.369751176151;860.3762272352494;887.6227603268715;912.1790388650268;921.8755468011733;922.0042354257386;3453.4129198036394;3680.245549662313;3685.3734865073;3783.905402364908;3889.4749208857006;9775.217982561378;9998.450085245237;10110;10110.090091891765;10129.240306977006;8356.958215208884;10062.094411502854;10065.69802905914;10066.69799906004;10078.244131690153;7140.9642951785945;7629.618519074024;7714.228577142241;7867.370610351159;7875.291223789772;5038.01758657073;5481.369642491165;5507.5593952484505;5561.110222364402;5743.770249190153;7856.292933636;8401.453905496122;9269.768255793659;9352.859707104262;9361.531923403667;9275.489848058422;9437.056294370508;9477.099675530813;9577.616895324109;9591.712248632552;6651.235107962646;6833.897491537531;7006.299370063157;7239.312265334785;7243.20324764286;7497.512661676974;7513.624318784148;7603.847923041619;7605.429592780453;7876.803079922818;7052.541584796972;7164.283571642794;7192.784216473514;7238.855222895408;7325.120985481776;7082.468814838805;7087.68105435267;7100.289971002859;7106.324899134574;7128.893066603901;6595.604263744191;6630.701618427086;6702.229243636849;6702.497312701469;6715.127033485615;4663.743494107721;4677.532246775295;4734.171519984058;4735.763211839463;4802.8799280018275;3767.453719210754;4306.20335237982;4808.158572249912;4906.828261010847;4931.926021109614 07:06:41 INFO - PROCESS | 1638 | |4;prototype.html;314.78909130882306;317.89350567559865;321.89377505423204;326.4808953763517;329.58472324870655;5354.420445968439;5356.303680521536;5357.598180136491;5373.408925018254;5373.435789242127;4091.8747344480284;4106.876793696187;5166.5866730661555;5281.366236051669;5293.8941221175555;2750.6659270253913;3779.603141670126;3815.67566756826;3842.1163132479546;3960.3663413853787;3421.6407277235903;3619.855205791765;3859.8070096495203;3977.681785457171;3993.0616305168264;3250.6099268087864;3942;3948.9930067832806;3982.112968098135;3996.5603783583783;3768.8869333920024;3912;3932;3933.8819835404697;4002.3396139636925;2882.4523340565224;3150.503510832359;3482;3493.6681015303507;3510.8946731598094;3979.5224573051128;4176.394422808706;5054.0686401886815;5057.949420505822;5060.254212296789;4298.656107511391;4489.653104068799;4603.539646035403;4616;4630.7453090080035;4315.51114865371;5466.890662186774;5493.972530137364;5503.046418521447;5510.641808282448;3362.865485380582;3800.9619903800885;3802.315583195024;3817.5609804872515;3820.5797362290127;4644.397682799428;4697.553732395417;5678.939558215896;5826.329972053226;5857.105025158265;3213.887513937001;3656.835442405098;3839.3856982882603;3858.803770831051;3861.45939568455;3905.804709764557;3928.5285765707727;3932.210844065943;3935.704822138351;3940.566537680853;3800.5439347278502;4432.556744325541;4518.367428560005;4567.38340324052;4568.1548913451115;5270.841874743764;5506.669599823943;5508.182299841043;5560.833175004756;5585.69278689676;1093.371311495893;1104.2049724198564;1258.6349958511928;1278.2649976263685;1279.33474593211;737.8266107464741;827.9815826533397;853.9786505337416;854.0818619983543;861.6897916749965;4353.521112677603;4557.541586692227;4958.057968985881;5033.219850923113;5293.3647962244;4799.760011999456;5785.595008349375;5794.565407594448;5813.680247586339;5821.330546987066;4455.215490318551;4485.820567177341;5183.585313174937;5210.853612205385;5339;2424.666433461589;2556;2689.67343248089;2809.7611703005064;2839.872205750746;5031.867829738279;5646.781334639216;5657.2928383952;5657.8019769307875;5786.218860453785;4853.514648535118;5406.594505412031;5436.864078398072;5534.944650553443;5562.4425160955;5907.1434641976675;5942.7920022799;5990.670513121733;6005.219321488178;6008.939910600838;4748.884012257047;5769.9711501442225;5787.768489260382;5790.855228619318;5853.619514731528;4724.338592597108;5400.865818178069;5616.943830561642;5688.3742788294085;5714.314282285986;5949.007082627195;5959.553033522417;5962.493188079062;5969.970150149222;5997.610155339889;3945.1320709443876;3985.621365970228;3995.760254384746;4016.758994460342;4029.6373326400767;5528.668279903219;5592.3009623797025;5647.830565083054;5683.914741278967;5755.963926493271;4593.425821772278;5428.321459817523;5468.535174510212;5500.972495137498;5539.418361072029;5329.840104796862;5479.904019196257;5528.474794894479;5557.666540007613;5566.471185237396;4835.903281934271;5423.240746295601;5429.728513574227;5438.211459338453;5443.59173062014;5261.079311120462;5472.358292512151;5479.589030822784;5517;5547.472990065938;4884.9741554274;4933.802647894044;5375.489328513785;5392.352917649907;5552.888942221214 07:06:41 INFO - PROCESS | 1638 | |5;yui.html;628.9811305660829;703.8768215562276;724.967376468059;780.7891869195321;839.5160085644578;14518.927405362972;15016.324265408055;15234.619134521643;15252.542423727306;15280.312385942618;12628.494860205603;13706.58880233592;13757.105788123765;13961.650958726037;14026.438942442315;842.2125312832521;861.0399404663787;861.6682577207757;861.8233262181237;868.522312727997;858.8754630578594;865.0786911938796;865.5455885660048;865.6104752861206;867.1848462445313;902.1700035966926;902.440486898124;903.2909166304453;903.6566104880169;904.4528060523387;897.9371443998923;898.2185498616213;899.1952202778542;899.5906862377602;900.6982660808637;660.0627109504467;674.1303718203511;674.4031532094083;679.8776220280348;680.9863802723968;13769.931150344284;14536.200508972002;14541.272936353245;14573.927130364385;14623.19572423527;13037.087403881733;13059.477620895153;13141.934290328583;13345.39945702436;13405.128666636638;12340.13619046667;12389;12390.504379824797;12481.643183171229;12519.874801251963;4357.433533640607;4366.104948485553;4384.123175364908;4451.710638808467;4602.470715867685;95500;96341.51829240879;96364;98241;98570.0142998568;10092.899071009342;10311.690649280534;10363.844542331872;10379.584816607252;10584.788304233873;19445.930473824075;19596.020198989994;19626.01869906499;19931.501712457306;19976.200951962048;7398.482106252511;7547.207543207884;7574.3183113520045;7600.885986710204;7706.460547761603;4235.597618226264;4319.373690814877;4406.779661016936;4412.84555040572;4488.528704486047;3207.0859804955476;3278.639349671534;3312.006398080566;3316.651751566099;3317.0214786638;613.9355367686329;622.0513716582249;624.5877720704314;632.9620222786648;637.9919726831595;601.3835818286292;616.7440512187482;619.4146531527753;620.3734228429319;623.5292354272495;8257.256846883809;8714.782130446663;8798.912010879809;8907.688230911886;8962.68630597926;606.1907353682883;629.4649547884353;638.3297537585516;644.452215616722;655.5214693273937;4094.6724262058965;4327.76197309151;4330.935035974463;4351.73889566627;4479.977600112044;99555.50222248843;122357;129322.70677293107;130585.34707326592;132440.67559324476;63707.681461592394;80891;86546.56726716452;88896;102705;68477.31522684809;69754.65122674455;87018;91557.5422122885;93848;9535.33252672334;9711.805763884542;9897.35667181631;9900.603975840886;9943.502824858584;54567.520517284254;55464;55610;57162.428375717376;57172.14241786293;66526.33473665202;79623;82046.76929845937;82138;86044.70932935886;11855.051595872483;12049.096317776026;12309.907315756163;12311.56909508163;12627.242365458102;12465.878070973657;13449.193048416735;13975.720485590027;14937.850621493646;14991.475298364505;11451.312921224753;12031.45858436355;12657.240565566095;12947.287899165636;13239.3380330985;12823.230606163661;13060;13300.017883044779;13375.464981400635;13467.461301548221;12291.139620226855;13084.345782710636;13105.623909489366;13199.20804751718;13368.799468008183;10746.301490403099;10956.28784129029;11074.833877491683;11084.002439780135;11177;8844.98282697498;8930.732078037669;9872.506374681094;10079.748006299902;11401.885981140082 07:06:41 INFO - PROCESS | 1638 | __end_tp_report 07:06:41 INFO - PROCESS | 1638 | __start_cc_report 07:06:41 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1570 07:06:41 INFO - PROCESS | 1638 | __end_cc_report 07:06:41 INFO - PROCESS | 1638 | __startTimestamp1487257601835__endTimestamp 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | ------- Summary: start ------- 07:06:41 INFO - PROCESS | 1638 | Number of tests: 6 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5803.28 Median:6052.30 stddev:653.36 (10.8%) stddev-sans-first:615.93 07:06:41 INFO - PROCESS | 1638 | Values: 2953.6 3457.8 3526.4 3549.1 3580.3 5754.2 5773.0 5802.8 5804.4 5845.3 5732.5 5792.4 5792.7 5798.5 5801.0 5189.9 5234.1 5246.3 5253.4 5289.8 5155.5 5187.5 5192.8 5240.2 5310.9 5268.1 5274.1 5274.4 5281.2 5282.2 5218.2 5258.5 5280.0 5281.3 5289.6 5140.3 5199.0 5282.7 5286.4 5299.4 5901.6 5963.5 5964.9 5965.6 5966.0 6131.3 6193.0 6209.8 6316.5 6316.9 6252.1 6260.3 6285.2 6288.9 6301.2 5864.0 5888.3 5893.5 5894.4 5922.3 6236.3 6251.6 6328.5 6337.7 6373.7 6192.2 6252.4 6272.8 6283.9 6293.7 5583.8 5658.2 5959.6 6333.2 6354.9 6127.4 6131.7 6170.1 6285.3 6314.0 6198.8 6255.4 6277.8 6324.3 6337.3 4990.5 5010.6 5012.9 5018.0 5020.1 4452.9 4500.4 4506.3 4508.3 4518.8 5842.0 5858.3 5893.7 5951.8 6021.7 6275.6 6278.6 6292.2 6311.6 6325.6 5996.0 6030.9 6048.5 6052.3 6076.1 5372.4 5459.1 5472.3 5517.0 5532.4 6263.3 6341.0 6341.5 6346.7 6350.6 6249.3 6288.1 6293.2 6294.9 6337.0 6427.3 6466.7 6482.2 6495.0 6497.0 5566.0 6096.9 6302.5 6309.2 6310.0 5125.6 6177.6 6239.1 6255.0 6302.3 6237.1 6257.8 6271.0 6274.1 6284.0 6154.1 6159.5 6167.4 6227.8 6236.3 4327.9 5964.1 6026.2 6123.0 6143.9 6109.7 6200.3 6208.6 6212.9 6214.5 6020.4 6054.2 6071.7 6080.9 6115.2 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:71052.33 Median:3495.98 stddev:156654.19 (4481.0%) stddev-sans-first:157004.04 07:06:41 INFO - PROCESS | 1638 | Values: 480.9 497.7 522.0 559.7 602.9 25078.5 32478.0 39017.4 40251.4 40339.6 42368.6 42636.8 42879.6 42880.0 42956.0 9452.7 9616.4 9634.6 9639.9 9643.8 8919.4 9241.7 9466.3 11431.8 11657.0 11701.7 11747.4 11766.7 11766.8 11768.7 11619.2 11681.1 11697.9 11715.9 11748.6 11540.4 11604.8 11615.1 11615.7 11617.9 39608.6 39890.0 39911.4 39977.0 40025.8 3292.7 3312.4 3489.2 3579.2 3709.9 28038.3 29089.0 29127.3 30584.8 31001.2 3276.5 3310.7 3383.1 3430.2 3502.7 499547.0 499785.0 500726.5 500805.0 501136.0 58416.7 58769.0 58928.0 58965.0 59030.4 62166.7 62229.0 62346.4 62404.4 62456.8 16336.3 16540.5 16557.1 16565.8 16587.8 11649.7 12924.9 12947.3 12972.5 13002.4 14167.9 14645.6 15335.5 20318.8 20333.0 8105.8 8162.5 8198.2 8216.3 8218.1 813.2 964.2 1004.9 1034.3 1037.7 32337.7 32569.5 32712.5 32728.7 33261.8 1001.6 1102.9 1120.3 1137.6 1165.2 14955.4 15094.6 15252.2 15489.4 15494.8 671486.0 675809.0 676039.0 677646.0 680111.0 56794.7 57209.0 57234.0 57281.0 57360.7 1225.7 1298.4 1361.6 1391.2 1425.7 28675.0 29006.6 30568.5 30626.4 31252.8 48964.0 49203.8 49415.5 49445.8 49477.8 561805.0 567961.0 568601.0 568711.0 569078.0 23958.1 24141.3 25452.4 26387.9 26926.0 45167.0 45412.5 45572.6 45752.3 45781.3 36291.3 36731.1 36914.8 36970.0 37065.8 34709.7 36751.9 37042.0 38054.4 38101.4 34150.6 36704.4 37145.3 37355.6 38134.6 31942.2 34030.7 34058.7 34650.8 34835.5 25356.4 25384.9 25500.0 25692.5 26052.5 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:34077.83 Median:14194.62 stddev:92976.49 (655.0%) stddev-sans-first:93202.88 07:06:41 INFO - PROCESS | 1638 | Values: 378.5 381.4 390.3 405.3 406.5 19080.5 20847.8 21049.9 21327.0 21559.0 19962.7 20489.3 20504.8 20715.8 20977.6 5944.5 5977.4 6148.0 6203.4 6205.6 4358.5 4594.1 4595.4 6046.5 6190.6 6451.9 6743.5 6775.7 6832.2 6853.0 6656.6 6715.8 6757.0 6766.6 6779.1 5885.3 5886.9 5941.4 5953.9 5960.4 25982.6 25991.6 26013.7 26238.6 26247.7 2125.9 2226.3 2301.8 2318.4 2406.6 9880.0 10255.9 10290.3 10517.2 10652.5 1857.6 1867.6 1885.9 1914.0 1974.0 112977.0 117935.4 118380.0 120984.0 129496.0 11203.7 11304.9 11674.1 11698.9 11887.8 14853.9 14855.1 14863.0 14875.4 14903.6 8333.3 8566.3 8613.8 8745.3 8770.6 8464.2 8551.7 8583.0 8653.7 8674.9 3722.3 4463.8 4560.2 4677.9 4683.6 1659.9 1773.0 1808.6 1814.5 1830.8 765.6 855.3 937.8 944.0 977.2 18570.6 20244.6 21342.9 21698.9 21822.9 945.8 946.4 956.0 972.5 987.0 11210.1 11451.4 11498.7 11518.9 11561.2 487915.0 558845.0 567866.0 568762.0 569197.0 111593.0 146362.0 149254.0 151720.0 152191.0 996.8 1001.6 1025.5 1051.8 1052.2 13610.6 17093.8 18961.0 19708.6 19848.8 39791.8 51469.7 52846.5 52956.5 54479.5 73475.6 75666.9 76146.0 76218.6 77437.0 7173.5 7286.4 7431.0 7444.5 7749.5 12569.5 12980.2 13094.2 13112.7 13599.4 11342.5 11387.3 11563.5 11661.9 11662.0 11123.9 11218.9 11261.6 11371.4 11401.2 10211.7 11091.0 11304.7 11566.8 11681.4 7477.3 7520.9 7601.6 7625.3 7708.0 8992.5 9178.9 10851.1 11100.6 11419.1 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5400.63 Median:5198.91 stddev:2930.90 (56.4%) stddev-sans-first:2924.17 07:06:41 INFO - PROCESS | 1638 | Values: 1461.8 1491.8 1621.8 1649.8 1826.3 7042.9 7980.5 8412.4 8421.7 8428.0 7512.2 7732.9 8022.0 8218.3 8232.3 1990.6 2332.3 2366.3 2368.4 2371.4 2372.2 2384.5 2408.7 2411.6 2416.8 2345.8 2346.3 2370.5 2372.1 2377.5 2335.0 2338.1 2363.7 2363.9 2367.6 2361.4 2367.2 2388.1 2388.6 2395.7 8335.4 8398.0 8444.1 8451.6 8458.3 5074.8 5230.2 5236.1 5244.9 5245.5 3518.5 3535.2 3537.5 3603.0 3611.2 1068.2 1075.7 1089.1 1110.6 1123.8 10781.0 10884.3 10908.3 10922.8 10946.1 3835.4 4372.6 4575.5 4661.9 4696.2 9320.7 9328.6 9328.9 9330.7 9333.5 5191.8 5206.0 5208.2 5210.5 5217.7 4339.8 4388.3 4658.1 4767.4 4794.3 3734.4 3784.3 3887.2 3888.2 3892.4 1257.6 1272.6 1276.4 1287.7 1288.3 787.4 866.4 901.9 919.3 931.2 5169.8 5692.5 5724.6 5849.2 6002.4 860.4 887.6 912.2 921.9 922.0 3453.4 3680.2 3685.4 3783.9 3889.5 9775.2 9998.5 10110.0 10110.1 10129.2 8357.0 10062.1 10065.7 10066.7 10078.2 7141.0 7629.6 7714.2 7867.4 7875.3 5038.0 5481.4 5507.6 5561.1 5743.8 7856.3 8401.5 9269.8 9352.9 9361.5 9275.5 9437.1 9477.1 9577.6 9591.7 6651.2 6833.9 7006.3 7239.3 7243.2 7497.5 7513.6 7603.8 7605.4 7876.8 7052.5 7164.3 7192.8 7238.9 7325.1 7082.5 7087.7 7100.3 7106.3 7128.9 6595.6 6630.7 6702.2 6702.5 6715.1 4663.7 4677.5 4734.2 4735.8 4802.9 3767.5 4306.2 4808.2 4906.8 4931.9 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4452.30 Median:5032.54 stddev:1410.90 (28.0%) stddev-sans-first:1380.25 07:06:41 INFO - PROCESS | 1638 | Values: 314.8 317.9 321.9 326.5 329.6 5354.4 5356.3 5357.6 5373.4 5373.4 4091.9 4106.9 5166.6 5281.4 5293.9 2750.7 3779.6 3815.7 3842.1 3960.4 3421.6 3619.9 3859.8 3977.7 3993.1 3250.6 3942.0 3949.0 3982.1 3996.6 3768.9 3912.0 3932.0 3933.9 4002.3 2882.5 3150.5 3482.0 3493.7 3510.9 3979.5 4176.4 5054.1 5057.9 5060.3 4298.7 4489.7 4603.5 4616.0 4630.7 4315.5 5466.9 5494.0 5503.0 5510.6 3362.9 3801.0 3802.3 3817.6 3820.6 4644.4 4697.6 5678.9 5826.3 5857.1 3213.9 3656.8 3839.4 3858.8 3861.5 3905.8 3928.5 3932.2 3935.7 3940.6 3800.5 4432.6 4518.4 4567.4 4568.2 5270.8 5506.7 5508.2 5560.8 5585.7 1093.4 1104.2 1258.6 1278.3 1279.3 737.8 828.0 854.0 854.1 861.7 4353.5 4557.5 4958.1 5033.2 5293.4 4799.8 5785.6 5794.6 5813.7 5821.3 4455.2 4485.8 5183.6 5210.9 5339.0 2424.7 2556.0 2689.7 2809.8 2839.9 5031.9 5646.8 5657.3 5657.8 5786.2 4853.5 5406.6 5436.9 5534.9 5562.4 5907.1 5942.8 5990.7 6005.2 6008.9 4748.9 5770.0 5787.8 5790.9 5853.6 4724.3 5400.9 5616.9 5688.4 5714.3 5949.0 5959.6 5962.5 5970.0 5997.6 3945.1 3985.6 3995.8 4016.8 4029.6 5528.7 5592.3 5647.8 5683.9 5756.0 4593.4 5428.3 5468.5 5501.0 5539.4 5329.8 5479.9 5528.5 5557.7 5566.5 4835.9 5423.2 5429.7 5438.2 5443.6 5261.1 5472.4 5479.6 5517.0 5547.5 4885.0 4933.8 5375.5 5392.4 5552.9 07:06:41 INFO - PROCESS | 1638 | 07:06:41 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20988.81 Median:4545.50 stddev:31375.15 (690.2%) stddev-sans-first:31425.93 07:06:41 INFO - PROCESS | 1638 | Values: 629.0 703.9 725.0 780.8 839.5 14518.9 15016.3 15234.6 15252.5 15280.3 12628.5 13706.6 13757.1 13961.7 14026.4 842.2 861.0 861.7 861.8 868.5 858.9 865.1 865.5 865.6 867.2 902.2 902.4 903.3 903.7 904.5 897.9 898.2 899.2 899.6 900.7 660.1 674.1 674.4 679.9 681.0 13769.9 14536.2 14541.3 14573.9 14623.2 13037.1 13059.5 13141.9 13345.4 13405.1 12340.1 12389.0 12390.5 12481.6 12519.9 4357.4 4366.1 4384.1 4451.7 4602.5 95500.0 96341.5 96364.0 98241.0 98570.0 10092.9 10311.7 10363.8 10379.6 10584.8 19445.9 19596.0 19626.0 19931.5 19976.2 7398.5 7547.2 7574.3 7600.9 7706.5 4235.6 4319.4 4406.8 4412.8 4488.5 3207.1 3278.6 3312.0 3316.7 3317.0 613.9 622.1 624.6 633.0 638.0 601.4 616.7 619.4 620.4 623.5 8257.3 8714.8 8798.9 8907.7 8962.7 606.2 629.5 638.3 644.5 655.5 4094.7 4327.8 4330.9 4351.7 4480.0 99555.5 122357.0 129322.7 130585.3 132440.7 63707.7 80891.0 86546.6 88896.0 102705.0 68477.3 69754.7 87018.0 91557.5 93848.0 9535.3 9711.8 9897.4 9900.6 9943.5 54567.5 55464.0 55610.0 57162.4 57172.1 66526.3 79623.0 82046.8 82138.0 86044.7 11855.1 12049.1 12309.9 12311.6 12627.2 12465.9 13449.2 13975.7 14937.9 14991.5 11451.3 12031.5 12657.2 12947.3 13239.3 12823.2 13060.0 13300.0 13375.5 13467.5 12291.1 13084.3 13105.6 13199.2 13368.8 10746.3 10956.3 11074.8 11084.0 11177.0 8845.0 8930.7 9872.5 10079.7 11401.9 07:06:41 INFO - PROCESS | 1638 | -------- Summary: end -------- 07:06:41 INFO - PROCESS | 1638 | 07:06:42 INFO - TEST-INFO | 1638: exit 0 07:06:42 INFO - TEST-OK | dromaeo_css | took 1118025ms 07:06:42 INFO - TEST-START | kraken 07:06:42 INFO - operating with platform_type : mac_ 07:06:42 INFO - Initialising browser for kraken test... 07:06:42 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpsAYH78/profile http://localhost:49242/getInfo.html) 07:06:44 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 07:06:44 INFO - PROCESS | 1648 | colorDepth:24 07:06:44 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 07:06:44 INFO - PROCESS | 1648 | __metrics 07:06:45 INFO - PROCESS | 1648 | 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" 07:06:45 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:45 INFO - TEST-INFO | 1648: exit 0 07:06:45 INFO - Browser initialized. 07:06:45 INFO - Running cycle 1/1 for kraken test... 07:06:45 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpsAYH78/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:57 INFO - PROCESS | 1650 | RSS: Main: 172421120 07:06:57 INFO - PROCESS | 1650 | 07:07:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:01 INFO - PROCESS | 1650 | RSS: Main: 221880320 07:07:01 INFO - PROCESS | 1650 | 07:07:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 07:07:04 INFO - PROCESS | 1650 | RSS: Main: 233852928 07:07:04 INFO - PROCESS | 1650 | 07:07:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 07:07:08 INFO - PROCESS | 1650 | RSS: Main: 331722752 07:07:08 INFO - PROCESS | 1650 | 07:07:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 07:07:11 INFO - PROCESS | 1650 | RSS: Main: 233291776 07:07:11 INFO - PROCESS | 1650 | 07:07:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:07:13 INFO - PROCESS | 1650 | RSS: Main: 234037248 07:07:13 INFO - PROCESS | 1650 | 07:07:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 07:07:17 INFO - PROCESS | 1650 | RSS: Main: 275345408 07:07:17 INFO - PROCESS | 1650 | 07:07:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 07:07:20 INFO - PROCESS | 1650 | RSS: Main: 275849216 07:07:20 INFO - PROCESS | 1650 | 07:07:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 07:07:23 INFO - PROCESS | 1650 | RSS: Main: 273276928 07:07:23 INFO - PROCESS | 1650 | 07:07:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:25 INFO - PROCESS | 1650 | RSS: Main: 248893440 07:07:25 INFO - PROCESS | 1650 | 07:07:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:28 INFO - PROCESS | 1650 | RSS: Main: 252252160 07:07:28 INFO - PROCESS | 1650 | 07:07:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:07:31 INFO - PROCESS | 1650 | RSS: Main: 254238720 07:07:31 INFO - PROCESS | 1650 | 07:07:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:07:34 INFO - PROCESS | 1650 | RSS: Main: 266461184 07:07:34 INFO - PROCESS | 1650 | 07:07:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:07:38 INFO - PROCESS | 1650 | RSS: Main: 266899456 07:07:38 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 07:07:40 INFO - PROCESS | 1650 | RSS: Main: 310317056 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | __start_tp_report 07:07:40 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 07:07:40 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 07:07:40 INFO - PROCESS | 1650 | |i|pagename|runs| 07:07:40 INFO - PROCESS | 1650 | |0;ai-astar;117;115;116;113;113;116;114;112;113;112 07:07:40 INFO - PROCESS | 1650 | |1;audio-beat-detection;142;110;107;143;106;106;107;107;136;108 07:07:40 INFO - PROCESS | 1650 | |2;audio-dft;196;264;203;181;179;181;178;182;182;181 07:07:40 INFO - PROCESS | 1650 | |3;audio-fft;81;61;72;113;85;60;61;47;84;73 07:07:40 INFO - PROCESS | 1650 | |4;audio-oscillator;92;70;94;68;68;68;89;67;70;91 07:07:40 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;87;85;88;84;87;84;87;87;89;83 07:07:40 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;93;94;93;94;93;93;94;94;94 07:07:40 INFO - PROCESS | 1650 | |7;imaging-desaturate;81;80;76;79;82;81;83;84;83;82 07:07:40 INFO - PROCESS | 1650 | |8;json-parse-financial;57;55;54;56;56;57;57;57;56;55 07:07:40 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;66;71;66;74;73;68;100;101;100;95 07:07:40 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;85;82;84;82;82;81;83;83;80;82 07:07:40 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;139;146;138;136;138;139;136;139;172;147 07:07:40 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;165;162;165;165;163;163;155;158;164;158 07:07:40 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;77;88;83;85;77;65;64;65;65 07:07:40 INFO - PROCESS | 1650 | __end_tp_report 07:07:40 INFO - PROCESS | 1650 | __start_cc_report 07:07:40 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1927 07:07:40 INFO - PROCESS | 1650 | __end_cc_report 07:07:40 INFO - PROCESS | 1650 | __startTimestamp1487257660321__endTimestamp 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | ------- Summary: start ------- 07:07:40 INFO - PROCESS | 1650 | Number of tests: 14 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.79 (1.6%) stddev-sans-first:1.56 07:07:40 INFO - PROCESS | 1650 | Values: 117.0 115.0 116.0 113.0 113.0 116.0 114.0 112.0 113.0 112.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:109.00 stddev:16.10 (14.8%) stddev-sans-first:14.36 07:07:40 INFO - PROCESS | 1650 | Values: 142.0 110.0 107.0 143.0 106.0 106.0 107.0 107.0 136.0 108.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:192.70 Median:182.00 stddev:26.34 (14.5%) stddev-sans-first:27.91 07:07:40 INFO - PROCESS | 1650 | Values: 196.0 264.0 203.0 181.0 179.0 181.0 178.0 182.0 182.0 181.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:73.70 Median:72.50 stddev:18.43 (25.4%) stddev-sans-first:19.36 07:07:40 INFO - PROCESS | 1650 | Values: 81.0 61.0 72.0 113.0 85.0 60.0 61.0 47.0 84.0 73.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:11.97 (15.1%) stddev-sans-first:11.53 07:07:40 INFO - PROCESS | 1650 | Values: 92.0 70.0 94.0 68.0 68.0 68.0 89.0 67.0 70.0 91.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.97 (2.3%) stddev-sans-first:2.06 07:07:40 INFO - PROCESS | 1650 | Values: 87.0 85.0 88.0 84.0 87.0 84.0 87.0 87.0 89.0 83.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:07:40 INFO - PROCESS | 1650 | Values: 93.0 93.0 94.0 93.0 94.0 93.0 93.0 94.0 94.0 94.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:81.10 Median:82.00 stddev:2.33 (2.8%) stddev-sans-first:2.47 07:07:40 INFO - PROCESS | 1650 | Values: 81.0 80.0 76.0 79.0 82.0 81.0 83.0 84.0 83.0 82.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.05 (1.9%) stddev-sans-first:1.05 07:07:40 INFO - PROCESS | 1650 | Values: 57.0 55.0 54.0 56.0 56.0 57.0 57.0 57.0 56.0 55.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:81.40 Median:69.50 stddev:15.45 (22.2%) stddev-sans-first:15.35 07:07:40 INFO - PROCESS | 1650 | Values: 66.0 71.0 66.0 74.0 73.0 68.0 100.0 101.0 100.0 95.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.43 (1.7%) stddev-sans-first:1.17 07:07:40 INFO - PROCESS | 1650 | Values: 85.0 82.0 84.0 82.0 82.0 81.0 83.0 83.0 80.0 82.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:139.00 stddev:10.86 (7.8%) stddev-sans-first:11.42 07:07:40 INFO - PROCESS | 1650 | Values: 139.0 146.0 138.0 136.0 138.0 139.0 136.0 139.0 172.0 147.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:163.50 stddev:3.55 (2.2%) stddev-sans-first:3.57 07:07:40 INFO - PROCESS | 1650 | Values: 165.0 162.0 165.0 165.0 163.0 163.0 155.0 158.0 164.0 158.0 07:07:40 INFO - PROCESS | 1650 | 07:07:40 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:77.00 stddev:9.64 (12.5%) stddev-sans-first:9.73 07:07:40 INFO - PROCESS | 1650 | Values: 65.0 77.0 88.0 83.0 85.0 77.0 65.0 64.0 65.0 65.0 07:07:40 INFO - PROCESS | 1650 | -------- Summary: end -------- 07:07:40 INFO - PROCESS | 1650 | 07:07:41 INFO - TEST-INFO | 1650: exit 0 07:07:41 INFO - TEST-OK | kraken | took 58913ms 07:07:41 INFO - SUITE-END | took 1176s 07:07:41 INFO - Completed test suite (00:19:37) 07:07:41 INFO - javascript benchmark 07:07:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2953.6307961504813, 3457.8443970021344, 3526.4005119129747, 3549.0594992327024, 3580.2660454606807, 5754.1944127822135, 5773.0, 5802.767889284423, 5804.390538993408, 5845.269341332328, 5732.541396688265, 5792.4497172768515, 5792.739326730297, 5798.5361171106315, 5801.0, 5189.922151167735, 5234.084035293828, 5246.265522826789, 5253.422123566424, 5289.761960711778, 5155.510226528474, 5187.533122019017, 5192.818251361203, 5240.187770895517, 5310.946890531103, 5268.0780863348955, 5274.129768588178, 5274.4198138204765, 5281.2342210379475, 5282.181261904392, 5218.191180367049, 5258.526732594085, 5280.049591073605, 5281.260623512711, 5289.629725919187, 5140.331756871583, 5199.0, 5282.683039017633, 5286.36563612369, 5299.443558426348, 5901.616394934315, 5963.493103086243, 5964.880702385928, 5965.642061476326, 5965.970170149165, 6131.254333328308, 6193.0, 6209.751609935597, 6316.526260530432, 6316.936830631681, 6252.093446450239, 6260.311365749764, 6285.214348206474, 6288.9056664150075, 6301.180846489973, 5864.032434648278, 5888.322842873039, 5893.499052580493, 5894.410558944071, 5922.2597175353085, 6236.251649802053, 6251.562390632703, 6328.462080723098, 6337.746490140435, 6373.745050198033, 6192.225971753531, 6252.374762523711, 6272.8118156455375, 6283.937160628427, 6293.685315734195, 5583.832485025456, 5658.151277308437, 5959.582829201914, 6333.2400111985935, 6354.904676429857, 6127.372786728296, 6131.662758548234, 6170.074488826622, 6285.340039295808, 6314.02132669437, 6198.783042593487, 6255.405736455121, 6277.843053923689, 6324.3043265240785, 6337.302896681362, 4990.50094990498, 5010.624203184776, 5012.922221722347, 5018.0, 5020.071286811952, 4452.933206001912, 4500.4149460569915, 4506.301523263899, 4508.256137737237, 4518.8418405356315, 5842.0, 5858.297004359504, 5893.705314734332, 5951.791687290924, 6021.729022194012, 6275.560710750204, 6278.623282603058, 6292.182016337847, 6311.589746666452, 6325.557210995278, 5995.950708625973, 6030.879382412327, 6048.455638992512, 6052.303985041776, 6076.088586712029, 5372.435894231127, 5459.099248623933, 5472.288602481732, 5517.034518959246, 5532.3914369419335, 6263.342349053375, 6341.0, 6341.492680585542, 6346.746130154742, 6350.618962862243, 6249.25008998923, 6288.11966324724, 6293.244810622755, 6294.937050629435, 6337.0, 6427.260865000398, 6466.708998095003, 6482.189726284215, 6495.025746138117, 6496.967515162583, 5565.9721701392855, 6096.9390306096375, 6302.495800336053, 6309.179806625109, 6309.968450157719, 5125.641205115606, 6177.567570270217, 6239.0953311768635, 6255.030470277115, 6302.275238347649, 6237.095621135, 6257.812265632038, 6270.996640537492, 6274.121622972879, 6284.0, 6154.107654389999, 6159.5072394209255, 6167.444929956326, 6227.813165605039, 6236.314005459487, 4327.896386421442, 5964.075568286922, 6026.15633811258, 6122.959096953439, 6143.907841382472, 6109.716387860143, 6200.255969283715, 6208.565400421927, 6212.9068063978175, 6214.471769899428, 6020.4280593343565, 6054.1826853376, 6071.666058366833, 6080.939190608215, 6115.235595550556], "value": 5762.606819205079, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.89901120764637, 497.7287378378784, 521.9686818790871, 559.7397210297208, 602.9035354343306, 25078.498430031388, 32478.0, 39017.414738778905, 40251.39622905659, 40339.59660403402, 42368.576314236845, 42636.78681606596, 42879.571204287946, 42880.0, 42956.0, 9452.66915657952, 9616.374935629197, 9634.566444510014, 9639.855402168972, 9643.758906027335, 8919.42023768453, 9241.722748317561, 9466.29002824791, 11431.828522572168, 11657.0, 11701.707457313592, 11747.353895535742, 11766.705832354217, 11766.764664706701, 11768.705782355424, 11619.244749091282, 11681.065514758799, 11697.94151029248, 11715.941420292844, 11748.588799392066, 11540.422978851107, 11604.767904641943, 11615.128865335133, 11615.6515304541, 11617.941910290394, 39608.60391396078, 39890.0, 39911.401328980086, 39977.0, 40025.79987100046, 3292.720118789882, 3312.3706495765728, 3489.249811290559, 3579.2483578448555, 3709.870154544578, 28038.299042523897, 29089.0, 29127.271818204503, 30584.8470757647, 31001.224969375722, 3276.4921437177036, 3310.7351411886993, 3383.069655844638, 3430.1939044324563, 3502.702270307027, 499547.0, 499785.0, 500726.4963675158, 500805.0, 501136.0, 58416.707916460145, 58769.0, 58928.0, 58965.0, 59030.40969590335, 62166.68916655388, 62229.0, 62346.376536234966, 62404.375956239855, 62456.750864982445, 16336.264868080965, 16540.503784886474, 16557.08936008507, 16565.751513727304, 16587.751183732253, 11649.708757281136, 12924.870751292367, 12947.287899165636, 12972.481100755864, 13002.414891329912, 14167.866570674321, 14645.560633181021, 15335.515804642753, 20318.796812031986, 20332.9833508324, 8105.8378832424205, 8162.510249385056, 8198.221168988937, 8216.301614362847, 8218.082580683891, 813.2355585749376, 964.2093483343731, 1004.8695217879886, 1034.2760067952463, 1037.6523864505475, 32337.676623233467, 32569.51145732816, 32712.509312360333, 32728.672713273038, 33261.833690831394, 1001.649422702063, 1102.9338239705644, 1120.3278033180027, 1137.6302701622005, 1165.1727273635645, 14955.40178392852, 15094.622634434227, 15252.237388130548, 15489.380424782883, 15494.84505154934, 671486.0, 675809.0, 676039.0, 677646.0, 680111.0, 56794.716026419606, 57209.0, 57234.0, 57281.0, 57360.71319643458, 1225.6568160914958, 1298.3508245877063, 1361.5506882728873, 1391.172252509755, 1425.7219842130685, 28674.99637512677, 29006.56490152607, 30568.541471877495, 30626.387472250877, 31252.843735781174, 48964.0, 49203.753981229864, 49415.50584494109, 49445.752771235915, 49477.75261123815, 561805.0, 567961.0, 568601.0, 568711.0, 569078.0, 23958.08335333134, 24141.275761727175, 25452.363690907874, 26387.868060659574, 26926.0, 45167.0, 45412.54587454083, 45572.632821015424, 45752.313715294964, 45781.31328030016, 36291.27417451689, 36731.08172295714, 36914.8154259227, 36970.0, 37065.81467092647, 34709.65290347064, 36751.89744307675, 37042.0, 38054.42918356171, 38101.4284785734, 34150.63397464074, 36704.449433257985, 37145.257094857414, 37355.626443735215, 38134.61865381311, 31942.201444964063, 34030.65969340374, 34058.65941340555, 34650.78722244709, 34835.477467837496, 25356.366090847878, 25384.873075634503, 25500.0, 25692.486150276516, 26052.478950421264], "value": 20255.26102493829, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5400738103204, 381.35931634853455, 390.34422170753135, 405.3210871789751, 406.50203500711615, 19080.522986925334, 20847.760360018758, 21049.894750526266, 21327.0, 21559.0, 19962.70055949162, 20489.282875099336, 20504.794952050514, 20715.78905269682, 20977.58044839102, 5944.494717948979, 5977.432143946318, 6148.0, 6203.379662033805, 6205.596636218654, 4358.4987726411555, 4594.058218065288, 4595.425571803525, 6046.516278697693, 6190.628562286255, 6451.870962580769, 6743.527953043289, 6775.695093720769, 6832.180138383401, 6853.040574319574, 6656.567323124005, 6715.8321041974095, 6756.966215168942, 6766.627835469048, 6779.118714567099, 5885.264341957255, 5886.911696324559, 5941.3761555036535, 5953.910691339634, 5960.37416071315, 25982.610260846104, 25991.61012584813, 26013.73986260151, 26238.606420903703, 26247.73752262472, 2125.925592604267, 2226.2875879718495, 2301.838871279011, 2318.3508617587104, 2406.6390041493914, 9879.950600247024, 10255.897441025569, 10290.279680422298, 10517.158627309796, 10652.467376631137, 1857.6099019205983, 1867.6451474219855, 1885.8962757048357, 1914.0, 1973.9932634356437, 112977.0, 117935.41032294784, 118380.0, 120984.0, 129496.0, 11203.663890083311, 11304.886951130384, 11674.124440666985, 11698.941505292589, 11887.76224475523, 14853.851461485463, 14855.108693478425, 14862.959592828614, 14875.404983800527, 14903.627409314853, 8333.250007499355, 8566.27186689126, 8613.784655383666, 8745.256653184424, 8770.561471926378, 8464.238218560358, 8551.74344769658, 8583.0, 8653.74038778825, 8674.913250867537, 3722.3485889969147, 4463.839401755502, 4560.175929628109, 4677.906441871143, 4683.625309975194, 1659.9170041498119, 1772.9822701773076, 1808.5749848785524, 1814.5151349299126, 1830.7544912557635, 765.6324964017192, 855.268745222838, 937.779621788879, 944.0323668240109, 977.2231076294221, 18570.628587428175, 20244.595108097754, 21342.89328553347, 21698.89150554237, 21822.890885545472, 945.8155659646441, 946.4226821638795, 955.9665411710557, 972.5380444288907, 986.9901300986899, 11210.103191744642, 11451.370174640475, 11498.712532186595, 11518.88481115195, 11561.190716649922, 487915.0, 558845.0, 567866.0, 568762.0, 569197.0, 111593.0, 146362.0, 149254.0, 151720.0, 152191.0, 996.7607774134156, 1001.5643195210107, 1025.5231317437429, 1051.8369652703843, 1052.1740433759462, 13610.606755920846, 17093.829061709224, 18961.0, 19708.60582788365, 19848.80151198527, 39791.80104099461, 51469.742651286506, 52846.471535285695, 52956.47043529515, 54479.45520544744, 73475.63262183654, 75666.864997024, 76146.0, 76218.6189069051, 77437.0, 7173.5337203081635, 7286.4170866329505, 7430.96284518574, 7444.461520918931, 7749.496282741604, 12569.49722011146, 12980.15628984113, 13094.214347139203, 13112.737745245233, 13599.388027538587, 11342.476376054547, 11387.316760994367, 11563.479643415898, 11661.883381166079, 11662.0, 11123.888761112285, 11218.943905280421, 11261.605843795427, 11371.374574398487, 11401.20191586581, 10211.7447063824, 11091.0, 11304.660860174208, 11566.826497602711, 11681.415929203336, 7477.327040566375, 7520.8871866920945, 7601.581912994839, 7625.3137217648455, 7708.03649543807, 8992.46045237288, 9178.908210918073, 10851.131909447384, 11100.555977761122, 11419.143564232882], "value": 9615.303994013784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.7807328900662, 1491.8284397294312, 1621.7810595569601, 1649.8432648898358, 1826.3151318255655, 7042.894356584656, 7980.521168729881, 8412.36907231957, 8421.705240316582, 8428.03077646071, 7512.211217822119, 7732.9226707732905, 8021.959890200541, 8218.30144437722, 8232.341412686985, 1990.5720270141917, 2332.265336419027, 2366.325597204797, 2368.4315764216635, 2371.3715865295712, 2372.1578839511985, 2384.523095380931, 2408.7229968553665, 2411.602085655865, 2416.758324167578, 2345.7654234576576, 2346.3430239532872, 2370.525894821034, 2372.063035101134, 2377.453185767266, 2335.019291897407, 2338.088145623208, 2363.7399886012527, 2363.917262895799, 2367.6093444581625, 2361.374235827507, 2367.1596583212886, 2388.0925248405497, 2388.581998150317, 2395.652630368604, 8335.416520843544, 8397.958010209972, 8444.071152173317, 8451.619677114544, 8458.323334133316, 5074.797008119671, 5230.189320655304, 5236.083685355047, 5244.8688782780355, 5245.4754524547625, 3518.489818976234, 3535.1515636247113, 3537.451694987281, 3603.0, 3611.151379425859, 1068.2415485005656, 1075.714935542082, 1089.0742868561738, 1110.6445937300068, 1123.820188769801, 10780.975807298373, 10884.292520986111, 10908.290961087583, 10922.781544369147, 10946.124310055176, 3835.424686297022, 4372.562743725665, 4575.5424457554645, 4661.930071048937, 4696.154692155376, 9320.72037838866, 9328.580213890391, 9328.906710932939, 9330.720078397659, 9333.486658233862, 5191.8182863599595, 5206.0, 5208.192730126836, 5210.452902445264, 5217.739113044408, 4339.7613131278085, 4388.253996820548, 4658.091672123971, 4767.356406885026, 4794.2808578713475, 3734.3651579231596, 3784.299904517673, 3887.2225554889137, 3888.183481468867, 3892.377219644843, 1257.6478585995935, 1272.573687814574, 1276.3618190904547, 1287.7102651903247, 1288.2850018239778, 787.4448513797759, 866.4021824940771, 901.8602116671926, 919.3426699909596, 931.1759093202564, 5169.81905633301, 5692.516136128475, 5724.599278050497, 5849.210356601804, 6002.369751176151, 860.3762272352494, 887.6227603268715, 912.1790388650268, 921.8755468011733, 922.0042354257386, 3453.4129198036394, 3680.245549662313, 3685.3734865073, 3783.905402364908, 3889.4749208857006, 9775.217982561378, 9998.450085245237, 10110.0, 10110.090091891765, 10129.240306977006, 8356.958215208884, 10062.094411502854, 10065.69802905914, 10066.69799906004, 10078.244131690153, 7140.9642951785945, 7629.618519074024, 7714.228577142241, 7867.370610351159, 7875.291223789772, 5038.01758657073, 5481.369642491165, 5507.5593952484505, 5561.110222364402, 5743.770249190153, 7856.292933636, 8401.453905496122, 9269.768255793659, 9352.859707104262, 9361.531923403667, 9275.489848058422, 9437.056294370508, 9477.099675530813, 9577.616895324109, 9591.712248632552, 6651.235107962646, 6833.897491537531, 7006.299370063157, 7239.312265334785, 7243.20324764286, 7497.512661676974, 7513.624318784148, 7603.847923041619, 7605.429592780453, 7876.803079922818, 7052.541584796972, 7164.283571642794, 7192.784216473514, 7238.855222895408, 7325.120985481776, 7082.468814838805, 7087.68105435267, 7100.289971002859, 7106.324899134574, 7128.893066603901, 6595.604263744191, 6630.701618427086, 6702.229243636849, 6702.497312701469, 6715.127033485615, 4663.743494107721, 4677.532246775295, 4734.171519984058, 4735.763211839463, 4802.8799280018275, 3767.453719210754, 4306.20335237982, 4808.158572249912, 4906.828261010847, 4931.926021109614], "value": 4403.129787148729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.78909130882306, 317.89350567559865, 321.89377505423204, 326.4808953763517, 329.58472324870655, 5354.420445968439, 5356.303680521536, 5357.598180136491, 5373.408925018254, 5373.435789242127, 4091.8747344480284, 4106.876793696187, 5166.5866730661555, 5281.366236051669, 5293.8941221175555, 2750.6659270253913, 3779.603141670126, 3815.67566756826, 3842.1163132479546, 3960.3663413853787, 3421.6407277235903, 3619.855205791765, 3859.8070096495203, 3977.681785457171, 3993.0616305168264, 3250.6099268087864, 3942.0, 3948.9930067832806, 3982.112968098135, 3996.5603783583783, 3768.8869333920024, 3912.0, 3932.0, 3933.8819835404697, 4002.3396139636925, 2882.4523340565224, 3150.503510832359, 3482.0, 3493.6681015303507, 3510.8946731598094, 3979.5224573051128, 4176.394422808706, 5054.0686401886815, 5057.949420505822, 5060.254212296789, 4298.656107511391, 4489.653104068799, 4603.539646035403, 4616.0, 4630.7453090080035, 4315.51114865371, 5466.890662186774, 5493.972530137364, 5503.046418521447, 5510.641808282448, 3362.865485380582, 3800.9619903800885, 3802.315583195024, 3817.5609804872515, 3820.5797362290127, 4644.397682799428, 4697.553732395417, 5678.939558215896, 5826.329972053226, 5857.105025158265, 3213.887513937001, 3656.835442405098, 3839.3856982882603, 3858.803770831051, 3861.45939568455, 3905.804709764557, 3928.5285765707727, 3932.210844065943, 3935.704822138351, 3940.566537680853, 3800.5439347278502, 4432.556744325541, 4518.367428560005, 4567.38340324052, 4568.1548913451115, 5270.841874743764, 5506.669599823943, 5508.182299841043, 5560.833175004756, 5585.69278689676, 1093.371311495893, 1104.2049724198564, 1258.6349958511928, 1278.2649976263685, 1279.33474593211, 737.8266107464741, 827.9815826533397, 853.9786505337416, 854.0818619983543, 861.6897916749965, 4353.521112677603, 4557.541586692227, 4958.057968985881, 5033.219850923113, 5293.3647962244, 4799.760011999456, 5785.595008349375, 5794.565407594448, 5813.680247586339, 5821.330546987066, 4455.215490318551, 4485.820567177341, 5183.585313174937, 5210.853612205385, 5339.0, 2424.666433461589, 2556.0, 2689.67343248089, 2809.7611703005064, 2839.872205750746, 5031.867829738279, 5646.781334639216, 5657.2928383952, 5657.8019769307875, 5786.218860453785, 4853.514648535118, 5406.594505412031, 5436.864078398072, 5534.944650553443, 5562.4425160955, 5907.1434641976675, 5942.7920022799, 5990.670513121733, 6005.219321488178, 6008.939910600838, 4748.884012257047, 5769.9711501442225, 5787.768489260382, 5790.855228619318, 5853.619514731528, 4724.338592597108, 5400.865818178069, 5616.943830561642, 5688.3742788294085, 5714.314282285986, 5949.007082627195, 5959.553033522417, 5962.493188079062, 5969.970150149222, 5997.610155339889, 3945.1320709443876, 3985.621365970228, 3995.760254384746, 4016.758994460342, 4029.6373326400767, 5528.668279903219, 5592.3009623797025, 5647.830565083054, 5683.914741278967, 5755.963926493271, 4593.425821772278, 5428.321459817523, 5468.535174510212, 5500.972495137498, 5539.418361072029, 5329.840104796862, 5479.904019196257, 5528.474794894479, 5557.666540007613, 5566.471185237396, 4835.903281934271, 5423.240746295601, 5429.728513574227, 5438.211459338453, 5443.59173062014, 5261.079311120462, 5472.358292512151, 5479.589030822784, 5517.0, 5547.472990065938, 4884.9741554274, 4933.802647894044, 5375.489328513785, 5392.352917649907, 5552.888942221214], "value": 4004.1166945513537, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.9811305660829, 703.8768215562276, 724.967376468059, 780.7891869195321, 839.5160085644578, 14518.927405362972, 15016.324265408055, 15234.619134521643, 15252.542423727306, 15280.312385942618, 12628.494860205603, 13706.58880233592, 13757.105788123765, 13961.650958726037, 14026.438942442315, 842.2125312832521, 861.0399404663787, 861.6682577207757, 861.8233262181237, 868.522312727997, 858.8754630578594, 865.0786911938796, 865.5455885660048, 865.6104752861206, 867.1848462445313, 902.1700035966926, 902.440486898124, 903.2909166304453, 903.6566104880169, 904.4528060523387, 897.9371443998923, 898.2185498616213, 899.1952202778542, 899.5906862377602, 900.6982660808637, 660.0627109504467, 674.1303718203511, 674.4031532094083, 679.8776220280348, 680.9863802723968, 13769.931150344284, 14536.200508972002, 14541.272936353245, 14573.927130364385, 14623.19572423527, 13037.087403881733, 13059.477620895153, 13141.934290328583, 13345.39945702436, 13405.128666636638, 12340.13619046667, 12389.0, 12390.504379824797, 12481.643183171229, 12519.874801251963, 4357.433533640607, 4366.104948485553, 4384.123175364908, 4451.710638808467, 4602.470715867685, 95500.0, 96341.51829240879, 96364.0, 98241.0, 98570.0142998568, 10092.899071009342, 10311.690649280534, 10363.844542331872, 10379.584816607252, 10584.788304233873, 19445.930473824075, 19596.020198989994, 19626.01869906499, 19931.501712457306, 19976.200951962048, 7398.482106252511, 7547.207543207884, 7574.3183113520045, 7600.885986710204, 7706.460547761603, 4235.597618226264, 4319.373690814877, 4406.779661016936, 4412.84555040572, 4488.528704486047, 3207.0859804955476, 3278.639349671534, 3312.006398080566, 3316.651751566099, 3317.0214786638, 613.9355367686329, 622.0513716582249, 624.5877720704314, 632.9620222786648, 637.9919726831595, 601.3835818286292, 616.7440512187482, 619.4146531527753, 620.3734228429319, 623.5292354272495, 8257.256846883809, 8714.782130446663, 8798.912010879809, 8907.688230911886, 8962.68630597926, 606.1907353682883, 629.4649547884353, 638.3297537585516, 644.452215616722, 655.5214693273937, 4094.6724262058965, 4327.76197309151, 4330.935035974463, 4351.73889566627, 4479.977600112044, 99555.50222248843, 122357.0, 129322.70677293107, 130585.34707326592, 132440.67559324476, 63707.681461592394, 80891.0, 86546.56726716452, 88896.0, 102705.0, 68477.31522684809, 69754.65122674455, 87018.0, 91557.5422122885, 93848.0, 9535.33252672334, 9711.805763884542, 9897.35667181631, 9900.603975840886, 9943.502824858584, 54567.520517284254, 55464.0, 55610.0, 57162.428375717376, 57172.14241786293, 66526.33473665202, 79623.0, 82046.76929845937, 82138.0, 86044.70932935886, 11855.051595872483, 12049.096317776026, 12309.907315756163, 12311.56909508163, 12627.242365458102, 12465.878070973657, 13449.193048416735, 13975.720485590027, 14937.850621493646, 14991.475298364505, 11451.312921224753, 12031.45858436355, 12657.240565566095, 12947.287899165636, 13239.3380330985, 12823.230606163661, 13060.0, 13300.017883044779, 13375.464981400635, 13467.461301548221, 12291.139620226855, 13084.345782710636, 13105.623909489366, 13199.20804751718, 13368.799468008183, 10746.301490403099, 10956.28784129029, 11074.833877491683, 11084.002439780135, 11177.0, 8844.98282697498, 8930.732078037669, 9872.506374681094, 10079.748006299902, 11401.885981140082], "value": 7392.483144300669, "unit": "score"}], "name": "dromaeo_css", "value": 7258.906557734061, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 116.0, 113.0, 113.0, 116.0, 114.0, 112.0, 113.0, 112.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 107.0, 143.0, 106.0, 106.0, 107.0, 107.0, 136.0, 108.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 264.0, 203.0, 181.0, 179.0, 181.0, 178.0, 182.0, 182.0, 181.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 72.0, 113.0, 85.0, 60.0, 61.0, 47.0, 84.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 94.0, 68.0, 68.0, 68.0, 89.0, 67.0, 70.0, 91.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 84.0, 87.0, 84.0, 87.0, 87.0, 89.0, 83.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 76.0, 79.0, 82.0, 81.0, 83.0, 84.0, 83.0, 82.0], "value": 81.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 66.0, 74.0, 73.0, 68.0, 100.0, 101.0, 100.0, 95.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 82.0, 82.0, 81.0, 83.0, 83.0, 80.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 146.0, 138.0, 136.0, 138.0, 139.0, 136.0, 139.0, 172.0, 147.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 165.0, 165.0, 163.0, 163.0, 155.0, 158.0, 164.0, 158.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 88.0, 83.0, 85.0, 77.0, 65.0, 64.0, 65.0, 65.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1434.1000000000001, "alertThreshold": 2.0}]} 07:07:41 INFO - Return code: 0 07:07:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:07:41 INFO - # TBPL SUCCESS # 07:07:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:07:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:07:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:07:41 INFO - 2017-02-16 07:07:41.642 screenresolution[1654:10117] starting screenresolution argv=screenresolution get 07:07:41 INFO - 2017-02-16 07:07:41.645 screenresolution[1654:10117] Display 0: 1600x1200x32@60 07:07:41 INFO - 2017-02-16 07:07:41.651 screenresolution[1655:10120] starting screenresolution argv=screenresolution list 07:07:41 INFO - Available Modes on Display 0 07:07:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:07:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:07:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:07:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:07:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:07:41 INFO - Intel Iris: 07:07:41 INFO - Chipset Model: Intel Iris 07:07:41 INFO - Type: GPU 07:07:41 INFO - Bus: Built-In 07:07:41 INFO - VRAM (Dynamic, Max): 1536 MB 07:07:41 INFO - Vendor: Intel (0x8086) 07:07:41 INFO - Device ID: 0x0a2e 07:07:41 INFO - Revision ID: 0x0009 07:07:41 INFO - Displays: 07:07:41 INFO - Display: 07:07:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:07:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:07:41 INFO - Display Serial Number: 1600x1200 60 07:07:41 INFO - Main Display: Yes 07:07:41 INFO - Mirror: Off 07:07:41 INFO - Online: Yes 07:07:41 INFO - Rotation: Supported 07:07:41 INFO - Return code: 0 07:07:41 INFO - Running post-action listener: _resource_record_post_action 07:07:41 INFO - [mozharness: 2017-02-16 15:07:41.892909Z] Finished run-tests step (success) 07:07:41 INFO - Running post-run listener: _resource_record_post_run 07:07:41 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 38011904; Write bytes: 501466624; Read time: 244; Write time: 1595 07:07:41 INFO - TinderboxPrint: CPU usage
53.4% 07:07:41 INFO - TinderboxPrint: I/O read bytes / time
38,011,904 / 244 07:07:41 INFO - TinderboxPrint: I/O write bytes / time
501,466,624 / 1,595 07:07:41 INFO - TinderboxPrint: CPU idle
2,235.8 (46.6%) 07:07:41 INFO - TinderboxPrint: CPU system
958.6 (20.0%) 07:07:41 INFO - TinderboxPrint: CPU user
1,603.3 (33.4%) 07:07:41 INFO - TinderboxPrint: Swap in / out
229,797,888 / 0 07:07:41 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183536128; Write bytes: 176997888; Read time: 16930; Write time: 398 07:07:41 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37090304; Write bytes: 307781632; Read time: 231; Write time: 1150 07:07:42 INFO - Running post-run listener: _upload_blobber_files 07:07:42 INFO - Blob upload gear active. 07:07:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:07:42 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 07:07:42 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'] 07:07:42 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 07:07:42 INFO - (blobuploader) - INFO - Open directory for files ... 07:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:44 INFO - (blobuploader) - INFO - Done attempting. 07:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:44 INFO - (blobuploader) - INFO - Done attempting. 07:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:07:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:47 INFO - (blobuploader) - INFO - Done attempting. 07:07:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:07:47 INFO - Return code: 0 07:07:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:07:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:07:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a797e9f8c62b56c0da777fd8bde5abfc75d7eb2310f81522d48b82e93997e8d92743c30f48a13182a587d6e17fefcfec2fa234f05204a449884b23de613dda92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/849cfabe290d025709938b94af741cd32379c857abedbce631c0b6e6556e4bd297081644356e40d357f51d3e457fc865c6fd76c5fe13833b14cefc218dc609cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dc89c79f3e596bf31358aeda728cc0274917b87bc65c71026b452ed4aaae80a04908ef9418d01a2c9a755cabfa598ca365b79d42dacb1ed805a6baea0518314"} 07:07:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:07:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:07:47 INFO - Contents: 07:07:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a797e9f8c62b56c0da777fd8bde5abfc75d7eb2310f81522d48b82e93997e8d92743c30f48a13182a587d6e17fefcfec2fa234f05204a449884b23de613dda92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/849cfabe290d025709938b94af741cd32379c857abedbce631c0b6e6556e4bd297081644356e40d357f51d3e457fc865c6fd76c5fe13833b14cefc218dc609cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dc89c79f3e596bf31358aeda728cc0274917b87bc65c71026b452ed4aaae80a04908ef9418d01a2c9a755cabfa598ca365b79d42dacb1ed805a6baea0518314"} 07:07:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:07:47 INFO - Copying logs to upload dir... 07:07:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:07:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.375121 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-16 07:07:47.285264) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 07:07:47.288917) ========= 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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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/a797e9f8c62b56c0da777fd8bde5abfc75d7eb2310f81522d48b82e93997e8d92743c30f48a13182a587d6e17fefcfec2fa234f05204a449884b23de613dda92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/849cfabe290d025709938b94af741cd32379c857abedbce631c0b6e6556e4bd297081644356e40d357f51d3e457fc865c6fd76c5fe13833b14cefc218dc609cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dc89c79f3e596bf31358aeda728cc0274917b87bc65c71026b452ed4aaae80a04908ef9418d01a2c9a755cabfa598ca365b79d42dacb1ed805a6baea0518314"} build_url:https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/St2ivYWiTOGwPQmiKX0uog/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/a797e9f8c62b56c0da777fd8bde5abfc75d7eb2310f81522d48b82e93997e8d92743c30f48a13182a587d6e17fefcfec2fa234f05204a449884b23de613dda92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/849cfabe290d025709938b94af741cd32379c857abedbce631c0b6e6556e4bd297081644356e40d357f51d3e457fc865c6fd76c5fe13833b14cefc218dc609cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dc89c79f3e596bf31358aeda728cc0274917b87bc65c71026b452ed4aaae80a04908ef9418d01a2c9a755cabfa598ca365b79d42dacb1ed805a6baea0518314"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 07:07:47.323156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:07:47.323564) ========= 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.6fSL5JVSbD/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.MI7KGWOoYa/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 07:07:47.372296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 07:07:47.372660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 07:07:47.373008) ========= ========= Total master_lag: 0.18 =========