builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0259 starttime: 1486091182.88 results: success (0) buildid: 20170202163809 builduid: 9ce2b59662434c1c8211010d2f57c36f revision: 9759594e223f25075dde334fe96af323bf33d144 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:22.879570) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:22.880016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:22.880322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:22.908329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:22.908665) ========= 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.1xHgPrkgJC/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.sW75qCNwPU/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-02 19:06:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.1M=0.001s 2017-02-02 19:06:23 (22.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104512 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:23.040234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:23.040550) ========= 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.1xHgPrkgJC/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.sW75qCNwPU/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.024830 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:23.089020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 19:06:23.089375) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9759594e223f25075dde334fe96af323bf33d144 --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 9759594e223f25075dde334fe96af323bf33d144 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1xHgPrkgJC/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.sW75qCNwPU/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-02 19:06:23,197 truncating revision to first 12 chars 2017-02-02 19:06:23,197 Setting DEBUG logging. 2017-02-02 19:06:23,197 attempt 1/10 2017-02-02 19:06:23,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9759594e223f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 19:06:24,744 unpacking tar archive at: mozilla-beta-9759594e223f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.830950 ========= master_lag: 0.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 19:06:25.445940) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:25.449285) ========= script_repo_revision: 9759594e223f25075dde334fe96af323bf33d144 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:25.449709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:25.449976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 19:06:25.472762) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-02 19:06:25.473047) ========= /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.1xHgPrkgJC/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.sW75qCNwPU/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:06:25 INFO - MultiFileLogger online at 20170202 19:06:25 in /builds/slave/test 19:06:25 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 19:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:06:25 INFO - {'append_to_log': False, 19:06:25 INFO - 'base_work_dir': '/builds/slave/test', 19:06:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:06:25 INFO - 'branch': 'Mozilla-Beta', 19:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:06:25 INFO - 'config_files': ('talos/mac_config.py',), 19:06:25 INFO - 'default_actions': ('clobber', 19:06:25 INFO - 'read-buildbot-config', 19:06:25 INFO - 'download-and-extract', 19:06:25 INFO - 'populate-webroot', 19:06:25 INFO - 'create-virtualenv', 19:06:25 INFO - 'install', 19:06:25 INFO - 'run-tests'), 19:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:06:25 INFO - 'download_minidump_stackwalk': True, 19:06:25 INFO - 'download_symbols': 'ondemand', 19:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:06:25 INFO - 'installer_path': 'installer.exe', 19:06:25 INFO - 'log_level': 'info', 19:06:25 INFO - 'log_name': 'talos', 19:06:25 INFO - 'log_to_console': True, 19:06:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:06:25 INFO - 'opt_config_files': (), 19:06:25 INFO - 'pip_index': False, 19:06:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:06:25 INFO - 'cmd': ('bash', 19:06:25 INFO - '-c', 19:06:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:06:25 INFO - 'enabled': True, 19:06:25 INFO - 'halt_on_failure': False, 19:06:25 INFO - 'name': 'check_screen_resolution'},), 19:06:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:06:25 INFO - 'cmd': ('bash', 19:06:25 INFO - '-c', 19:06:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:06:25 INFO - 'enabled': True, 19:06:25 INFO - 'halt_on_failure': False, 19:06:25 INFO - 'name': 'check_screen_resolution'},), 19:06:25 INFO - 'run_cmd_checks_enabled': True, 19:06:25 INFO - 'sps_profile': False, 19:06:25 INFO - 'sps_profile_interval': 0, 19:06:25 INFO - 'suite': 'dromaeojs', 19:06:25 INFO - 'system_bits': '32', 19:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:06:25 INFO - 'title': 't-yosemite-r7-0259', 19:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:06:25 INFO - 'use_talos_json': True, 19:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:06:25 INFO - 'work_dir': 'build'} 19:06:25 INFO - [mozharness: 2017-02-03 03:06:25.689387Z] Running clobber step. 19:06:25 INFO - Running pre-action listener: _resource_record_pre_action 19:06:25 INFO - Running main action method: clobber 19:06:25 INFO - rmtree: /builds/slave/test/build 19:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:06:28 INFO - Running post-action listener: _resource_record_post_action 19:06:28 INFO - [mozharness: 2017-02-03 03:06:28.159071Z] Finished clobber step (success) 19:06:28 INFO - [mozharness: 2017-02-03 03:06:28.159145Z] Running read-buildbot-config step. 19:06:28 INFO - Running pre-action listener: _resource_record_pre_action 19:06:28 INFO - Running main action method: read_buildbot_config 19:06:28 INFO - Using buildbot properties: 19:06:28 INFO - { 19:06:28 INFO - "project": "", 19:06:28 INFO - "product": "firefox", 19:06:28 INFO - "script_repo_revision": "production", 19:06:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 19:06:28 INFO - "repository": "", 19:06:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 19:06:28 INFO - "buildid": "20170202163809", 19:06:28 INFO - "pgo_build": "False", 19:06:28 INFO - "basedir": "/builds/slave/test", 19:06:28 INFO - "buildnumber": 35, 19:06:28 INFO - "slavename": "t-yosemite-r7-0259", 19:06:28 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:06:28 INFO - "platform": "yosemite_r7", 19:06:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:06:28 INFO - "branch": "mozilla-beta", 19:06:28 INFO - "repo_path": "releases/mozilla-beta", 19:06:28 INFO - "revision": "9759594e223f25075dde334fe96af323bf33d144", 19:06:28 INFO - "stage_platform": "macosx64", 19:06:28 INFO - "builduid": "9ce2b59662434c1c8211010d2f57c36f", 19:06:28 INFO - "slavebuilddir": "test" 19:06:28 INFO - } 19:06:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 19:06:28 INFO - Running post-action listener: _resource_record_post_action 19:06:28 INFO - [mozharness: 2017-02-03 03:06:28.162363Z] Finished read-buildbot-config step (success) 19:06:28 INFO - [mozharness: 2017-02-03 03:06:28.162494Z] Running download-and-extract step. 19:06:28 INFO - Running pre-action listener: _resource_record_pre_action 19:06:28 INFO - Running main action method: download_and_extract 19:06:28 INFO - mkdir: /builds/slave/test/build/tests 19:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:28 INFO - trying https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 19:06:28 INFO - Downloading https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/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 19:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/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 19:06:29 INFO - Downloaded 1165 bytes. 19:06:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 19:06:29 INFO - Using the following test package requirements: 19:06:29 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 19:06:29 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 19:06:29 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 19:06:29 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 19:06:29 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 19:06:29 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:06:29 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 19:06:29 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 19:06:29 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 19:06:29 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 19:06:29 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 19:06:29 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 19:06:29 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 19:06:29 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 19:06:29 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 19:06:29 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 19:06:29 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 19:06:29 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 19:06:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 19:06:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 19:06:29 INFO - Fetch https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 19:06:30 INFO - Http code: 200 19:06:30 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 19:06:30 INFO - x-amz-cf-id: 9Ba8uYbVlw-sIuHID75zeNtX9u_TUN4h8Zy7dDuvTIbvf0EJ1v6xyw== 19:06:30 INFO - x-amz-version-id: FpApMTnd_OhGn5OzUhRSRnxmx6orBm2E 19:06:32 INFO - Expected file size: 16092095 19:06:32 INFO - Obtained file size: 16092095 19:06:39 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 19:06:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 19:06:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 19:06:39 INFO - Fetch https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 19:06:39 INFO - Http code: 200 19:06:39 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 19:06:39 INFO - x-amz-cf-id: MdnMl4vQU54V1szoVtuZq0XbpGCwC41s9IePkpe4Jh-3vJePwasgug== 19:06:39 INFO - x-amz-version-id: FpApMTnd_OhGn5OzUhRSRnxmx6orBm2E 19:06:40 INFO - Expected file size: 16092095 19:06:40 INFO - Obtained file size: 16092095 19:06:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 19:06:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 19:06:47 INFO - Fetch https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 19:06:48 INFO - Http code: 200 19:06:48 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 19:06:48 INFO - x-amz-cf-id: iuZR0LDff4OH0m00dPPoID_V-4debKq310B_MvCO1TciVrPq4WW1Ww== 19:06:48 INFO - x-amz-version-id: gA6A93QeoRiHvGgI563xQ64AjgE3mtpE 19:06:49 INFO - Expected file size: 14403005 19:06:49 INFO - Obtained file size: 14403005 19:06: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')]} 19:06:49 INFO - trying https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 19:06:49 INFO - Downloading https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 19:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/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 19:06:54 INFO - Downloaded 82133559 bytes. 19:06:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 19:06:54 INFO - mkdir: /builds/slave/test/properties 19:06:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:06:54 INFO - Writing to file /builds/slave/test/properties/build_url 19:06:54 INFO - Contents: 19:06:54 INFO - build_url:https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 19:06:56 INFO - Running post-action listener: _resource_record_post_action 19:06:56 INFO - Running post-action listener: set_extra_try_arguments 19:06:56 INFO - [mozharness: 2017-02-03 03:06:56.214172Z] Finished download-and-extract step (success) 19:06:56 INFO - [mozharness: 2017-02-03 03:06:56.214316Z] Running populate-webroot step. 19:06:56 INFO - Running pre-action listener: _resource_record_pre_action 19:06:56 INFO - Running main action method: populate_webroot 19:06:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:06:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:06:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:06:56 INFO - '--tppagecycles', 19:06:56 INFO - '7'], 19:06:56 INFO - 'tests': ['tsvgm']}}, 19:06:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:06:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:06:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:06:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:06:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['damp', 'tps']}, 19:06:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'tests': ['damp', 'tps']}, 19:06:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['dromaeo_dom']}, 19:06:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:06:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['basic_compositor_video']}, 19:06:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:06:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['a11yr', 19:06:56 INFO - 'ts_paint', 19:06:56 INFO - 'tpaint', 19:06:56 INFO - 'sessionrestore', 19:06:56 INFO - 'sessionrestore_no_auto_restore', 19:06:56 INFO - 'tabpaint']}, 19:06:56 INFO - 'other-e10s': {'tests': ['a11yr', 19:06:56 INFO - 'ts_paint', 19:06:56 INFO - 'tpaint', 19:06:56 INFO - 'sessionrestore', 19:06:56 INFO - 'sessionrestore_no_auto_restore', 19:06:56 INFO - 'tabpaint']}, 19:06:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:06:56 INFO - 'ts_paint', 19:06:56 INFO - 'tpaint', 19:06:56 INFO - 'sessionrestore', 19:06:56 INFO - 'sessionrestore_no_auto_restore', 19:06:56 INFO - 'tabpaint']}, 19:06:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:06:56 INFO - 'ts_paint', 19:06:56 INFO - 'tpaint', 19:06:56 INFO - 'sessionrestore', 19:06:56 INFO - 'sessionrestore_no_auto_restore', 19:06:56 INFO - 'tabpaint']}, 19:06:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['a11yr', 19:06:56 INFO - 'ts_paint', 19:06:56 INFO - 'tpaint', 19:06:56 INFO - 'sessionrestore', 19:06:56 INFO - 'sessionrestore_no_auto_restore', 19:06:56 INFO - 'tabpaint']}, 19:06:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['a11yr', 19:06:56 INFO - 'ts_paint', 19:06:56 INFO - 'tpaint', 19:06:56 INFO - 'sessionrestore', 19:06:56 INFO - 'sessionrestore_no_auto_restore', 19:06:56 INFO - 'tabpaint']}, 19:06:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['tsvgx', 19:06:56 INFO - 'tsvgr_opacity', 19:06:56 INFO - 'tart', 19:06:56 INFO - 'tscrollx', 19:06:56 INFO - 'cart']}, 19:06:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:06:56 INFO - 'tsvgr_opacity', 19:06:56 INFO - 'tart', 19:06:56 INFO - 'tscrollx', 19:06:56 INFO - 'cart']}, 19:06:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'talos_options': ['--disable-e10s'], 19:06:56 INFO - 'tests': ['tp5o']}, 19:06:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'tests': ['tp5o']}, 19:06:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'talos_options': ['--disable-e10s', 19:06:56 INFO - '--xperf_path', 19:06:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:56 INFO - 'tests': ['tp5n']}, 19:06:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:06:56 INFO - 'talos_options': ['--xperf_path', 19:06:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:56 INFO - 'tests': ['tp5n']}}, 19:06:56 INFO - 'talos.zip': {'path': '', 19:06:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:06:56 INFO - Running post-action listener: _resource_record_post_action 19:06:56 INFO - [mozharness: 2017-02-03 03:06:56.233344Z] Finished populate-webroot step (success) 19:06:56 INFO - [mozharness: 2017-02-03 03:06:56.233477Z] Running create-virtualenv step. 19:06:56 INFO - Running pre-action listener: _resource_record_pre_action 19:06:56 INFO - Running main action method: create_virtualenv 19:06:56 INFO - Creating virtualenv /builds/slave/test/build/venv 19:06:56 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 19:06:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:06:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:06:56 INFO - Using real prefix '/tools/python27' 19:06:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:06:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:06:59 INFO - Installing pip.................done. 19:06:59 INFO - Return code: 0 19:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:07:00 INFO - Reading from file tmpfile_stdout 19:07:00 INFO - Output received: 19:07:00 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) 19:07:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:07:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:00 INFO - 'HOME': '/Users/cltbld', 19:07:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:00 INFO - 'LOGNAME': 'cltbld', 19:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:00 INFO - 'MOZ_NO_REMOTE': '1', 19:07:00 INFO - 'NO_EM_RESTART': '1', 19:07:00 INFO - 'PAGER': '/bin/cat', 19:07:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:00 INFO - 'PWD': '/builds/slave/test', 19:07:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:00 INFO - 'SHELL': '/bin/bash', 19:07:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:00 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:00 INFO - 'USER': 'cltbld', 19:07:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:00 INFO - 'XPC_FLAGS': '0x0', 19:07:00 INFO - 'XPC_SERVICE_NAME': '0', 19:07:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:00 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 19:07:00 INFO - Cleaning up... 19:07:00 INFO - Return code: 0 19:07:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:07:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:00 INFO - 'HOME': '/Users/cltbld', 19:07:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:00 INFO - 'LOGNAME': 'cltbld', 19:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:00 INFO - 'MOZ_NO_REMOTE': '1', 19:07:00 INFO - 'NO_EM_RESTART': '1', 19:07:00 INFO - 'PAGER': '/bin/cat', 19:07:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:00 INFO - 'PWD': '/builds/slave/test', 19:07:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:00 INFO - 'SHELL': '/bin/bash', 19:07:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:00 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:00 INFO - 'USER': 'cltbld', 19:07:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:00 INFO - 'XPC_FLAGS': '0x0', 19:07:00 INFO - 'XPC_SERVICE_NAME': '0', 19:07:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:00 INFO - Downloading/unpacking psutil>=3.1.1 19:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:04 INFO - Installing collected packages: psutil 19:07:04 INFO - Running setup.py install for psutil 19:07:04 INFO - building 'psutil._psutil_osx' extension 19:07:04 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 19:07:04 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 19:07:04 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 19:07:05 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 19:07:05 INFO - building 'psutil._psutil_posix' extension 19:07:05 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 19:07:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:07:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:07:05 INFO - ^ 19:07:05 INFO - 1 warning generated. 19:07:05 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 19:07:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:05 INFO - Successfully installed psutil 19:07:05 INFO - Cleaning up... 19:07:05 INFO - Return code: 0 19:07:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:07:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:05 INFO - 'HOME': '/Users/cltbld', 19:07:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:05 INFO - 'LOGNAME': 'cltbld', 19:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:05 INFO - 'MOZ_NO_REMOTE': '1', 19:07:05 INFO - 'NO_EM_RESTART': '1', 19:07:05 INFO - 'PAGER': '/bin/cat', 19:07:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:05 INFO - 'PWD': '/builds/slave/test', 19:07:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:05 INFO - 'SHELL': '/bin/bash', 19:07:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:05 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:05 INFO - 'USER': 'cltbld', 19:07:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:05 INFO - 'XPC_FLAGS': '0x0', 19:07:05 INFO - 'XPC_SERVICE_NAME': '0', 19:07:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:07:08 INFO - Installing collected packages: mozsystemmonitor 19:07:08 INFO - Running setup.py install for mozsystemmonitor 19:07:08 INFO - Successfully installed mozsystemmonitor 19:07:08 INFO - Cleaning up... 19:07:08 INFO - Return code: 0 19:07:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:08 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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:08 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 19:07:08 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 19:07:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:08 INFO - 'HOME': '/Users/cltbld', 19:07:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:08 INFO - 'LOGNAME': 'cltbld', 19:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:08 INFO - 'MOZ_NO_REMOTE': '1', 19:07:08 INFO - 'NO_EM_RESTART': '1', 19:07:08 INFO - 'PAGER': '/bin/cat', 19:07:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:08 INFO - 'PWD': '/builds/slave/test', 19:07:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:08 INFO - 'SHELL': '/bin/bash', 19:07:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:08 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:08 INFO - 'USER': 'cltbld', 19:07:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:08 INFO - 'XPC_FLAGS': '0x0', 19:07:08 INFO - 'XPC_SERVICE_NAME': '0', 19:07:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:09 INFO - Downloading/unpacking jsonschema==2.5.1 19:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:11 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 19:07:12 INFO - Downloading functools32-3.2.3-2.tar.gz 19:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:07:12 INFO - warning: no files found matching '*.txt' 19:07:12 INFO - no previously-included directories found matching 'build' 19:07:12 INFO - no previously-included directories found matching 'dist' 19:07:12 INFO - no previously-included directories found matching '.git*' 19:07:12 INFO - Installing collected packages: jsonschema, functools32 19:07:12 INFO - Running setup.py install for functools32 19:07:12 INFO - warning: no files found matching '*.txt' 19:07:12 INFO - no previously-included directories found matching 'build' 19:07:12 INFO - no previously-included directories found matching 'dist' 19:07:12 INFO - no previously-included directories found matching '.git*' 19:07:12 INFO - Successfully installed jsonschema functools32 19:07:12 INFO - Cleaning up... 19:07:12 INFO - Return code: 0 19:07:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:07:12 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')]} 19:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:12 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')]} 19:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:12 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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:12 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 19:07:12 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 19:07:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:12 INFO - 'HOME': '/Users/cltbld', 19:07:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:12 INFO - 'LOGNAME': 'cltbld', 19:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:12 INFO - 'MOZ_NO_REMOTE': '1', 19:07:12 INFO - 'NO_EM_RESTART': '1', 19:07:12 INFO - 'PAGER': '/bin/cat', 19:07:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:12 INFO - 'PWD': '/builds/slave/test', 19:07:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:12 INFO - 'SHELL': '/bin/bash', 19:07:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:12 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:12 INFO - 'USER': 'cltbld', 19:07:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:12 INFO - 'XPC_FLAGS': '0x0', 19:07:12 INFO - 'XPC_SERVICE_NAME': '0', 19:07:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:07:12 INFO - Cleaning up... 19:07:12 INFO - Return code: 0 19:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:07:12 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')]} 19:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:12 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')]} 19:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:12 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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:12 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 19:07:12 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 19:07:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:12 INFO - 'HOME': '/Users/cltbld', 19:07:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:12 INFO - 'LOGNAME': 'cltbld', 19:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:12 INFO - 'MOZ_NO_REMOTE': '1', 19:07:12 INFO - 'NO_EM_RESTART': '1', 19:07:12 INFO - 'PAGER': '/bin/cat', 19:07:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:12 INFO - 'PWD': '/builds/slave/test', 19:07:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:12 INFO - 'SHELL': '/bin/bash', 19:07:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:12 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:12 INFO - 'USER': 'cltbld', 19:07:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:12 INFO - 'XPC_FLAGS': '0x0', 19:07:12 INFO - 'XPC_SERVICE_NAME': '0', 19:07:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:13 INFO - Downloading/unpacking blobuploader==1.2.4 19:07:13 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 19:07:13 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 19:07:13 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 19:07:13 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 19:07:13 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 19:07:13 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 19:07:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:15 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 19:07:15 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 19:07:15 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 19:07:15 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 19:07:15 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 19:07:15 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 19:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:07:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:16 INFO - Downloading docopt-0.6.1.tar.gz 19:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:07:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:07:16 INFO - Running setup.py install for blobuploader 19:07:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:07:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:07:17 INFO - Running setup.py install for requests 19:07:17 INFO - Running setup.py install for docopt 19:07:17 INFO - Successfully installed blobuploader requests docopt 19:07:17 INFO - Cleaning up... 19:07:17 INFO - Return code: 0 19:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:17 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')]} 19:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:18 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')]} 19:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:18 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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:18 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 19:07:18 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 19:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:18 INFO - 'HOME': '/Users/cltbld', 19:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:18 INFO - 'LOGNAME': 'cltbld', 19:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:18 INFO - 'MOZ_NO_REMOTE': '1', 19:07:18 INFO - 'NO_EM_RESTART': '1', 19:07:18 INFO - 'PAGER': '/bin/cat', 19:07:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:18 INFO - 'PWD': '/builds/slave/test', 19:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:18 INFO - 'SHELL': '/bin/bash', 19:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:18 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:18 INFO - 'USER': 'cltbld', 19:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:18 INFO - 'XPC_FLAGS': '0x0', 19:07:18 INFO - 'XPC_SERVICE_NAME': '0', 19:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-O5cELT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-HYG6v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-un2iYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-edrcqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-YNdDus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-d0jbYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-q7efNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-vttNUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Y059mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-pIOhXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Nm1OFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:20 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-fTFtd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:20 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PHka5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:20 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-tjSUNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:20 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-MP35cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:20 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-cGO12I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:20 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-B3Ue_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:07:20 INFO - Running setup.py install for manifestparser 19:07:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:07:20 INFO - Running setup.py install for mozcrash 19:07:20 INFO - Running setup.py install for mozdebug 19:07:21 INFO - Running setup.py install for mozdevice 19:07:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Running setup.py install for mozfile 19:07:21 INFO - Running setup.py install for mozhttpd 19:07:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Running setup.py install for mozinfo 19:07:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Running setup.py install for mozInstall 19:07:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:07:21 INFO - Running setup.py install for mozleak 19:07:22 INFO - Running setup.py install for mozlog 19:07:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:07:22 INFO - Running setup.py install for moznetwork 19:07:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:07:22 INFO - Running setup.py install for mozprocess 19:07:22 INFO - Running setup.py install for mozprofile 19:07:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:07:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:07:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:07:22 INFO - Running setup.py install for mozrunner 19:07:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:07:22 INFO - Running setup.py install for mozscreenshot 19:07:23 INFO - Running setup.py install for moztest 19:07:23 INFO - Running setup.py install for mozversion 19:07:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:07:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:23 INFO - Cleaning up... 19:07:23 INFO - Return code: 0 19:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:23 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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:23 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 19:07:23 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 19:07:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:23 INFO - 'HOME': '/Users/cltbld', 19:07:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:23 INFO - 'LOGNAME': 'cltbld', 19:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:23 INFO - 'MOZ_NO_REMOTE': '1', 19:07:23 INFO - 'NO_EM_RESTART': '1', 19:07:23 INFO - 'PAGER': '/bin/cat', 19:07:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:23 INFO - 'PWD': '/builds/slave/test', 19:07:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:23 INFO - 'SHELL': '/bin/bash', 19:07:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:23 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:23 INFO - 'USER': 'cltbld', 19:07:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:23 INFO - 'XPC_FLAGS': '0x0', 19:07:23 INFO - 'XPC_SERVICE_NAME': '0', 19:07:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-gOMIIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-8cOpfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-zMXJHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-sDGWwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-3eUfkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-wlXpTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-nqIF6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-SWJEA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Sr3Hag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:24 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)) 19:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-z3axgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:25 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)) 19:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-HCueR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:25 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)) 19:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-qZXcuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:25 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)) 19:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-1yKx9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:25 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)) 19:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-P0r8r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:25 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)) 19:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ZV0WFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:25 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)) 19:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-QCiuWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:25 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)) 19:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-FXWOq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:25 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)) 19:07:25 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)) 19:07:25 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)) 19:07:25 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)) 19:07:25 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)) 19:07:25 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)) 19:07:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07: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 19:07:28 INFO - Downloading blessings-1.6.tar.gz 19:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:28 INFO - Installing collected packages: blessings 19:07:28 INFO - Running setup.py install for blessings 19:07:29 INFO - Successfully installed blessings 19:07:29 INFO - Cleaning up... 19:07:29 INFO - Return code: 0 19:07:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:29 INFO - Reading from file tmpfile_stdout 19:07:29 INFO - Current package versions: 19:07:29 INFO - blessings == 1.6 19:07:29 INFO - blobuploader == 1.2.4 19:07:29 INFO - docopt == 0.6.1 19:07:29 INFO - functools32 == 3.2.3-2 19:07:29 INFO - jsonschema == 2.5.1 19:07:29 INFO - manifestparser == 1.1 19:07:29 INFO - mozInstall == 1.12 19:07:29 INFO - mozcrash == 1.0 19:07:29 INFO - mozdebug == 0.1 19:07:29 INFO - mozdevice == 0.48 19:07:29 INFO - mozfile == 1.2 19:07:29 INFO - mozhttpd == 0.7 19:07:29 INFO - mozinfo == 0.9 19:07:29 INFO - mozleak == 0.1 19:07:29 INFO - mozlog == 3.4 19:07:29 INFO - moznetwork == 0.27 19:07:29 INFO - mozprocess == 0.23 19:07:29 INFO - mozprofile == 0.28 19:07:29 INFO - mozrunner == 6.13 19:07:29 INFO - mozscreenshot == 0.1 19:07:29 INFO - mozsystemmonitor == 0.3 19:07:29 INFO - moztest == 0.8 19:07:29 INFO - mozversion == 1.4 19:07:29 INFO - psutil == 3.1.1 19:07:29 INFO - requests == 1.2.3 19:07:29 INFO - wsgiref == 0.1.2 19:07:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:29 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')]} 19:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:29 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')]} 19:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:29 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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:29 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 19:07:29 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 19:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:29 INFO - 'HOME': '/Users/cltbld', 19:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:29 INFO - 'LOGNAME': 'cltbld', 19:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:29 INFO - 'MOZ_NO_REMOTE': '1', 19:07:29 INFO - 'NO_EM_RESTART': '1', 19:07:29 INFO - 'PAGER': '/bin/cat', 19:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:29 INFO - 'PWD': '/builds/slave/test', 19:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:29 INFO - 'SHELL': '/bin/bash', 19:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:29 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:29 INFO - 'USER': 'cltbld', 19:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:29 INFO - 'XPC_FLAGS': '0x0', 19:07:29 INFO - 'XPC_SERVICE_NAME': '0', 19:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 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)) 19:07:29 INFO - Cleaning up... 19:07:29 INFO - Return code: 0 19:07:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:07:29 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')]} 19:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:29 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')]} 19:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:29 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 0x10385e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff1bc67e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, '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.1xHgPrkgJC/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.sW75qCNwPU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 19:07:29 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 19:07:29 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 19:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:29 INFO - 'HOME': '/Users/cltbld', 19:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:29 INFO - 'LOGNAME': 'cltbld', 19:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:29 INFO - 'MOZ_NO_REMOTE': '1', 19:07:29 INFO - 'NO_EM_RESTART': '1', 19:07:29 INFO - 'PAGER': '/bin/cat', 19:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:29 INFO - 'PWD': '/builds/slave/test', 19:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:29 INFO - 'SHELL': '/bin/bash', 19:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:29 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:29 INFO - 'USER': 'cltbld', 19:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:29 INFO - 'XPC_FLAGS': '0x0', 19:07:29 INFO - 'XPC_SERVICE_NAME': '0', 19:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:07:29 INFO - Cleaning up... 19:07:29 INFO - Return code: 0 19:07:29 INFO - Running post-action listener: _resource_record_post_action 19:07:29 INFO - Running post-action listener: _start_resource_monitoring 19:07:29 INFO - Starting resource monitoring. 19:07:29 INFO - [mozharness: 2017-02-03 03:07:29.995127Z] Finished create-virtualenv step (success) 19:07:29 INFO - [mozharness: 2017-02-03 03:07:29.996008Z] Running install step. 19:07:29 INFO - Running pre-action listener: _resource_record_pre_action 19:07:29 INFO - Running main action method: install 19:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:30 INFO - Reading from file tmpfile_stdout 19:07:30 INFO - Detecting whether we're running mozinstall >=1.0... 19:07:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:07:30 INFO - Reading from file tmpfile_stdout 19:07:30 INFO - Output received: 19:07:30 INFO - Usage: mozinstall [options] installer 19:07:30 INFO - Options: 19:07:30 INFO - -h, --help show this help message and exit 19:07:30 INFO - -d DEST, --destination=DEST 19:07:30 INFO - Directory to install application into. [default: 19:07:30 INFO - "/builds/slave/test"] 19:07:30 INFO - --app=APP Application being installed. [default: firefox] 19:07:30 INFO - mkdir: /builds/slave/test/build/application 19:07:30 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'] 19:07:30 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 19:07:51 INFO - Reading from file tmpfile_stdout 19:07:51 INFO - Output received: 19:07:51 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:07:51 INFO - Running post-action listener: _resource_record_post_action 19:07:51 INFO - [mozharness: 2017-02-03 03:07:51.918094Z] Finished install step (success) 19:07:51 INFO - [mozharness: 2017-02-03 03:07:51.918282Z] Running run-tests step. 19:07:51 INFO - Running pre-action listener: _resource_record_pre_action 19:07:51 INFO - Running main action method: run_tests 19:07:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:07:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:07:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:07:51 INFO - 2017-02-02 19:07:51.933 screenresolution[1621:7301] starting screenresolution argv=screenresolution get 19:07:51 INFO - 2017-02-02 19:07:51.935 screenresolution[1621:7301] Display 0: 1600x1200x32@60 19:07:51 INFO - 2017-02-02 19:07:51.941 screenresolution[1622:7303] starting screenresolution argv=screenresolution list 19:07:51 INFO - Available Modes on Display 0 19:07:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:07:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:07:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:07:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:07:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:07:52 INFO - Intel Iris: 19:07:52 INFO - Chipset Model: Intel Iris 19:07:52 INFO - Type: GPU 19:07:52 INFO - Bus: Built-In 19:07:52 INFO - VRAM (Dynamic, Max): 1536 MB 19:07:52 INFO - Vendor: Intel (0x8086) 19:07:52 INFO - Device ID: 0x0a2e 19:07:52 INFO - Revision ID: 0x0009 19:07:52 INFO - Displays: 19:07:52 INFO - Display: 19:07:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:07:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:07:52 INFO - Display Serial Number: 1600x1200 60 19:07:52 INFO - Main Display: Yes 19:07:52 INFO - Mirror: Off 19:07:52 INFO - Online: Yes 19:07:52 INFO - Rotation: Supported 19:07:52 INFO - Return code: 0 19:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:07:52 INFO - Python 2.7.3 19:07:52 INFO - Return code: 0 19:07:52 INFO - grabbing minidump binary from tooltool 19:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:07:52 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 0x103672d30>, '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 0x1034d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10366ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:07:52 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 19:07:52 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 19:07:52 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 19:07:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:07:52 INFO - Return code: 0 19:07:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:07:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:07:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:07:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:07:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:07:52 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/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 19:07:52 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/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --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 19:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1xHgPrkgJC/Render', 19:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:07:52 INFO - 'HOME': '/Users/cltbld', 19:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:07:52 INFO - 'LOGNAME': 'cltbld', 19:07:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:07:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:52 INFO - 'MOZ_NO_REMOTE': '1', 19:07:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:07:52 INFO - 'NO_EM_RESTART': '1', 19:07:52 INFO - 'PAGER': '/bin/cat', 19:07:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:52 INFO - 'PWD': '/builds/slave/test', 19:07:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:07:52 INFO - 'SHELL': '/bin/bash', 19:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sW75qCNwPU/Listeners', 19:07:52 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 19:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:07:52 INFO - 'USER': 'cltbld', 19:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:52 INFO - 'XPC_FLAGS': '0x0', 19:07:52 INFO - 'XPC_SERVICE_NAME': '0', 19:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:07:52 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/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 19:07:52 INFO - mozversion application_buildid: 20170202163809 19:07:52 INFO - mozversion application_changeset: 9759594e223f25075dde334fe96af323bf33d144 19:07:52 INFO - mozversion application_display_name: Firefox 19:07:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:07:52 INFO - mozversion application_name: Firefox 19:07:52 INFO - mozversion application_remotingname: firefox 19:07:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:07:52 INFO - mozversion application_vendor: Mozilla 19:07:52 INFO - mozversion application_version: 52.0 19:07:52 INFO - mozversion platform_buildid: 20170202163809 19:07:52 INFO - mozversion platform_changeset: 9759594e223f25075dde334fe96af323bf33d144 19:07:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:07:52 INFO - mozversion platform_version: 52.0 19:07:52 INFO - using testdate: 1486091272 19:07:52 INFO - actual date: 1486091272 19:07:52 INFO - starting webserver on 'localhost:49241' 19:07:52 INFO - SUITE-START | Running 2 tests 19:07:52 INFO - TEST-START | dromaeo_css 19:07:52 INFO - operating with platform_type : mac_ 19:07:52 INFO - Initialising browser for dromaeo_css test... 19:07:52 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpkkbbj1/profile http://localhost:49241/getInfo.html) 19:07:55 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 19:07:55 INFO - PROCESS | 1632 | colorDepth:24 19:07:55 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 19:07:55 INFO - PROCESS | 1632 | __metrics 19:07:55 INFO - PROCESS | 1632 | 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" 19:07:55 INFO - PROCESS | 1632 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:07:56 INFO - TEST-INFO | 1632: exit 0 19:07:56 INFO - Browser initialized. 19:07:56 INFO - Running cycle 1/1 for dromaeo_css test... 19:07:56 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpkkbbj1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:08 INFO - PROCESS | 1634 | RSS: Main: 172228608 19:08:08 INFO - PROCESS | 1634 | 19:11:11 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 19:11:13 INFO - PROCESS | 1634 | RSS: Main: 268460032 19:11:13 INFO - PROCESS | 1634 | 19:14:15 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 19:14:16 INFO - PROCESS | 1634 | RSS: Main: 295366656 19:14:16 INFO - PROCESS | 1634 | 19:17:18 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 19:17:19 INFO - PROCESS | 1634 | RSS: Main: 270749696 19:17:19 INFO - PROCESS | 1634 | 19:20:21 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 19:20:22 INFO - PROCESS | 1634 | RSS: Main: 276402176 19:20:22 INFO - PROCESS | 1634 | 19:23:25 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 19:23:26 INFO - PROCESS | 1634 | RSS: Main: 265011200 19:23:26 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 19:26:29 INFO - PROCESS | 1634 | RSS: Main: 317767680 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | __start_tp_report 19:26:29 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 19:26:29 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 19:26:29 INFO - PROCESS | 1634 | |i|pagename|runs| 19:26:29 INFO - PROCESS | 1634 | |0;dojo.html;3451.9816654087044;3482.7910325380494;3483.8780642677502;3491.179572800393;3537.2041290709594;5773.48038676519;5865.002949498585;5882.441168089024;5902.085176797593;5921.73352199151;5807.73865176067;5839.036558967776;5878.382769809173;5880.823575292738;5889.057750759879;5234.450382709818;5240.082985477546;5246.5278124968745;5303.28405665236;5340.679559226459;5227.398849132342;5227.895442091156;5240.947590524103;5362.3029006229135;5371.597130215249;3890.3775395936655;5246.449122842104;5277.70972596507;5296.09966305729;5321.760520776555;5302.893942121155;5332.840014799563;5358.651687640291;5368.785248590052;5405.486478784509;5142.7685754140775;5209.765560549747;5274.604404669665;5282.049231138393;5308.787648494055;5612.102063669793;5716.085426331767;5758.48173664368;5762.1068734346245;5777.88444231113;6057.030875060013;6098.9695051524905;6114.541409394314;6123.112148738453;6141.263048434216;6089.482393996515;6136.263648362181;6203.038529028008;6228.750849965996;6233.844153896143;5893.44012318829;5939.109133629903;5948.9291927452605;5957.255343082114;5958.106284057426;6327.240731112296;6364;6365.395287447685;6365.872682546323;6372.4583410409705;6053.940560401912;6076.179715738407;6109.5112391008615;6110.419510146529;6115.969420152871;6122.733612273343;6123.8162855114415;6133.73253493014;6176.227971503562;6187.566870319124;6066.393360663987;6090.451859332681;6110.1523298385355;6111.642934067181;6119.836419153483;6041.697915104315;6106.297775755845;6111.113888486145;6120;6158.322584515699;4909.0672772173175;4951.876203094879;4956.4547899731;4960.454350021495;4976.751162441936;4449.555044495589;4514.616257618073;4523.615492683159;4546.931796023062;4574.245249533789;5699.430056994267;5781.479666830005;5847.06446968483;5864.70676466175;5921.3782552831335;6179.81460556184;6181.258249010058;6236.407541283571;6237.719302631393;6248.50011999039;5742.59801813869;5850.151727999416;5868.794592189338;5893.410658934073;5893.882122357614;5409.540189083972;5425.457454254622;5428.104362780097;5429.864253393618;5444.945550544523;6362.331955144736;6384.936150638434;6388.520860935356;6388.680565971683;6388.776392826228;4882.633802464758;6121;6133.08984587437;6178.474829639351;6189.319174890668;6365;6369.363063693593;6387.393197646216;6394.584352017104;6407.391297826699;6121.479674227562;6171.814845554641;6175.382461753788;6181.598196117238;6193.38066193377;6132.662703551169;6191.473724733448;6206.565540412128;6207.068939659087;6208.25500939872;5972.193753843349;6019.969900150471;6090.543209259235;6177.104319873503;6177.876442471035;5995.890760209375;6161.72272247741;6169.50643948474;6179.536534759821;6180.938190618036;4958.57852082577;5895.616784908967;6049.848753781191;6096.481799047131;6100.908486372797;6076.635401875725;6077.936361136695;6118.2658081028785;6129.633877547049;6155.722992465439;6061.454469097803;6065.60573562717;6091.817245482643;6110.694465276807;6117.480014198843 19:26:29 INFO - PROCESS | 1634 | |1;ext.html;499.26857154268987;518.1838604198388;529.198264629087;539.851540826273;575.5280669850722;31444.899428520006;40612;41897.952551186194;41906.161876762526;43585.91035224121;44026.55973440265;44506.55493445064;44643;44657.330140047845;44676;8029.839403211932;8175.427720059598;9722.368046077017;9737.464439455827;9746.171575416098;9681.273904457159;9785.02149785023;9795.706128816111;9800.803983920317;9808.362456440344;9785.755356116082;9791.902080979205;9804.117629413351;9808.46053467059;9820.214382849355;9732.367396119265;9783.853242201372;9802.754931126743;9805.80388392228;9822.968588298269;9580.473073980927;9651.662191823323;9653.613855445774;9664.081912218327;9671.032896710343;41985.160296793896;42227.57772422267;42270.78864605688;42300.153996919886;42325;3245.7078862902217;3588.4617307403837;3815.9618403815884;3868.3810590305698;4039.7576145431367;29547;29974.801007959657;32451.83774081138;32685.85599504006;33028.83485582557;3312.2216279174377;3325.700686938187;3334.0997930558856;3340.799552026862;3391.084407210064;520395;524611;524915;525049;525062;36459.4531082034;37276.813615931744;63470;65614.67192664006;71450;37915.62084379176;38445.807770960964;38568.42147367792;38571;38579;15704.607384815243;15885.444009459614;15889.364425423084;15891.205439727968;15896.046237225572;13162.736745265232;13254.138480998705;13261.535846245335;13296.601101966762;13312.134711243738;7682.462227644011;8370.455920365157;8402.957985210034;8458.323334133378;8475.957620211859;3467.653234676512;3477.165480284764;3490.2844916791996;3493.4235851084795;3527.3474407234744;940.9529523523796;963.3834346018554;1050.4642632257603;1119.4794420594462;1139.8119310313705;29230;30263.697363026087;30264.08354080485;30497.08508744697;30710.385792284476;735.9227281135404;1078.9190810689229;1104.7624760676492;1114.6154576671036;1161.7618388230392;15444.613884652748;15782.974106683028;15881;15932.699196052;16054.197290135446;657831;667569.6486070252;668216;668478;668566;59580.404195958356;60276.698616506634;60344.79310413855;60520.48698782478;60535.69732151311;1288.7035981724257;1331.5872079655337;1387.5143699705225;1391.9860801391856;1435.2751860310477;30483.695163048087;31918.84040579875;31925.20186995344;32155.35689286248;32816.015519533496;51101.23348149707;51582.74208628933;51720.48279517307;51763;51777;528950;531583;531651.3417433043;531724;612944;24441.02235910544;27269;27426.17721468359;27858.58212126779;28626.713732862405;38170.83812621466;38654.6134538651;47145.528544714114;47974.28038579354;48386.5161348382;38573.42139867848;38897.17433235901;39433.80283098566;39698.40452393159;41032.384514231715;39280.01799955024;39325.60674393334;40462.797686011385;40534.986625334604;40583;37763.43354849624;38118.61881381151;38219.808900955315;38508.61491385163;38574.80712596419;31202.063938081894;32413.18967025843;32526.837365813964;33261.833690831394;35058.64941350554;21666.35000949974;25423.872880635477;25942.35144121412;26023.609645855708;26471 19:26:29 INFO - PROCESS | 1634 | |2;jquery.html;347.25167264544905;391.39724823771394;396.8035822267977;405.7078903189702;417.2427044913482;18963;21285.467863303424;21307.934603269852;21544.13823447064;21687.566248675015;21301.25445609404;21408;21661.566768664616;21725;21735.347939561798;5908.350081491032;5929.080992446177;6088.604240724361;6148.723307451175;6150.2927163376335;6027.276726792769;6123.448889599935;6126.509879209675;6129.172561704179;6129.816105516842;5828.708564571775;6096.4817990470865;6164.10620460033;6187.1956645636;6192;5964.880702385972;6132.846678833021;6142.140100385949;6174.475169610566;6178.227721534809;6050.606710563843;6072.939270607281;6077;6091.969540152271;6096.116063170815;10986;13660.248686322248;13712.314384280746;13879.653008674864;13922.443102275896;2182.388931099295;2207.536417352358;2288.8397812153157;2497.1884137655334;2724.209979106057;10206.285560010801;10445.529951152217;10689;10709.892901070967;10722.678319650424;1889.187649310796;1971.3888694504606;1977.2189984955862;1983.3157560641555;2010.155734591475;101205;101275.98724012739;118871.99999999914;121972;142364.28817855948;8129.390295727726;9656.71029869105;10029.64896228643;10210.846837297446;11523.827142592867;12581;12694.80957785634;12704.6823829405;12710.428030738454;12718.364081795873;8350.206730360605;8436.789080273042;8511.063782983867;8522.65909363631;8607.569621518898;8529.701460448854;8680.392372533988;8721.30229581632;8877.511736854534;8943.3739638226;3586.8385922633543;3830.8276127574327;3989.182217645434;3989.5412027617194;4084.571120032354;1724.025925352172;1903.9524011899814;1976.443893773592;2019.515316324101;2019.7374341335533;898.9527200811112;929.809389075238;976.9853452198223;979.6816034788723;1000.3397757480174;17678.29286828538;21663.45841353979;21797.019134139002;21802;21915.890420547796;936.3773090894479;943.6932996776076;958.6273971919583;963.2727290895469;1027.6814187601867;10151.680281563496;10689;10931.344119352705;11462.083033357312;11603.245789023686;573505;574433;574798;579410;597568;105091.47454262679;125801;126507;126646;132658.67341326462;970.1947383671536;986.1124987511297;996.2478328861663;1001.7645853224486;1005.8440941654055;17619.119044048002;18308.90845545817;18984.43046708601;20023.79857208572;20070.297539586045;55410;56075;56392.15411768909;56782.86434271209;58021;78615.60692196502;79328;80108.19891801008;81362;82018;7397.038385009914;7594.8101297468;7739.961300193463;7869.803254918673;8226;11901.761964760482;13238.602841914759;13341.866581334063;13643.727125457634;13656.590302290948;11589.7102572433;11624.418779061183;11712.648620541397;11805.881941180478;11868.82196767032;11401.372924489233;11477.598284060017;11664.475098620753;11742.765144697229;11811.409429528661;11578.536858525564;11782.17524773292;11798.587049453228;11976.28142311464;12065.396730163282;7584.233507262518;7785.610719464117;7798.025246844145;7809.687612495437;8022.9598852005365;11288;11756.353400563052;11786.705332366759;11885.346305953255;12104 19:26:29 INFO - PROCESS | 1634 | |3;mootools.html;1349.5209200733739;1363.5704753002803;1478.9778153327702;1806.9909650451746;1837.4303965770612;8033.03603567572;8451.957740211306;8452.154784521545;8455.577221138941;8463.661453541867;7610.619469026554;7829.334506566948;8235.094139644634;8391.70629027984;8418.32653387729;2372.655964885095;2405.987970060156;2409.3976505873534;2411.9397015074587;2417.4319035026756;2407;2413.4690368118986;2439.5730747119183;2443.1082654831034;2444.4133407982044;1889.905504724765;2386.642003699442;2389.247387073075;2414.8792560372;2417.7340492545895;2374.750651181618;2378.7502312257225;2391.8280042778915;2399.2682231919257;2400.3999000249937;2404.5311164322966;2404.8797560121925;2425.0178677635586;2426.8301218914685;2429.4169399344205;8606.483610983361;8637;8647.783805404852;8658.610362533638;8683.739487815375;5129.153689641204;5292.814751483718;5296.841094767163;5299.417064122943;5302.3637163540625;3375.932481350359;3389.915252118692;3466.9826650866585;3519.7360197985254;3614.313280476701;1054.6256079091966;1072.4316112460408;1094.0919037199185;1105.9557617695282;1112.3492756737319;11141.777164456666;11185.944070279678;11199.440027998568;11213.495392707347;11216.66350009501;4554.863354099382;4704.623630109583;4792.329073929653;4792.400949881265;4862.927056094161;9677.419354838732;9687;9698.854517182248;9700;9702.320837541445;5335.413104558495;5340.06548853949;5340.546053585489;5340.759665815048;5342;4441.222786012435;4452.265376212953;4861.756912154378;4915.827946021872;4917.360743103373;3437.8281085945605;3923.588023257574;3945.4870866787132;3962.2867883781196;4054.4526488924207;1196.0192642033448;1298.2599918046812;1302.3358087375318;1311.1215485624655;1317.9802302965463;821.4865708931918;924.1082355526949;924.7595625137512;929.3076657889916;951.167728237792;5805.954928112896;5847.239858818326;6012.909806352908;6075.301340345828;6257.311695713468;927.4249965021595;936.321167153808;952.1858810716876;960.2270172511056;997.7356000659831;3654.7258955578436;3848;3902.414637804295;3965.821538030738;4002.239574480839;10033.548490317808;10203.183745300357;10306.227032972558;10310.278280520291;10348.586056557804;10086.949565252127;10160.847587286196;10162.288639795144;10411.53148108337;10418.739531511621;7970.163132871081;8035.437519373705;8108.270255676899;8192.18078192176;8196.83606327882;4647.326137710081;5659.830205093854;5680.801171958961;5696.20253164549;5877.382874798084;9374.343795934492;9454.480003599869;9489;9560.474173920224;9601.951990240004;9640.228781697308;9676.516174191403;9761.609535618496;9795.9020409795;9877.950610246902;6455.289918109098;6635.734570617121;6667.233268174028;6687;6893.862122757617;6842.794716158523;7750.806229844299;7815.687372505036;7820.569868657051;7942.126366099609;7213.783586492414;7301.598412087386;7327.340539351484;7339.559626422431;7472.701091956261;7151.141862976476;7163.426925845815;7215.170255420484;7359.668814903449;7374.041374621265;6707.3628005339415;6871.484638652021;6874.518783685294;6877.243503214742;6890.000949862342;4845.466998630078;4884.242942343943;4923.064617722621;5010.148274793367;5016.673916195436;4811.566958973569;4912.70523768575;4930.112579735682;5046.646734728533;5117.718525481134 19:26:29 INFO - PROCESS | 1634 | |4;prototype.html;303.7008546581617;308.82551358482453;314.9606299212598;322.1045493527993;322.4791960983013;5070.416902056256;5185.118529849925;5188.558972487338;5194.636375453715;5215.556677682392;4136.689748268876;4766.903612169203;4783.8665673983505;5157;5187.429382767892;3469.930601387971;3982.2234664240486;4038.4548086008454;4040.5353384360883;4055.513338399396;3381.0871064812486;3635.78185308881;3722.7156630962277;4009.5990400959963;4069.369247766601;3465.376232278189;3477.5479187705564;3893.279743247508;3996.841705479038;4036.3652720648183;3621.4929909812386;3927.666148377377;3976.681865450757;3983.5618082010956;4017.27689015977;2862.77097832175;3037.9088627340993;3133.373325334919;3254.4304746669236;3586.8206589670413;4168.645665118469;4570.497245303014;5004.924926126111;5061.443241243497;5139.8458046258675;4590.288505281686;4618.930716039262;4651.279051746951;4654.488006319302;4673;4337.262665346899;4736.8578942631775;5252.684838909678;5429.239906413105;5499.752511137009;3573.3925232710503;3693.538307711536;3933.272344616255;3944.6055394460614;3945.6448919597374;4745.762711864393;5267.683938963636;5658.0479734492355;5748.367679555246;5749.269097178891;3582.6775590197008;3591.8204089795404;3679.4112941929698;3800.7529510582276;4032.778197199182;3829.7319187656594;4006.59934006597;4029.81865816039;4067.9796601016806;4074.7351422157467;4013.518377794683;4602.769861506911;4611.9077618447445;4633.235516139799;4641.141388843007;4588.38056862326;4871.2206047032305;5249.816256431083;5515.283013208257;5553.222548843165;1255.32212605194;1261.4701825233424;1291.2768849444342;1310.541310541303;1311.5212947274367;782.8003859015914;894.5124906925611;915.4507295622573;923.5474617437408;934.9108288843557;4015.951864549101;4122.670186385082;4779.283107533898;4804.51060171348;4888.828890988798;5181.4351895811815;5189.6107791915;5221.6083793715625;5236.581073514109;5247.239150323182;4108.77401742901;4501.572350626685;4711.623070154379;4810.95189048112;4834.5890599299455;2434.9026038958245;2497.8626175560516;2621.252942911299;2829.618001569803;2849.28767808048;4472.74763066342;4486.59620634138;5299.417064122943;5486.341639003345;5608.747606357723;4860.392450943632;5114;5149.613778966593;5441.319835020622;5484.890302194013;5017.322661440732;5803.651780893244;5807.709614519257;5835.708214589338;5867.70661466925;4748.501407352178;4920.311156438173;5591.692456914909;5642.746076426489;5685.232493613309;4615.399998000238;5264.921026184534;5614.5789065821045;5654.434556544313;5664.971675141598;5910.911336330045;5930.673812940329;5930.975202646595;5938.940610593839;5967.6121052131475;3891.9416208756325;3917.7845218513257;3932.761180228333;3944.349182384989;3969.761814291152;4980.626453015966;5081.314022606901;5485.670859748428;5720.713964301852;5775.971120144372;4864.391951006124;5054.711048682562;5158.38099428071;5517.255170552085;5550.8057217997175;4827.493113223061;5156.5616922562;5471.179323101566;5505.6696598204235;5531.391546929754;4421.425214722066;4863.862808488576;5092.3889133302755;5146.867689108391;5359.490848369399;4844.442889067803;5376.392404747395;5540.695261760642;5596.908602822574;5620.381758006698;4056.0265536271672;5260.973695131653;5456.61803673739;5537.390887002507;5541.528970037431 19:26:29 INFO - PROCESS | 1634 | |5;yui.html;712.6579241963857;729.7591794707747;745.2361329637125;781.1251398433755;819.274941676616;15065.397384104637;15690.293936772845;15773.921130394361;15775.053496790186;15785.447509337175;13995.370208340624;14118.858811411883;14119.858801411983;14152.29238538074;14170.50403235887;706.8303607134302;727.3163226567036;732.2640746050212;858.3776761847657;876.4040452492303;714.9142102947653;718.1023720349563;718.1525799556521;851.3870013590205;881.1276835932445;901.603294550399;908.2143945487139;914.2868562521244;917.7889085510336;918.3066784577635;910.8269428808505;911.5806728904712;912.0833562269943;912.4434095201922;912.5710915869531;664.9667516624149;671.9193696756372;673.3266733266734;675.3145557259386;675.7297081167573;14118.788218176736;14239.857601423957;14267.500637477639;14278.143311401349;15174.089554626758;13954.372053257628;14329.49846755369;14380.92809535956;14436.855631443656;14537.345819438046;8897.644094236222;12124.696882577919;12174.330411827346;12483.063770217179;12723.872761272361;4414.271645178574;4536.160810250081;4720.716756994591;4788.114198873185;4795.448523419782;96913.51543242238;97098;99831.50084249605;100593.4910976336;102633.48683256537;8747.65009399617;10501.264911456125;10703.83944240837;10727.40999245049;11014.779704405866;20086.09612567438;20268.79731202669;20276.188952442033;20281.391558253275;20316.69524957127;7473.588952607659;7661.50200236994;7920.168382319889;7933.048034235929;7934.563599001995;4326.783660817009;4360.171567402247;4363.912721745611;4554.521775213621;4557.726536407826;3348.8158151301427;3376.5610470638658;3402.795832250073;3437.2609888874013;3466.3587236361354;647.2782847125516;648.3872740260502;652.9183852018498;653.9542232043711;663.7112855907695;589.602018637418;607.1287702147432;614.2371394098875;630.130420020369;633.1863555331469;8509.489430634181;8689.826203475895;8703.912960870437;8935.776605584912;8991.640334386551;596.83885350955;600.9789657361971;605.8969975104243;624.6689254695019;637.4995628431751;3689.7786132832116;4340.52254252032;4370.104128653682;4389.473263208435;4481;106859.93140068655;108510;109286.3607045879;109630.45184774185;116696;70283.2971670287;76960.23039769531;87400.5629971846;101517;106266;84214;84458;85308;86193;88347.55826220827;8495.235428811437;8521.957390213009;8552.572371381282;8628.266597339045;8660.047394786443;51716.18993335215;52123.696907577614;52530.73734631302;55586;59504.70247648734;54419.18371224514;57009;62842;72725.27274727185;73983.6300818514;10718;12445;12622.810657840324;12926.96584273237;13043.673908152372;11042;14382.640433988816;14471.462343802903;14892.925535372255;15019;12970.740585188432;13839.861601383856;14028.018038737191;14317.57047288583;14318.856811431753;13409.865901341253;13527.053106282467;13617.79573306421;13756;14140.646483837987;10767.153480337362;13077.607671769862;13141.145825521311;13298.933505332798;13333.066685332322;11101.085282138498;11264.549418023187;11673.533058677558;11876.703082423008;12069.637910862688;11390.202685811913;11399.373034483184;11616.767664646492;11638.76722465529;11655.30068195911 19:26:29 INFO - PROCESS | 1634 | __end_tp_report 19:26:29 INFO - PROCESS | 1634 | __start_cc_report 19:26:29 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1614 19:26:29 INFO - PROCESS | 1634 | __end_cc_report 19:26:29 INFO - PROCESS | 1634 | __startTimestamp1486092389589__endTimestamp 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | ------- Summary: start ------- 19:26:29 INFO - PROCESS | 1634 | Number of tests: 6 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5763.65 Median:6049.85 stddev:624.57 (10.3%) stddev-sans-first:599.58 19:26:29 INFO - PROCESS | 1634 | Values: 3452.0 3482.8 3483.9 3491.2 3537.2 5773.5 5865.0 5882.4 5902.1 5921.7 5807.7 5839.0 5878.4 5880.8 5889.1 5234.5 5240.1 5246.5 5303.3 5340.7 5227.4 5227.9 5240.9 5362.3 5371.6 3890.4 5246.4 5277.7 5296.1 5321.8 5302.9 5332.8 5358.7 5368.8 5405.5 5142.8 5209.8 5274.6 5282.0 5308.8 5612.1 5716.1 5758.5 5762.1 5777.9 6057.0 6099.0 6114.5 6123.1 6141.3 6089.5 6136.3 6203.0 6228.8 6233.8 5893.4 5939.1 5948.9 5957.3 5958.1 6327.2 6364.0 6365.4 6365.9 6372.5 6053.9 6076.2 6109.5 6110.4 6116.0 6122.7 6123.8 6133.7 6176.2 6187.6 6066.4 6090.5 6110.2 6111.6 6119.8 6041.7 6106.3 6111.1 6120.0 6158.3 4909.1 4951.9 4956.5 4960.5 4976.8 4449.6 4514.6 4523.6 4546.9 4574.2 5699.4 5781.5 5847.1 5864.7 5921.4 6179.8 6181.3 6236.4 6237.7 6248.5 5742.6 5850.2 5868.8 5893.4 5893.9 5409.5 5425.5 5428.1 5429.9 5444.9 6362.3 6384.9 6388.5 6388.7 6388.8 4882.6 6121.0 6133.1 6178.5 6189.3 6365.0 6369.4 6387.4 6394.6 6407.4 6121.5 6171.8 6175.4 6181.6 6193.4 6132.7 6191.5 6206.6 6207.1 6208.3 5972.2 6020.0 6090.5 6177.1 6177.9 5995.9 6161.7 6169.5 6179.5 6180.9 4958.6 5895.6 6049.8 6096.5 6100.9 6076.6 6077.9 6118.3 6129.6 6155.7 6061.5 6065.6 6091.8 6110.7 6117.5 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:70156.62 Median:39566.10 stddev:156018.00 (394.3%) stddev-sans-first:156368.02 19:26:29 INFO - PROCESS | 1634 | Values: 499.3 518.2 529.2 539.9 575.5 31444.9 40612.0 41898.0 41906.2 43585.9 44026.6 44506.6 44643.0 44657.3 44676.0 8029.8 8175.4 9722.4 9737.5 9746.2 9681.3 9785.0 9795.7 9800.8 9808.4 9785.8 9791.9 9804.1 9808.5 9820.2 9732.4 9783.9 9802.8 9805.8 9823.0 9580.5 9651.7 9653.6 9664.1 9671.0 41985.2 42227.6 42270.8 42300.2 42325.0 3245.7 3588.5 3816.0 3868.4 4039.8 29547.0 29974.8 32451.8 32685.9 33028.8 3312.2 3325.7 3334.1 3340.8 3391.1 520395.0 524611.0 524915.0 525049.0 525062.0 36459.5 37276.8 63470.0 65614.7 71450.0 37915.6 38445.8 38568.4 38571.0 38579.0 15704.6 15885.4 15889.4 15891.2 15896.0 13162.7 13254.1 13261.5 13296.6 13312.1 7682.5 8370.5 8403.0 8458.3 8476.0 3467.7 3477.2 3490.3 3493.4 3527.3 941.0 963.4 1050.5 1119.5 1139.8 29230.0 30263.7 30264.1 30497.1 30710.4 735.9 1078.9 1104.8 1114.6 1161.8 15444.6 15783.0 15881.0 15932.7 16054.2 657831.0 667569.6 668216.0 668478.0 668566.0 59580.4 60276.7 60344.8 60520.5 60535.7 1288.7 1331.6 1387.5 1392.0 1435.3 30483.7 31918.8 31925.2 32155.4 32816.0 51101.2 51582.7 51720.5 51763.0 51777.0 528950.0 531583.0 531651.3 531724.0 612944.0 24441.0 27269.0 27426.2 27858.6 28626.7 38170.8 38654.6 47145.5 47974.3 48386.5 38573.4 38897.2 39433.8 39698.4 41032.4 39280.0 39325.6 40462.8 40535.0 40583.0 37763.4 38118.6 38219.8 38508.6 38574.8 31202.1 32413.2 32526.8 33261.8 35058.6 21666.4 25423.9 25942.4 26023.6 26471.0 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:34275.26 Median:11992.19 stddev:96967.22 (808.6%) stddev-sans-first:97205.77 19:26:29 INFO - PROCESS | 1634 | Values: 347.3 391.4 396.8 405.7 417.2 18963.0 21285.5 21307.9 21544.1 21687.6 21301.3 21408.0 21661.6 21725.0 21735.3 5908.4 5929.1 6088.6 6148.7 6150.3 6027.3 6123.4 6126.5 6129.2 6129.8 5828.7 6096.5 6164.1 6187.2 6192.0 5964.9 6132.8 6142.1 6174.5 6178.2 6050.6 6072.9 6077.0 6092.0 6096.1 10986.0 13660.2 13712.3 13879.7 13922.4 2182.4 2207.5 2288.8 2497.2 2724.2 10206.3 10445.5 10689.0 10709.9 10722.7 1889.2 1971.4 1977.2 1983.3 2010.2 101205.0 101276.0 118872.0 121972.0 142364.3 8129.4 9656.7 10029.6 10210.8 11523.8 12581.0 12694.8 12704.7 12710.4 12718.4 8350.2 8436.8 8511.1 8522.7 8607.6 8529.7 8680.4 8721.3 8877.5 8943.4 3586.8 3830.8 3989.2 3989.5 4084.6 1724.0 1904.0 1976.4 2019.5 2019.7 899.0 929.8 977.0 979.7 1000.3 17678.3 21663.5 21797.0 21802.0 21915.9 936.4 943.7 958.6 963.3 1027.7 10151.7 10689.0 10931.3 11462.1 11603.2 573505.0 574433.0 574798.0 579410.0 597568.0 105091.5 125801.0 126507.0 126646.0 132658.7 970.2 986.1 996.2 1001.8 1005.8 17619.1 18308.9 18984.4 20023.8 20070.3 55410.0 56075.0 56392.2 56782.9 58021.0 78615.6 79328.0 80108.2 81362.0 82018.0 7397.0 7594.8 7740.0 7869.8 8226.0 11901.8 13238.6 13341.9 13643.7 13656.6 11589.7 11624.4 11712.6 11805.9 11868.8 11401.4 11477.6 11664.5 11742.8 11811.4 11578.5 11782.2 11798.6 11976.3 12065.4 7584.2 7785.6 7798.0 7809.7 8023.0 11288.0 11756.4 11786.7 11885.3 12104.0 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5555.49 Median:5123.44 stddev:3035.99 (59.3%) stddev-sans-first:3028.05 19:26:29 INFO - PROCESS | 1634 | Values: 1349.5 1363.6 1479.0 1807.0 1837.4 8033.0 8452.0 8452.2 8455.6 8463.7 7610.6 7829.3 8235.1 8391.7 8418.3 2372.7 2406.0 2409.4 2411.9 2417.4 2407.0 2413.5 2439.6 2443.1 2444.4 1889.9 2386.6 2389.2 2414.9 2417.7 2374.8 2378.8 2391.8 2399.3 2400.4 2404.5 2404.9 2425.0 2426.8 2429.4 8606.5 8637.0 8647.8 8658.6 8683.7 5129.2 5292.8 5296.8 5299.4 5302.4 3375.9 3389.9 3467.0 3519.7 3614.3 1054.6 1072.4 1094.1 1106.0 1112.3 11141.8 11185.9 11199.4 11213.5 11216.7 4554.9 4704.6 4792.3 4792.4 4862.9 9677.4 9687.0 9698.9 9700.0 9702.3 5335.4 5340.1 5340.5 5340.8 5342.0 4441.2 4452.3 4861.8 4915.8 4917.4 3437.8 3923.6 3945.5 3962.3 4054.5 1196.0 1298.3 1302.3 1311.1 1318.0 821.5 924.1 924.8 929.3 951.2 5806.0 5847.2 6012.9 6075.3 6257.3 927.4 936.3 952.2 960.2 997.7 3654.7 3848.0 3902.4 3965.8 4002.2 10033.5 10203.2 10306.2 10310.3 10348.6 10086.9 10160.8 10162.3 10411.5 10418.7 7970.2 8035.4 8108.3 8192.2 8196.8 4647.3 5659.8 5680.8 5696.2 5877.4 9374.3 9454.5 9489.0 9560.5 9602.0 9640.2 9676.5 9761.6 9795.9 9878.0 6455.3 6635.7 6667.2 6687.0 6893.9 6842.8 7750.8 7815.7 7820.6 7942.1 7213.8 7301.6 7327.3 7339.6 7472.7 7151.1 7163.4 7215.2 7359.7 7374.0 6707.4 6871.5 6874.5 6877.2 6890.0 4845.5 4884.2 4923.1 5010.1 5016.7 4811.6 4912.7 4930.1 5046.6 5117.7 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4363.34 Median:4794.19 stddev:1332.48 (27.8%) stddev-sans-first:1300.91 19:26:29 INFO - PROCESS | 1634 | Values: 303.7 308.8 315.0 322.1 322.5 5070.4 5185.1 5188.6 5194.6 5215.6 4136.7 4766.9 4783.9 5157.0 5187.4 3469.9 3982.2 4038.5 4040.5 4055.5 3381.1 3635.8 3722.7 4009.6 4069.4 3465.4 3477.5 3893.3 3996.8 4036.4 3621.5 3927.7 3976.7 3983.6 4017.3 2862.8 3037.9 3133.4 3254.4 3586.8 4168.6 4570.5 5004.9 5061.4 5139.8 4590.3 4618.9 4651.3 4654.5 4673.0 4337.3 4736.9 5252.7 5429.2 5499.8 3573.4 3693.5 3933.3 3944.6 3945.6 4745.8 5267.7 5658.0 5748.4 5749.3 3582.7 3591.8 3679.4 3800.8 4032.8 3829.7 4006.6 4029.8 4068.0 4074.7 4013.5 4602.8 4611.9 4633.2 4641.1 4588.4 4871.2 5249.8 5515.3 5553.2 1255.3 1261.5 1291.3 1310.5 1311.5 782.8 894.5 915.5 923.5 934.9 4016.0 4122.7 4779.3 4804.5 4888.8 5181.4 5189.6 5221.6 5236.6 5247.2 4108.8 4501.6 4711.6 4811.0 4834.6 2434.9 2497.9 2621.3 2829.6 2849.3 4472.7 4486.6 5299.4 5486.3 5608.7 4860.4 5114.0 5149.6 5441.3 5484.9 5017.3 5803.7 5807.7 5835.7 5867.7 4748.5 4920.3 5591.7 5642.7 5685.2 4615.4 5264.9 5614.6 5654.4 5665.0 5910.9 5930.7 5931.0 5938.9 5967.6 3891.9 3917.8 3932.8 3944.3 3969.8 4980.6 5081.3 5485.7 5720.7 5776.0 4864.4 5054.7 5158.4 5517.3 5550.8 4827.5 5156.6 5471.2 5505.7 5531.4 4421.4 4863.9 5092.4 5146.9 5359.5 4844.4 5376.4 5540.7 5596.9 5620.4 4056.0 5261.0 5456.6 5537.4 5541.5 19:26:29 INFO - PROCESS | 1634 | 19:26:29 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20592.89 Median:4508.58 stddev:30012.01 (665.7%) stddev-sans-first:30059.08 19:26:29 INFO - PROCESS | 1634 | Values: 712.7 729.8 745.2 781.1 819.3 15065.4 15690.3 15773.9 15775.1 15785.4 13995.4 14118.9 14119.9 14152.3 14170.5 706.8 727.3 732.3 858.4 876.4 714.9 718.1 718.2 851.4 881.1 901.6 908.2 914.3 917.8 918.3 910.8 911.6 912.1 912.4 912.6 665.0 671.9 673.3 675.3 675.7 14118.8 14239.9 14267.5 14278.1 15174.1 13954.4 14329.5 14380.9 14436.9 14537.3 8897.6 12124.7 12174.3 12483.1 12723.9 4414.3 4536.2 4720.7 4788.1 4795.4 96913.5 97098.0 99831.5 100593.5 102633.5 8747.7 10501.3 10703.8 10727.4 11014.8 20086.1 20268.8 20276.2 20281.4 20316.7 7473.6 7661.5 7920.2 7933.0 7934.6 4326.8 4360.2 4363.9 4554.5 4557.7 3348.8 3376.6 3402.8 3437.3 3466.4 647.3 648.4 652.9 654.0 663.7 589.6 607.1 614.2 630.1 633.2 8509.5 8689.8 8703.9 8935.8 8991.6 596.8 601.0 605.9 624.7 637.5 3689.8 4340.5 4370.1 4389.5 4481.0 106859.9 108510.0 109286.4 109630.5 116696.0 70283.3 76960.2 87400.6 101517.0 106266.0 84214.0 84458.0 85308.0 86193.0 88347.6 8495.2 8522.0 8552.6 8628.3 8660.0 51716.2 52123.7 52530.7 55586.0 59504.7 54419.2 57009.0 62842.0 72725.3 73983.6 10718.0 12445.0 12622.8 12927.0 13043.7 11042.0 14382.6 14471.5 14892.9 15019.0 12970.7 13839.9 14028.0 14317.6 14318.9 13409.9 13527.1 13617.8 13756.0 14140.6 10767.2 13077.6 13141.1 13298.9 13333.1 11101.1 11264.5 11673.5 11876.7 12069.6 11390.2 11399.4 11616.8 11638.8 11655.3 19:26:29 INFO - PROCESS | 1634 | -------- Summary: end -------- 19:26:29 INFO - PROCESS | 1634 | 19:26:30 INFO - TEST-INFO | 1634: exit 0 19:26:30 INFO - TEST-OK | dromaeo_css | took 1117690ms 19:26:30 INFO - TEST-START | kraken 19:26:30 INFO - operating with platform_type : mac_ 19:26:30 INFO - Initialising browser for kraken test... 19:26:30 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpsNExnG/profile http://localhost:49241/getInfo.html) 19:26:32 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 19:26:32 INFO - PROCESS | 1644 | colorDepth:24 19:26:32 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 19:26:32 INFO - PROCESS | 1644 | __metrics 19:26:32 INFO - PROCESS | 1644 | 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" 19:26:32 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:26:33 INFO - TEST-INFO | 1644: exit 0 19:26:33 INFO - Browser initialized. 19:26:33 INFO - Running cycle 1/1 for kraken test... 19:26:33 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpsNExnG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:45 INFO - PROCESS | 1646 | RSS: Main: 167743488 19:26:45 INFO - PROCESS | 1646 | 19:26:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 19:26:49 INFO - PROCESS | 1646 | RSS: Main: 217853952 19:26:49 INFO - PROCESS | 1646 | 19:26:51 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 19:26:52 INFO - PROCESS | 1646 | RSS: Main: 231251968 19:26:52 INFO - PROCESS | 1646 | 19:26:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 19:26:56 INFO - PROCESS | 1646 | RSS: Main: 328581120 19:26:56 INFO - PROCESS | 1646 | 19:26:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 19:26:58 INFO - PROCESS | 1646 | RSS: Main: 231350272 19:26:58 INFO - PROCESS | 1646 | 19:27:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:01 INFO - PROCESS | 1646 | RSS: Main: 233750528 19:27:01 INFO - PROCESS | 1646 | 19:27:04 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:05 INFO - PROCESS | 1646 | RSS: Main: 275197952 19:27:05 INFO - PROCESS | 1646 | 19:27:07 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:08 INFO - PROCESS | 1646 | RSS: Main: 273969152 19:27:08 INFO - PROCESS | 1646 | 19:27:11 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 19:27:11 INFO - PROCESS | 1646 | RSS: Main: 271450112 19:27:11 INFO - PROCESS | 1646 | 19:27:13 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:13 INFO - PROCESS | 1646 | RSS: Main: 247312384 19:27:13 INFO - PROCESS | 1646 | 19:27:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:16 INFO - PROCESS | 1646 | RSS: Main: 250093568 19:27:16 INFO - PROCESS | 1646 | 19:27:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:27:19 INFO - PROCESS | 1646 | RSS: Main: 251752448 19:27:19 INFO - PROCESS | 1646 | 19:27:22 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:22 INFO - PROCESS | 1646 | RSS: Main: 269172736 19:27:22 INFO - PROCESS | 1646 | 19:27:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:26 INFO - PROCESS | 1646 | RSS: Main: 262361088 19:27:26 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 19:27:28 INFO - PROCESS | 1646 | RSS: Main: 306782208 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | __start_tp_report 19:27:28 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 19:27:28 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 19:27:28 INFO - PROCESS | 1646 | |i|pagename|runs| 19:27:28 INFO - PROCESS | 1646 | |0;ai-astar;101;114;113;112;114;114;114;114;113;114 19:27:28 INFO - PROCESS | 1646 | |1;audio-beat-detection;145;138;139;142;108;107;109;132;173;115 19:27:28 INFO - PROCESS | 1646 | |2;audio-dft;183;184;183;182;184;183;181;181;181;184 19:27:28 INFO - PROCESS | 1646 | |3;audio-fft;82;58;62;112;85;82;59;57;82;58 19:27:28 INFO - PROCESS | 1646 | |4;audio-oscillator;91;68;106;101;98;99;104;68;68;90 19:27:28 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;89;85;89;87;88;86;90;87;89;88 19:27:28 INFO - PROCESS | 1646 | |6;imaging-darkroom;94;94;95;94;95;103;95;94;93;95 19:27:28 INFO - PROCESS | 1646 | |7;imaging-desaturate;83;82;81;79;82;82;86;84;83;82 19:27:28 INFO - PROCESS | 1646 | |8;json-parse-financial;53;54;54;54;57;57;56;56;57;57 19:27:28 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;63;70;72;85;111;102;84;69;71;70 19:27:28 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;82;82;80;80;82;81;82;84;83;84 19:27:28 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;145;127;144;150;145;155;140;140;182;136 19:27:28 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;164;163;162;163;162;162;159;160;161;161 19:27:28 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;66;69;84;84;85;80;63;65;65;66 19:27:28 INFO - PROCESS | 1646 | __end_tp_report 19:27:28 INFO - PROCESS | 1646 | __start_cc_report 19:27:28 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1873 19:27:28 INFO - PROCESS | 1646 | __end_cc_report 19:27:28 INFO - PROCESS | 1646 | __startTimestamp1486092448297__endTimestamp 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | ------- Summary: start ------- 19:27:28 INFO - PROCESS | 1646 | Number of tests: 14 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:4.03 (3.5%) stddev-sans-first:0.73 19:27:28 INFO - PROCESS | 1646 | Values: 101.0 114.0 113.0 112.0 114.0 114.0 114.0 114.0 113.0 114.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:138.50 stddev:21.19 (15.3%) stddev-sans-first:21.84 19:27:28 INFO - PROCESS | 1646 | Values: 145.0 138.0 139.0 142.0 108.0 107.0 109.0 132.0 173.0 115.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.26 (0.7%) stddev-sans-first:1.33 19:27:28 INFO - PROCESS | 1646 | Values: 183.0 184.0 183.0 182.0 184.0 183.0 181.0 181.0 181.0 184.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:73.70 Median:72.00 stddev:18.03 (25.0%) stddev-sans-first:18.87 19:27:28 INFO - PROCESS | 1646 | Values: 82.0 58.0 62.0 112.0 85.0 82.0 59.0 57.0 82.0 58.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:79.00 stddev:15.51 (19.6%) stddev-sans-first:16.44 19:27:28 INFO - PROCESS | 1646 | Values: 91.0 68.0 106.0 101.0 98.0 99.0 104.0 68.0 68.0 90.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.50 stddev:1.55 (1.8%) stddev-sans-first:1.58 19:27:28 INFO - PROCESS | 1646 | Values: 89.0 85.0 89.0 87.0 88.0 86.0 90.0 87.0 89.0 88.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:94.50 stddev:2.82 (3.0%) stddev-sans-first:2.96 19:27:28 INFO - PROCESS | 1646 | Values: 94.0 94.0 95.0 94.0 95.0 103.0 95.0 94.0 93.0 95.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:82.50 stddev:1.84 (2.2%) stddev-sans-first:1.94 19:27:28 INFO - PROCESS | 1646 | Values: 83.0 82.0 81.0 79.0 82.0 82.0 86.0 84.0 83.0 82.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.50 stddev:1.58 (2.8%) stddev-sans-first:1.39 19:27:28 INFO - PROCESS | 1646 | Values: 53.0 54.0 54.0 54.0 57.0 57.0 56.0 56.0 57.0 57.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:79.70 Median:70.50 stddev:15.78 (22.4%) stddev-sans-first:15.53 19:27:28 INFO - PROCESS | 1646 | Values: 63.0 70.0 72.0 85.0 111.0 102.0 84.0 69.0 71.0 70.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.41 (1.7%) stddev-sans-first:1.50 19:27:28 INFO - PROCESS | 1646 | Values: 82.0 82.0 80.0 80.0 82.0 81.0 82.0 84.0 83.0 84.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:145.00 stddev:14.65 (10.1%) stddev-sans-first:15.53 19:27:28 INFO - PROCESS | 1646 | Values: 145.0 127.0 144.0 150.0 145.0 155.0 140.0 140.0 182.0 136.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.33 19:27:28 INFO - PROCESS | 1646 | Values: 164.0 163.0 162.0 163.0 162.0 162.0 159.0 160.0 161.0 161.0 19:27:28 INFO - PROCESS | 1646 | 19:27:28 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:74.50 stddev:9.29 (12.5%) stddev-sans-first:9.53 19:27:28 INFO - PROCESS | 1646 | Values: 66.0 69.0 84.0 84.0 85.0 80.0 63.0 65.0 65.0 66.0 19:27:28 INFO - PROCESS | 1646 | -------- Summary: end -------- 19:27:28 INFO - PROCESS | 1646 | 19:27:29 INFO - TEST-INFO | 1646: exit 0 19:27:29 INFO - TEST-OK | kraken | took 59073ms 19:27:29 INFO - SUITE-END | took 1176s 19:27:29 INFO - Completed test suite (00:19:36) 19:27:29 INFO - javascript benchmark 19:27:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3451.9816654087044, 3482.7910325380494, 3483.8780642677502, 3491.179572800393, 3537.2041290709594, 5773.48038676519, 5865.002949498585, 5882.441168089024, 5902.085176797593, 5921.73352199151, 5807.73865176067, 5839.036558967776, 5878.382769809173, 5880.823575292738, 5889.057750759879, 5234.450382709818, 5240.082985477546, 5246.5278124968745, 5303.28405665236, 5340.679559226459, 5227.398849132342, 5227.895442091156, 5240.947590524103, 5362.3029006229135, 5371.597130215249, 3890.3775395936655, 5246.449122842104, 5277.70972596507, 5296.09966305729, 5321.760520776555, 5302.893942121155, 5332.840014799563, 5358.651687640291, 5368.785248590052, 5405.486478784509, 5142.7685754140775, 5209.765560549747, 5274.604404669665, 5282.049231138393, 5308.787648494055, 5612.102063669793, 5716.085426331767, 5758.48173664368, 5762.1068734346245, 5777.88444231113, 6057.030875060013, 6098.9695051524905, 6114.541409394314, 6123.112148738453, 6141.263048434216, 6089.482393996515, 6136.263648362181, 6203.038529028008, 6228.750849965996, 6233.844153896143, 5893.44012318829, 5939.109133629903, 5948.9291927452605, 5957.255343082114, 5958.106284057426, 6327.240731112296, 6364.0, 6365.395287447685, 6365.872682546323, 6372.4583410409705, 6053.940560401912, 6076.179715738407, 6109.5112391008615, 6110.419510146529, 6115.969420152871, 6122.733612273343, 6123.8162855114415, 6133.73253493014, 6176.227971503562, 6187.566870319124, 6066.393360663987, 6090.451859332681, 6110.1523298385355, 6111.642934067181, 6119.836419153483, 6041.697915104315, 6106.297775755845, 6111.113888486145, 6120.0, 6158.322584515699, 4909.0672772173175, 4951.876203094879, 4956.4547899731, 4960.454350021495, 4976.751162441936, 4449.555044495589, 4514.616257618073, 4523.615492683159, 4546.931796023062, 4574.245249533789, 5699.430056994267, 5781.479666830005, 5847.06446968483, 5864.70676466175, 5921.3782552831335, 6179.81460556184, 6181.258249010058, 6236.407541283571, 6237.719302631393, 6248.50011999039, 5742.59801813869, 5850.151727999416, 5868.794592189338, 5893.410658934073, 5893.882122357614, 5409.540189083972, 5425.457454254622, 5428.104362780097, 5429.864253393618, 5444.945550544523, 6362.331955144736, 6384.936150638434, 6388.520860935356, 6388.680565971683, 6388.776392826228, 4882.633802464758, 6121.0, 6133.08984587437, 6178.474829639351, 6189.319174890668, 6365.0, 6369.363063693593, 6387.393197646216, 6394.584352017104, 6407.391297826699, 6121.479674227562, 6171.814845554641, 6175.382461753788, 6181.598196117238, 6193.38066193377, 6132.662703551169, 6191.473724733448, 6206.565540412128, 6207.068939659087, 6208.25500939872, 5972.193753843349, 6019.969900150471, 6090.543209259235, 6177.104319873503, 6177.876442471035, 5995.890760209375, 6161.72272247741, 6169.50643948474, 6179.536534759821, 6180.938190618036, 4958.57852082577, 5895.616784908967, 6049.848753781191, 6096.481799047131, 6100.908486372797, 6076.635401875725, 6077.936361136695, 6118.2658081028785, 6129.633877547049, 6155.722992465439, 6061.454469097803, 6065.60573562717, 6091.817245482643, 6110.694465276807, 6117.480014198843], "value": 5726.376046327108, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.26857154268987, 518.1838604198388, 529.198264629087, 539.851540826273, 575.5280669850722, 31444.899428520006, 40612.0, 41897.952551186194, 41906.161876762526, 43585.91035224121, 44026.55973440265, 44506.55493445064, 44643.0, 44657.330140047845, 44676.0, 8029.839403211932, 8175.427720059598, 9722.368046077017, 9737.464439455827, 9746.171575416098, 9681.273904457159, 9785.02149785023, 9795.706128816111, 9800.803983920317, 9808.362456440344, 9785.755356116082, 9791.902080979205, 9804.117629413351, 9808.46053467059, 9820.214382849355, 9732.367396119265, 9783.853242201372, 9802.754931126743, 9805.80388392228, 9822.968588298269, 9580.473073980927, 9651.662191823323, 9653.613855445774, 9664.081912218327, 9671.032896710343, 41985.160296793896, 42227.57772422267, 42270.78864605688, 42300.153996919886, 42325.0, 3245.7078862902217, 3588.4617307403837, 3815.9618403815884, 3868.3810590305698, 4039.7576145431367, 29547.0, 29974.801007959657, 32451.83774081138, 32685.85599504006, 33028.83485582557, 3312.2216279174377, 3325.700686938187, 3334.0997930558856, 3340.799552026862, 3391.084407210064, 520395.0, 524611.0, 524915.0, 525049.0, 525062.0, 36459.4531082034, 37276.813615931744, 63470.0, 65614.67192664006, 71450.0, 37915.62084379176, 38445.807770960964, 38568.42147367792, 38571.0, 38579.0, 15704.607384815243, 15885.444009459614, 15889.364425423084, 15891.205439727968, 15896.046237225572, 13162.736745265232, 13254.138480998705, 13261.535846245335, 13296.601101966762, 13312.134711243738, 7682.462227644011, 8370.455920365157, 8402.957985210034, 8458.323334133378, 8475.957620211859, 3467.653234676512, 3477.165480284764, 3490.2844916791996, 3493.4235851084795, 3527.3474407234744, 940.9529523523796, 963.3834346018554, 1050.4642632257603, 1119.4794420594462, 1139.8119310313705, 29230.0, 30263.697363026087, 30264.08354080485, 30497.08508744697, 30710.385792284476, 735.9227281135404, 1078.9190810689229, 1104.7624760676492, 1114.6154576671036, 1161.7618388230392, 15444.613884652748, 15782.974106683028, 15881.0, 15932.699196052, 16054.197290135446, 657831.0, 667569.6486070252, 668216.0, 668478.0, 668566.0, 59580.404195958356, 60276.698616506634, 60344.79310413855, 60520.48698782478, 60535.69732151311, 1288.7035981724257, 1331.5872079655337, 1387.5143699705225, 1391.9860801391856, 1435.2751860310477, 30483.695163048087, 31918.84040579875, 31925.20186995344, 32155.35689286248, 32816.015519533496, 51101.23348149707, 51582.74208628933, 51720.48279517307, 51763.0, 51777.0, 528950.0, 531583.0, 531651.3417433043, 531724.0, 612944.0, 24441.02235910544, 27269.0, 27426.17721468359, 27858.58212126779, 28626.713732862405, 38170.83812621466, 38654.6134538651, 47145.528544714114, 47974.28038579354, 48386.5161348382, 38573.42139867848, 38897.17433235901, 39433.80283098566, 39698.40452393159, 41032.384514231715, 39280.01799955024, 39325.60674393334, 40462.797686011385, 40534.986625334604, 40583.0, 37763.43354849624, 38118.61881381151, 38219.808900955315, 38508.61491385163, 38574.80712596419, 31202.063938081894, 32413.18967025843, 32526.837365813964, 33261.833690831394, 35058.64941350554, 21666.35000949974, 25423.872880635477, 25942.35144121412, 26023.609645855708, 26471.0], "value": 19103.48765485579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.25167264544905, 391.39724823771394, 396.8035822267977, 405.7078903189702, 417.2427044913482, 18963.0, 21285.467863303424, 21307.934603269852, 21544.13823447064, 21687.566248675015, 21301.25445609404, 21408.0, 21661.566768664616, 21725.0, 21735.347939561798, 5908.350081491032, 5929.080992446177, 6088.604240724361, 6148.723307451175, 6150.2927163376335, 6027.276726792769, 6123.448889599935, 6126.509879209675, 6129.172561704179, 6129.816105516842, 5828.708564571775, 6096.4817990470865, 6164.10620460033, 6187.1956645636, 6192.0, 5964.880702385972, 6132.846678833021, 6142.140100385949, 6174.475169610566, 6178.227721534809, 6050.606710563843, 6072.939270607281, 6077.0, 6091.969540152271, 6096.116063170815, 10986.0, 13660.248686322248, 13712.314384280746, 13879.653008674864, 13922.443102275896, 2182.388931099295, 2207.536417352358, 2288.8397812153157, 2497.1884137655334, 2724.209979106057, 10206.285560010801, 10445.529951152217, 10689.0, 10709.892901070967, 10722.678319650424, 1889.187649310796, 1971.3888694504606, 1977.2189984955862, 1983.3157560641555, 2010.155734591475, 101205.0, 101275.98724012739, 118871.99999999914, 121972.0, 142364.28817855948, 8129.390295727726, 9656.71029869105, 10029.64896228643, 10210.846837297446, 11523.827142592867, 12581.0, 12694.80957785634, 12704.6823829405, 12710.428030738454, 12718.364081795873, 8350.206730360605, 8436.789080273042, 8511.063782983867, 8522.65909363631, 8607.569621518898, 8529.701460448854, 8680.392372533988, 8721.30229581632, 8877.511736854534, 8943.3739638226, 3586.8385922633543, 3830.8276127574327, 3989.182217645434, 3989.5412027617194, 4084.571120032354, 1724.025925352172, 1903.9524011899814, 1976.443893773592, 2019.515316324101, 2019.7374341335533, 898.9527200811112, 929.809389075238, 976.9853452198223, 979.6816034788723, 1000.3397757480174, 17678.29286828538, 21663.45841353979, 21797.019134139002, 21802.0, 21915.890420547796, 936.3773090894479, 943.6932996776076, 958.6273971919583, 963.2727290895469, 1027.6814187601867, 10151.680281563496, 10689.0, 10931.344119352705, 11462.083033357312, 11603.245789023686, 573505.0, 574433.0, 574798.0, 579410.0, 597568.0, 105091.47454262679, 125801.0, 126507.0, 126646.0, 132658.67341326462, 970.1947383671536, 986.1124987511297, 996.2478328861663, 1001.7645853224486, 1005.8440941654055, 17619.119044048002, 18308.90845545817, 18984.43046708601, 20023.79857208572, 20070.297539586045, 55410.0, 56075.0, 56392.15411768909, 56782.86434271209, 58021.0, 78615.60692196502, 79328.0, 80108.19891801008, 81362.0, 82018.0, 7397.038385009914, 7594.8101297468, 7739.961300193463, 7869.803254918673, 8226.0, 11901.761964760482, 13238.602841914759, 13341.866581334063, 13643.727125457634, 13656.590302290948, 11589.7102572433, 11624.418779061183, 11712.648620541397, 11805.881941180478, 11868.82196767032, 11401.372924489233, 11477.598284060017, 11664.475098620753, 11742.765144697229, 11811.409429528661, 11578.536858525564, 11782.17524773292, 11798.587049453228, 11976.28142311464, 12065.396730163282, 7584.233507262518, 7785.610719464117, 7798.025246844145, 7809.687612495437, 8022.9598852005365, 11288.0, 11756.353400563052, 11786.705332366759, 11885.346305953255, 12104.0], "value": 9499.311896777712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.5209200733739, 1363.5704753002803, 1478.9778153327702, 1806.9909650451746, 1837.4303965770612, 8033.03603567572, 8451.957740211306, 8452.154784521545, 8455.577221138941, 8463.661453541867, 7610.619469026554, 7829.334506566948, 8235.094139644634, 8391.70629027984, 8418.32653387729, 2372.655964885095, 2405.987970060156, 2409.3976505873534, 2411.9397015074587, 2417.4319035026756, 2407.0, 2413.4690368118986, 2439.5730747119183, 2443.1082654831034, 2444.4133407982044, 1889.905504724765, 2386.642003699442, 2389.247387073075, 2414.8792560372, 2417.7340492545895, 2374.750651181618, 2378.7502312257225, 2391.8280042778915, 2399.2682231919257, 2400.3999000249937, 2404.5311164322966, 2404.8797560121925, 2425.0178677635586, 2426.8301218914685, 2429.4169399344205, 8606.483610983361, 8637.0, 8647.783805404852, 8658.610362533638, 8683.739487815375, 5129.153689641204, 5292.814751483718, 5296.841094767163, 5299.417064122943, 5302.3637163540625, 3375.932481350359, 3389.915252118692, 3466.9826650866585, 3519.7360197985254, 3614.313280476701, 1054.6256079091966, 1072.4316112460408, 1094.0919037199185, 1105.9557617695282, 1112.3492756737319, 11141.777164456666, 11185.944070279678, 11199.440027998568, 11213.495392707347, 11216.66350009501, 4554.863354099382, 4704.623630109583, 4792.329073929653, 4792.400949881265, 4862.927056094161, 9677.419354838732, 9687.0, 9698.854517182248, 9700.0, 9702.320837541445, 5335.413104558495, 5340.06548853949, 5340.546053585489, 5340.759665815048, 5342.0, 4441.222786012435, 4452.265376212953, 4861.756912154378, 4915.827946021872, 4917.360743103373, 3437.8281085945605, 3923.588023257574, 3945.4870866787132, 3962.2867883781196, 4054.4526488924207, 1196.0192642033448, 1298.2599918046812, 1302.3358087375318, 1311.1215485624655, 1317.9802302965463, 821.4865708931918, 924.1082355526949, 924.7595625137512, 929.3076657889916, 951.167728237792, 5805.954928112896, 5847.239858818326, 6012.909806352908, 6075.301340345828, 6257.311695713468, 927.4249965021595, 936.321167153808, 952.1858810716876, 960.2270172511056, 997.7356000659831, 3654.7258955578436, 3848.0, 3902.414637804295, 3965.821538030738, 4002.239574480839, 10033.548490317808, 10203.183745300357, 10306.227032972558, 10310.278280520291, 10348.586056557804, 10086.949565252127, 10160.847587286196, 10162.288639795144, 10411.53148108337, 10418.739531511621, 7970.163132871081, 8035.437519373705, 8108.270255676899, 8192.18078192176, 8196.83606327882, 4647.326137710081, 5659.830205093854, 5680.801171958961, 5696.20253164549, 5877.382874798084, 9374.343795934492, 9454.480003599869, 9489.0, 9560.474173920224, 9601.951990240004, 9640.228781697308, 9676.516174191403, 9761.609535618496, 9795.9020409795, 9877.950610246902, 6455.289918109098, 6635.734570617121, 6667.233268174028, 6687.0, 6893.862122757617, 6842.794716158523, 7750.806229844299, 7815.687372505036, 7820.569868657051, 7942.126366099609, 7213.783586492414, 7301.598412087386, 7327.340539351484, 7339.559626422431, 7472.701091956261, 7151.141862976476, 7163.426925845815, 7215.170255420484, 7359.668814903449, 7374.041374621265, 6707.3628005339415, 6871.484638652021, 6874.518783685294, 6877.243503214742, 6890.000949862342, 4845.466998630078, 4884.242942343943, 4923.064617722621, 5010.148274793367, 5016.673916195436, 4811.566958973569, 4912.70523768575, 4930.112579735682, 5046.646734728533, 5117.718525481134], "value": 4513.058179224738, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.7008546581617, 308.82551358482453, 314.9606299212598, 322.1045493527993, 322.4791960983013, 5070.416902056256, 5185.118529849925, 5188.558972487338, 5194.636375453715, 5215.556677682392, 4136.689748268876, 4766.903612169203, 4783.8665673983505, 5157.0, 5187.429382767892, 3469.930601387971, 3982.2234664240486, 4038.4548086008454, 4040.5353384360883, 4055.513338399396, 3381.0871064812486, 3635.78185308881, 3722.7156630962277, 4009.5990400959963, 4069.369247766601, 3465.376232278189, 3477.5479187705564, 3893.279743247508, 3996.841705479038, 4036.3652720648183, 3621.4929909812386, 3927.666148377377, 3976.681865450757, 3983.5618082010956, 4017.27689015977, 2862.77097832175, 3037.9088627340993, 3133.373325334919, 3254.4304746669236, 3586.8206589670413, 4168.645665118469, 4570.497245303014, 5004.924926126111, 5061.443241243497, 5139.8458046258675, 4590.288505281686, 4618.930716039262, 4651.279051746951, 4654.488006319302, 4673.0, 4337.262665346899, 4736.8578942631775, 5252.684838909678, 5429.239906413105, 5499.752511137009, 3573.3925232710503, 3693.538307711536, 3933.272344616255, 3944.6055394460614, 3945.6448919597374, 4745.762711864393, 5267.683938963636, 5658.0479734492355, 5748.367679555246, 5749.269097178891, 3582.6775590197008, 3591.8204089795404, 3679.4112941929698, 3800.7529510582276, 4032.778197199182, 3829.7319187656594, 4006.59934006597, 4029.81865816039, 4067.9796601016806, 4074.7351422157467, 4013.518377794683, 4602.769861506911, 4611.9077618447445, 4633.235516139799, 4641.141388843007, 4588.38056862326, 4871.2206047032305, 5249.816256431083, 5515.283013208257, 5553.222548843165, 1255.32212605194, 1261.4701825233424, 1291.2768849444342, 1310.541310541303, 1311.5212947274367, 782.8003859015914, 894.5124906925611, 915.4507295622573, 923.5474617437408, 934.9108288843557, 4015.951864549101, 4122.670186385082, 4779.283107533898, 4804.51060171348, 4888.828890988798, 5181.4351895811815, 5189.6107791915, 5221.6083793715625, 5236.581073514109, 5247.239150323182, 4108.77401742901, 4501.572350626685, 4711.623070154379, 4810.95189048112, 4834.5890599299455, 2434.9026038958245, 2497.8626175560516, 2621.252942911299, 2829.618001569803, 2849.28767808048, 4472.74763066342, 4486.59620634138, 5299.417064122943, 5486.341639003345, 5608.747606357723, 4860.392450943632, 5114.0, 5149.613778966593, 5441.319835020622, 5484.890302194013, 5017.322661440732, 5803.651780893244, 5807.709614519257, 5835.708214589338, 5867.70661466925, 4748.501407352178, 4920.311156438173, 5591.692456914909, 5642.746076426489, 5685.232493613309, 4615.399998000238, 5264.921026184534, 5614.5789065821045, 5654.434556544313, 5664.971675141598, 5910.911336330045, 5930.673812940329, 5930.975202646595, 5938.940610593839, 5967.6121052131475, 3891.9416208756325, 3917.7845218513257, 3932.761180228333, 3944.349182384989, 3969.761814291152, 4980.626453015966, 5081.314022606901, 5485.670859748428, 5720.713964301852, 5775.971120144372, 4864.391951006124, 5054.711048682562, 5158.38099428071, 5517.255170552085, 5550.8057217997175, 4827.493113223061, 5156.5616922562, 5471.179323101566, 5505.6696598204235, 5531.391546929754, 4421.425214722066, 4863.862808488576, 5092.3889133302755, 5146.867689108391, 5359.490848369399, 4844.442889067803, 5376.392404747395, 5540.695261760642, 5596.908602822574, 5620.381758006698, 4056.0265536271672, 5260.973695131653, 5456.61803673739, 5537.390887002507, 5541.528970037431], "value": 3948.9044039119067, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.6579241963857, 729.7591794707747, 745.2361329637125, 781.1251398433755, 819.274941676616, 15065.397384104637, 15690.293936772845, 15773.921130394361, 15775.053496790186, 15785.447509337175, 13995.370208340624, 14118.858811411883, 14119.858801411983, 14152.29238538074, 14170.50403235887, 706.8303607134302, 727.3163226567036, 732.2640746050212, 858.3776761847657, 876.4040452492303, 714.9142102947653, 718.1023720349563, 718.1525799556521, 851.3870013590205, 881.1276835932445, 901.603294550399, 908.2143945487139, 914.2868562521244, 917.7889085510336, 918.3066784577635, 910.8269428808505, 911.5806728904712, 912.0833562269943, 912.4434095201922, 912.5710915869531, 664.9667516624149, 671.9193696756372, 673.3266733266734, 675.3145557259386, 675.7297081167573, 14118.788218176736, 14239.857601423957, 14267.500637477639, 14278.143311401349, 15174.089554626758, 13954.372053257628, 14329.49846755369, 14380.92809535956, 14436.855631443656, 14537.345819438046, 8897.644094236222, 12124.696882577919, 12174.330411827346, 12483.063770217179, 12723.872761272361, 4414.271645178574, 4536.160810250081, 4720.716756994591, 4788.114198873185, 4795.448523419782, 96913.51543242238, 97098.0, 99831.50084249605, 100593.4910976336, 102633.48683256537, 8747.65009399617, 10501.264911456125, 10703.83944240837, 10727.40999245049, 11014.779704405866, 20086.09612567438, 20268.79731202669, 20276.188952442033, 20281.391558253275, 20316.69524957127, 7473.588952607659, 7661.50200236994, 7920.168382319889, 7933.048034235929, 7934.563599001995, 4326.783660817009, 4360.171567402247, 4363.912721745611, 4554.521775213621, 4557.726536407826, 3348.8158151301427, 3376.5610470638658, 3402.795832250073, 3437.2609888874013, 3466.3587236361354, 647.2782847125516, 648.3872740260502, 652.9183852018498, 653.9542232043711, 663.7112855907695, 589.602018637418, 607.1287702147432, 614.2371394098875, 630.130420020369, 633.1863555331469, 8509.489430634181, 8689.826203475895, 8703.912960870437, 8935.776605584912, 8991.640334386551, 596.83885350955, 600.9789657361971, 605.8969975104243, 624.6689254695019, 637.4995628431751, 3689.7786132832116, 4340.52254252032, 4370.104128653682, 4389.473263208435, 4481.0, 106859.93140068655, 108510.0, 109286.3607045879, 109630.45184774185, 116696.0, 70283.2971670287, 76960.23039769531, 87400.5629971846, 101517.0, 106266.0, 84214.0, 84458.0, 85308.0, 86193.0, 88347.55826220827, 8495.235428811437, 8521.957390213009, 8552.572371381282, 8628.266597339045, 8660.047394786443, 51716.18993335215, 52123.696907577614, 52530.73734631302, 55586.0, 59504.70247648734, 54419.18371224514, 57009.0, 62842.0, 72725.27274727185, 73983.6300818514, 10718.0, 12445.0, 12622.810657840324, 12926.96584273237, 13043.673908152372, 11042.0, 14382.640433988816, 14471.462343802903, 14892.925535372255, 15019.0, 12970.740585188432, 13839.861601383856, 14028.018038737191, 14317.57047288583, 14318.856811431753, 13409.865901341253, 13527.053106282467, 13617.79573306421, 13756.0, 14140.646483837987, 10767.153480337362, 13077.607671769862, 13141.145825521311, 13298.933505332798, 13333.066685332322, 11101.085282138498, 11264.549418023187, 11673.533058677558, 11876.703082423008, 12069.637910862688, 11390.202685811913, 11399.373034483184, 11616.767664646492, 11638.76722465529, 11655.30068195911], "value": 7405.011222193478, "unit": "score"}], "name": "dromaeo_css", "value": 7181.260894168155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 113.0, 112.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 138.0, 139.0, 142.0, 108.0, 107.0, 109.0, 132.0, 173.0, 115.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 182.0, 184.0, 183.0, 181.0, 181.0, 181.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 62.0, 112.0, 85.0, 82.0, 59.0, 57.0, 82.0, 58.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 106.0, 101.0, 98.0, 99.0, 104.0, 68.0, 68.0, 90.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 87.0, 88.0, 86.0, 90.0, 87.0, 89.0, 88.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 103.0, 95.0, 94.0, 93.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 81.0, 79.0, 82.0, 82.0, 86.0, 84.0, 83.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 72.0, 85.0, 111.0, 102.0, 84.0, 69.0, 71.0, 70.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 80.0, 80.0, 82.0, 81.0, 82.0, 84.0, 83.0, 84.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 127.0, 144.0, 150.0, 145.0, 155.0, 140.0, 140.0, 182.0, 136.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 162.0, 162.0, 159.0, 160.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 84.0, 84.0, 85.0, 80.0, 63.0, 65.0, 65.0, 66.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1452.1000000000004, "alertThreshold": 2.0}]} 19:27:29 INFO - Return code: 0 19:27:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:27:29 INFO - # TBPL SUCCESS # 19:27:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:27:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:27:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:27:29 INFO - 2017-02-02 19:27:29.630 screenresolution[1650:9724] starting screenresolution argv=screenresolution get 19:27:29 INFO - 2017-02-02 19:27:29.633 screenresolution[1650:9724] Display 0: 1600x1200x32@60 19:27:29 INFO - 2017-02-02 19:27:29.639 screenresolution[1651:9727] starting screenresolution argv=screenresolution list 19:27:29 INFO - Available Modes on Display 0 19:27:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:27:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:27:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:27:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:27:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:27:29 INFO - Intel Iris: 19:27:29 INFO - Chipset Model: Intel Iris 19:27:29 INFO - Type: GPU 19:27:29 INFO - Bus: Built-In 19:27:29 INFO - VRAM (Dynamic, Max): 1536 MB 19:27:29 INFO - Vendor: Intel (0x8086) 19:27:29 INFO - Device ID: 0x0a2e 19:27:29 INFO - Revision ID: 0x0009 19:27:29 INFO - Displays: 19:27:29 INFO - Display: 19:27:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:27:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:27:29 INFO - Display Serial Number: 1600x1200 60 19:27:29 INFO - Main Display: Yes 19:27:29 INFO - Mirror: Off 19:27:29 INFO - Online: Yes 19:27:29 INFO - Rotation: Supported 19:27:29 INFO - Return code: 0 19:27:29 INFO - Running post-action listener: _resource_record_post_action 19:27:29 INFO - [mozharness: 2017-02-03 03:27:29.886194Z] Finished run-tests step (success) 19:27:29 INFO - Running post-run listener: _resource_record_post_run 19:27:29 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 36852736; Write bytes: 498882048; Read time: 240; Write time: 1583 19:27:29 INFO - TinderboxPrint: CPU usage
53.4% 19:27:29 INFO - TinderboxPrint: I/O read bytes / time
36,852,736 / 240 19:27:29 INFO - TinderboxPrint: I/O write bytes / time
498,882,048 / 1,583 19:27:29 INFO - TinderboxPrint: CPU idle
2,236.6 (46.6%) 19:27:29 INFO - TinderboxPrint: CPU system
960.0 (20.0%) 19:27:29 INFO - TinderboxPrint: CPU user
1,601.1 (33.4%) 19:27:29 INFO - TinderboxPrint: Swap in / out
228,114,432 / 0 19:27:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 179028480; Write bytes: 174501888; Read time: 16698; Write time: 386 19:27:29 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 35914752; Write bytes: 306648576; Read time: 227; Write time: 1144 19:27:30 INFO - Running post-run listener: _upload_blobber_files 19:27:30 INFO - Blob upload gear active. 19:27:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:27:30 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 19:27:30 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'] 19:27:30 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 19:27:30 INFO - (blobuploader) - INFO - Open directory for files ... 19:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:31 INFO - (blobuploader) - INFO - Done attempting. 19:27:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:27:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:27:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:32 INFO - (blobuploader) - INFO - Done attempting. 19:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:27:34 INFO - (blobuploader) - INFO - Done attempting. 19:27:34 INFO - (blobuploader) - INFO - Iteration through files over. 19:27:34 INFO - Return code: 0 19:27:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:27:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:27:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32678130bb3cc48a41f22dc0cf51b32929d5440f313dcabbe3f72b8e0fc23c450c3fb3be60063aaf4a938f46163997ce7ada4cc692d599f33153b07bf5c12ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3c9ceb5f93e69e5e911ac6a4263a547ac1692adb4fa31ee038481bd4bab29817d9dae245353abeb7a0db424a67eb19130dbbb8d936f67d634264df22ded0933", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c196be382bb8e9a86f6f6e4fdf26b4d656df5240e7479756e0be6360e5e18bdfc2d0de70e8ea8931d6cee17d40ad238f5bfbe05ce47ecdaf1d57e7ac174f618"} 19:27:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:27:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:27:34 INFO - Contents: 19:27:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32678130bb3cc48a41f22dc0cf51b32929d5440f313dcabbe3f72b8e0fc23c450c3fb3be60063aaf4a938f46163997ce7ada4cc692d599f33153b07bf5c12ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3c9ceb5f93e69e5e911ac6a4263a547ac1692adb4fa31ee038481bd4bab29817d9dae245353abeb7a0db424a67eb19130dbbb8d936f67d634264df22ded0933", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c196be382bb8e9a86f6f6e4fdf26b4d656df5240e7479756e0be6360e5e18bdfc2d0de70e8ea8931d6cee17d40ad238f5bfbe05ce47ecdaf1d57e7ac174f618"} 19:27:34 INFO - Running post-run listener: copy_logs_to_upload_dir 19:27:34 INFO - Copying logs to upload dir... 19:27:34 INFO - mkdir: /builds/slave/test/build/upload/logs 19:27:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.449115 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-02 19:27:34.977027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 19:27:34.983739) ========= 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.1xHgPrkgJC/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.sW75qCNwPU/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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/32678130bb3cc48a41f22dc0cf51b32929d5440f313dcabbe3f72b8e0fc23c450c3fb3be60063aaf4a938f46163997ce7ada4cc692d599f33153b07bf5c12ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3c9ceb5f93e69e5e911ac6a4263a547ac1692adb4fa31ee038481bd4bab29817d9dae245353abeb7a0db424a67eb19130dbbb8d936f67d634264df22ded0933", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c196be382bb8e9a86f6f6e4fdf26b4d656df5240e7479756e0be6360e5e18bdfc2d0de70e8ea8931d6cee17d40ad238f5bfbe05ce47ecdaf1d57e7ac174f618"} build_url:https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011109 build_url: 'https://queue.taskcluster.net/v1/task/frWoWlGOTAuWMPQKoBwF3Q/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/32678130bb3cc48a41f22dc0cf51b32929d5440f313dcabbe3f72b8e0fc23c450c3fb3be60063aaf4a938f46163997ce7ada4cc692d599f33153b07bf5c12ce0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3c9ceb5f93e69e5e911ac6a4263a547ac1692adb4fa31ee038481bd4bab29817d9dae245353abeb7a0db424a67eb19130dbbb8d936f67d634264df22ded0933", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c196be382bb8e9a86f6f6e4fdf26b4d656df5240e7479756e0be6360e5e18bdfc2d0de70e8ea8931d6cee17d40ad238f5bfbe05ce47ecdaf1d57e7ac174f618"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 19:27:35.022800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 19:27:35.023238) ========= 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.1xHgPrkgJC/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.sW75qCNwPU/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.005179 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 19:27:35.078334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 19:27:35.078758) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 19:27:35.079154) ========= ========= Total master_lag: 0.71 =========