builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0232 starttime: 1484197701.84 results: success (0) buildid: 20170111185517 builduid: fec7e01ade7e4235be69236676bb3990 revision: 1abb4b193740653f1161d86f38dbb79287e7d69b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:21.844813) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:21.845602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:21.846358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:21.881818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:21.882527) ========= 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.j60vKIJHxx/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.SMpe8n6kY5/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-11 21:08:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2017-01-11 21:08:22 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.642385 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:22.551036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:22.551415) ========= 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.j60vKIJHxx/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.SMpe8n6kY5/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.031370 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:22.605539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 21:08:22.605945) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1abb4b193740653f1161d86f38dbb79287e7d69b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1abb4b193740653f1161d86f38dbb79287e7d69b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j60vKIJHxx/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.SMpe8n6kY5/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-11 21:08:22,709 truncating revision to first 12 chars 2017-01-11 21:08:22,709 Setting DEBUG logging. 2017-01-11 21:08:22,709 attempt 1/10 2017-01-11 21:08:22,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1abb4b193740?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 21:08:23,858 unpacking tar archive at: mozilla-aurora-1abb4b193740/testing/mozharness/ program finished with exit code 0 elapsedTime=1.419003 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 21:08:24.052327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:24.053048) ========= script_repo_revision: 1abb4b193740653f1161d86f38dbb79287e7d69b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:24.054058) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:24.054752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 21:08:24.076579) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-11 21:08:24.077204) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j60vKIJHxx/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.SMpe8n6kY5/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:08:24 INFO - MultiFileLogger online at 20170111 21:08:24 in /builds/slave/test 21:08:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:08:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:08:24 INFO - {'append_to_log': False, 21:08:24 INFO - 'base_work_dir': '/builds/slave/test', 21:08:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:08:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:08:24 INFO - 'branch': 'Mozilla-Aurora', 21:08:24 INFO - 'buildbot_json_path': 'buildprops.json', 21:08:24 INFO - 'config_files': ('talos/mac_config.py',), 21:08:24 INFO - 'default_actions': ('clobber', 21:08:24 INFO - 'read-buildbot-config', 21:08:24 INFO - 'download-and-extract', 21:08:24 INFO - 'populate-webroot', 21:08:24 INFO - 'create-virtualenv', 21:08:24 INFO - 'install', 21:08:24 INFO - 'run-tests'), 21:08:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:08:24 INFO - 'download_minidump_stackwalk': True, 21:08:24 INFO - 'download_symbols': 'ondemand', 21:08:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:08:24 INFO - 'tooltool.py': '/tools/tooltool.py', 21:08:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:08:24 INFO - '/tools/misc-python/virtualenv.py')}, 21:08:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:08:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:08:24 INFO - 'installer_path': 'installer.exe', 21:08:24 INFO - 'log_level': 'info', 21:08:24 INFO - 'log_name': 'talos', 21:08:24 INFO - 'log_to_console': True, 21:08:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:08:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:08:24 INFO - 'opt_config_files': (), 21:08:24 INFO - 'pip_index': False, 21:08:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:08:24 INFO - 'cmd': ('bash', 21:08:24 INFO - '-c', 21:08:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:08:24 INFO - 'enabled': True, 21:08:24 INFO - 'halt_on_failure': False, 21:08:24 INFO - 'name': 'check_screen_resolution'},), 21:08:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:08:24 INFO - 'cmd': ('bash', 21:08:24 INFO - '-c', 21:08:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:08:24 INFO - 'enabled': True, 21:08:24 INFO - 'halt_on_failure': False, 21:08:24 INFO - 'name': 'check_screen_resolution'},), 21:08:24 INFO - 'run_cmd_checks_enabled': True, 21:08:24 INFO - 'sps_profile': False, 21:08:24 INFO - 'sps_profile_interval': 0, 21:08:24 INFO - 'suite': 'dromaeojs', 21:08:24 INFO - 'system_bits': '32', 21:08:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:08:24 INFO - 'title': 't-yosemite-r7-0232', 21:08:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:08:24 INFO - 'use_talos_json': True, 21:08:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:08:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:08:24 INFO - 'work_dir': 'build'} 21:08:24 INFO - [mozharness: 2017-01-12 05:08:24.288839Z] Running clobber step. 21:08:24 INFO - Running pre-action listener: _resource_record_pre_action 21:08:24 INFO - Running main action method: clobber 21:08:24 INFO - rmtree: /builds/slave/test/build 21:08:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:08:26 INFO - Running post-action listener: _resource_record_post_action 21:08:26 INFO - [mozharness: 2017-01-12 05:08:26.589111Z] Finished clobber step (success) 21:08:26 INFO - [mozharness: 2017-01-12 05:08:26.589361Z] Running read-buildbot-config step. 21:08:26 INFO - Running pre-action listener: _resource_record_pre_action 21:08:26 INFO - Running main action method: read_buildbot_config 21:08:26 INFO - Using buildbot properties: 21:08:26 INFO - { 21:08:26 INFO - "project": "", 21:08:26 INFO - "product": "firefox", 21:08:26 INFO - "script_repo_revision": "production", 21:08:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:08:26 INFO - "repository": "", 21:08:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:08:26 INFO - "buildid": "20170111185517", 21:08:26 INFO - "pgo_build": "False", 21:08:26 INFO - "basedir": "/builds/slave/test", 21:08:26 INFO - "buildnumber": 64, 21:08:26 INFO - "slavename": "t-yosemite-r7-0232", 21:08:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:08:26 INFO - "platform": "yosemite_r7", 21:08:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:08:26 INFO - "branch": "mozilla-aurora", 21:08:26 INFO - "repo_path": "releases/mozilla-aurora", 21:08:26 INFO - "revision": "1abb4b193740653f1161d86f38dbb79287e7d69b", 21:08:26 INFO - "stage_platform": "macosx64", 21:08:26 INFO - "builduid": "fec7e01ade7e4235be69236676bb3990", 21:08:26 INFO - "slavebuilddir": "test" 21:08:26 INFO - } 21:08:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 21:08:26 INFO - Running post-action listener: _resource_record_post_action 21:08:26 INFO - [mozharness: 2017-01-12 05:08:26.595189Z] Finished read-buildbot-config step (success) 21:08:26 INFO - [mozharness: 2017-01-12 05:08:26.595425Z] Running download-and-extract step. 21:08:26 INFO - Running pre-action listener: _resource_record_pre_action 21:08:26 INFO - Running main action method: download_and_extract 21:08:26 INFO - mkdir: /builds/slave/test/build/tests 21:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:26 INFO - trying https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 21:08:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 21:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 21:08:27 INFO - Downloaded 1199 bytes. 21:08:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 21:08:27 INFO - Using the following test package requirements: 21:08:27 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 21:08:27 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 21:08:27 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 21:08:27 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'jsshell-mac.zip'], 21:08:27 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 21:08:27 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 21:08:27 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 21:08:27 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 21:08:27 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 21:08:27 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 21:08:27 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 21:08:27 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:08:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 21:08:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:08:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 21:08:28 INFO - Http code: 200 21:08:28 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 21:08:28 INFO - x-amz-cf-id: fuZGIWG7HsiLeAZujJsfAMnc3Aeukde40AvHO4DGwYaZMYaukIZXpg== 21:08:28 INFO - x-amz-version-id: 9XBmKlQ7HSwfEl66AeeHAzIwML.VwKca 21:08:28 INFO - Expected file size: 16272958 21:08:28 INFO - Obtained file size: 16272958 21:08:35 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 21:08:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 21:08:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:08:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 21:08:36 INFO - Http code: 200 21:08:36 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 21:08:36 INFO - x-amz-cf-id: I7BS8kd4i4QXH049T_iAMiEynedTyvzliTMp_O0qzCp8IZtwPKgVGg== 21:08:36 INFO - x-amz-version-id: 9XBmKlQ7HSwfEl66AeeHAzIwML.VwKca 21:08:36 INFO - Expected file size: 16272958 21:08:36 INFO - Obtained file size: 16272958 21:08:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 21:08:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:08:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 21:08:43 INFO - Http code: 200 21:08:43 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 21:08:43 INFO - x-amz-cf-id: _ELUsK_d_ZuYSj9LM7nQp2qJjB92DU_1aiob45wIgcw6q0sN6q-UCQ== 21:08:43 INFO - x-amz-version-id: 974VEB7Uehvmjvl6m2xujQNkTwrvuNjU 21:08:44 INFO - Expected file size: 14409038 21:08:44 INFO - Obtained file size: 14409038 21:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:44 INFO - trying https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 21:08:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 21:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 21:08:47 INFO - Downloaded 109963288 bytes. 21:08:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 21:08:47 INFO - mkdir: /builds/slave/test/properties 21:08:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:08:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:08:47 INFO - Contents: 21:08:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 21:08:48 INFO - Running post-action listener: _resource_record_post_action 21:08:48 INFO - Running post-action listener: set_extra_try_arguments 21:08:48 INFO - [mozharness: 2017-01-12 05:08:48.109983Z] Finished download-and-extract step (success) 21:08:48 INFO - [mozharness: 2017-01-12 05:08:48.110120Z] Running populate-webroot step. 21:08:48 INFO - Running pre-action listener: _resource_record_pre_action 21:08:48 INFO - Running main action method: populate_webroot 21:08:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:08:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:08:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:08:48 INFO - '--tppagecycles', 21:08:48 INFO - '7'], 21:08:48 INFO - 'tests': ['tsvgm']}}, 21:08:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:08:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:08:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:08:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:08:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['damp', 'tps']}, 21:08:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'tests': ['damp', 'tps']}, 21:08:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['dromaeo_dom']}, 21:08:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:08:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['basic_compositor_video']}, 21:08:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:08:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['a11yr', 21:08:48 INFO - 'ts_paint', 21:08:48 INFO - 'tpaint', 21:08:48 INFO - 'sessionrestore', 21:08:48 INFO - 'sessionrestore_no_auto_restore', 21:08:48 INFO - 'tabpaint']}, 21:08:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:08:48 INFO - 'ts_paint', 21:08:48 INFO - 'tpaint', 21:08:48 INFO - 'sessionrestore', 21:08:48 INFO - 'sessionrestore_no_auto_restore', 21:08:48 INFO - 'tabpaint']}, 21:08:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:08:48 INFO - 'ts_paint', 21:08:48 INFO - 'tpaint', 21:08:48 INFO - 'sessionrestore', 21:08:48 INFO - 'sessionrestore_no_auto_restore', 21:08:48 INFO - 'tabpaint']}, 21:08:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:08:48 INFO - 'ts_paint', 21:08:48 INFO - 'tpaint', 21:08:48 INFO - 'sessionrestore', 21:08:48 INFO - 'sessionrestore_no_auto_restore', 21:08:48 INFO - 'tabpaint']}, 21:08:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['a11yr', 21:08:48 INFO - 'ts_paint', 21:08:48 INFO - 'tpaint', 21:08:48 INFO - 'sessionrestore', 21:08:48 INFO - 'sessionrestore_no_auto_restore', 21:08:48 INFO - 'tabpaint']}, 21:08:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['a11yr', 21:08:48 INFO - 'ts_paint', 21:08:48 INFO - 'tpaint', 21:08:48 INFO - 'sessionrestore', 21:08:48 INFO - 'sessionrestore_no_auto_restore', 21:08:48 INFO - 'tabpaint']}, 21:08:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['tsvgx', 21:08:48 INFO - 'tsvgr_opacity', 21:08:48 INFO - 'tart', 21:08:48 INFO - 'tscrollx', 21:08:48 INFO - 'cart']}, 21:08:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:08:48 INFO - 'tsvgr_opacity', 21:08:48 INFO - 'tart', 21:08:48 INFO - 'tscrollx', 21:08:48 INFO - 'cart']}, 21:08:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'talos_options': ['--disable-e10s'], 21:08:48 INFO - 'tests': ['tp5o']}, 21:08:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'tests': ['tp5o']}, 21:08:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'talos_options': ['--disable-e10s', 21:08:48 INFO - '--xperf_path', 21:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:48 INFO - 'tests': ['tp5n']}, 21:08:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:48 INFO - 'talos_options': ['--xperf_path', 21:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:48 INFO - 'tests': ['tp5n']}}, 21:08:48 INFO - 'talos.zip': {'path': '', 21:08:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:08:48 INFO - Running post-action listener: _resource_record_post_action 21:08:48 INFO - [mozharness: 2017-01-12 05:08:48.128536Z] Finished populate-webroot step (success) 21:08:48 INFO - [mozharness: 2017-01-12 05:08:48.128642Z] Running create-virtualenv step. 21:08:48 INFO - Running pre-action listener: _resource_record_pre_action 21:08:48 INFO - Running main action method: create_virtualenv 21:08:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:08:48 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 21:08:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:08:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:08:48 INFO - Using real prefix '/tools/python27' 21:08:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:08:48 INFO - Installing distribute.............................................................................................................................................................................................done. 21:08:51 INFO - Installing pip.................done. 21:08:51 INFO - Return code: 0 21:08:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:08:52 INFO - Reading from file tmpfile_stdout 21:08:52 INFO - Output received: 21:08:52 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) 21:08:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:52 INFO - 'HOME': '/Users/cltbld', 21:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:52 INFO - 'LOGNAME': 'cltbld', 21:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:52 INFO - 'MOZ_NO_REMOTE': '1', 21:08:52 INFO - 'NO_EM_RESTART': '1', 21:08:52 INFO - 'PAGER': '/bin/cat', 21:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:52 INFO - 'PWD': '/builds/slave/test', 21:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:52 INFO - 'SHELL': '/bin/bash', 21:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:08:52 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:52 INFO - 'USER': 'cltbld', 21:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:52 INFO - 'XPC_FLAGS': '0x0', 21:08:52 INFO - 'XPC_SERVICE_NAME': '0', 21:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:08:52 INFO - Cleaning up... 21:08:52 INFO - Return code: 0 21:08:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:08: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')]} 21:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08: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')]} 21:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:52 INFO - 'HOME': '/Users/cltbld', 21:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:52 INFO - 'LOGNAME': 'cltbld', 21:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:52 INFO - 'MOZ_NO_REMOTE': '1', 21:08:52 INFO - 'NO_EM_RESTART': '1', 21:08:52 INFO - 'PAGER': '/bin/cat', 21:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:52 INFO - 'PWD': '/builds/slave/test', 21:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:52 INFO - 'SHELL': '/bin/bash', 21:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:08:52 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:52 INFO - 'USER': 'cltbld', 21:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:52 INFO - 'XPC_FLAGS': '0x0', 21:08:52 INFO - 'XPC_SERVICE_NAME': '0', 21:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:52 INFO - Downloading/unpacking psutil>=3.1.1 21:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:08:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:56 INFO - Installing collected packages: psutil 21:08:56 INFO - Running setup.py install for psutil 21:08:56 INFO - building 'psutil._psutil_osx' extension 21:08:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:08:57 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 21:08:57 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 21:08:57 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 21:08:57 INFO - building 'psutil._psutil_posix' extension 21:08:57 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 21:08:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:08:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:08:57 INFO - ^ 21:08:57 INFO - 1 warning generated. 21:08:57 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 21:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:57 INFO - Successfully installed psutil 21:08:57 INFO - Cleaning up... 21:08:57 INFO - Return code: 0 21:08:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:08:57 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')]} 21:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:57 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')]} 21:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:57 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:08:57 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 21:08:57 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 21:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:57 INFO - 'HOME': '/Users/cltbld', 21:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:57 INFO - 'LOGNAME': 'cltbld', 21:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:57 INFO - 'MOZ_NO_REMOTE': '1', 21:08:57 INFO - 'NO_EM_RESTART': '1', 21:08:57 INFO - 'PAGER': '/bin/cat', 21:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:57 INFO - 'PWD': '/builds/slave/test', 21:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:57 INFO - 'SHELL': '/bin/bash', 21:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:08:57 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:57 INFO - 'USER': 'cltbld', 21:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:57 INFO - 'XPC_FLAGS': '0x0', 21:08:57 INFO - 'XPC_SERVICE_NAME': '0', 21:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:08:58 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 21:08:58 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 21:08:58 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 21:08:58 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 21:08:58 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 21:08:58 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 21:09:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:09:01 INFO - Installing collected packages: mozsystemmonitor 21:09:01 INFO - Running setup.py install for mozsystemmonitor 21:09:01 INFO - Successfully installed mozsystemmonitor 21:09:01 INFO - Cleaning up... 21:09:01 INFO - Return code: 0 21:09:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:09:01 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')]} 21:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:01 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')]} 21:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:01 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:09:01 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 21:09:01 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 21:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:01 INFO - 'HOME': '/Users/cltbld', 21:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:01 INFO - 'LOGNAME': 'cltbld', 21:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:01 INFO - 'MOZ_NO_REMOTE': '1', 21:09:01 INFO - 'NO_EM_RESTART': '1', 21:09:01 INFO - 'PAGER': '/bin/cat', 21:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:01 INFO - 'PWD': '/builds/slave/test', 21:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:01 INFO - 'SHELL': '/bin/bash', 21:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:01 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:01 INFO - 'USER': 'cltbld', 21:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:01 INFO - 'XPC_FLAGS': '0x0', 21:09:01 INFO - 'XPC_SERVICE_NAME': '0', 21:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:01 INFO - Downloading/unpacking jsonschema==2.5.1 21:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:09:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:04 INFO - Downloading functools32-3.2.3-2.tar.gz 21:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:09:04 INFO - warning: no files found matching '*.txt' 21:09:04 INFO - no previously-included directories found matching 'build' 21:09:04 INFO - no previously-included directories found matching 'dist' 21:09:04 INFO - no previously-included directories found matching '.git*' 21:09:04 INFO - Installing collected packages: jsonschema, functools32 21:09:04 INFO - Running setup.py install for functools32 21:09:04 INFO - warning: no files found matching '*.txt' 21:09:04 INFO - no previously-included directories found matching 'build' 21:09:04 INFO - no previously-included directories found matching 'dist' 21:09:04 INFO - no previously-included directories found matching '.git*' 21:09:04 INFO - Successfully installed jsonschema functools32 21:09:04 INFO - Cleaning up... 21:09:05 INFO - Return code: 0 21:09:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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', '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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:09: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 functools32==3.2.3-2 21:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:05 INFO - 'HOME': '/Users/cltbld', 21:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:05 INFO - 'LOGNAME': 'cltbld', 21:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:05 INFO - 'MOZ_NO_REMOTE': '1', 21:09:05 INFO - 'NO_EM_RESTART': '1', 21:09:05 INFO - 'PAGER': '/bin/cat', 21:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:05 INFO - 'PWD': '/builds/slave/test', 21:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:05 INFO - 'SHELL': '/bin/bash', 21:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:05 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:05 INFO - 'USER': 'cltbld', 21:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:05 INFO - 'XPC_FLAGS': '0x0', 21:09:05 INFO - 'XPC_SERVICE_NAME': '0', 21:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:09:05 INFO - Cleaning up... 21:09:05 INFO - Return code: 0 21:09:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:05 INFO - 'HOME': '/Users/cltbld', 21:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:05 INFO - 'LOGNAME': 'cltbld', 21:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:05 INFO - 'MOZ_NO_REMOTE': '1', 21:09:05 INFO - 'NO_EM_RESTART': '1', 21:09:05 INFO - 'PAGER': '/bin/cat', 21:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:05 INFO - 'PWD': '/builds/slave/test', 21:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:05 INFO - 'SHELL': '/bin/bash', 21:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:05 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:05 INFO - 'USER': 'cltbld', 21:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:05 INFO - 'XPC_FLAGS': '0x0', 21:09:05 INFO - 'XPC_SERVICE_NAME': '0', 21:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:09 INFO - Downloading docopt-0.6.1.tar.gz 21:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:09 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:09 INFO - Running setup.py install for blobuploader 21:09:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:09 INFO - Running setup.py install for requests 21:09:10 INFO - Running setup.py install for docopt 21:09:10 INFO - Successfully installed blobuploader requests docopt 21:09:10 INFO - Cleaning up... 21:09:10 INFO - Return code: 0 21:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:10 INFO - 'HOME': '/Users/cltbld', 21:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:10 INFO - 'LOGNAME': 'cltbld', 21:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:10 INFO - 'MOZ_NO_REMOTE': '1', 21:09:10 INFO - 'NO_EM_RESTART': '1', 21:09:10 INFO - 'PAGER': '/bin/cat', 21:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:10 INFO - 'PWD': '/builds/slave/test', 21:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:10 INFO - 'SHELL': '/bin/bash', 21:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:10 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:10 INFO - 'USER': 'cltbld', 21:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:10 INFO - 'XPC_FLAGS': '0x0', 21:09:10 INFO - 'XPC_SERVICE_NAME': '0', 21:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:10 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-fHe3XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:10 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-90gw_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:10 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-cbib0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-j7t5D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-cx5Ig8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-rQDCd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-rPim8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-5dNrn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Z_amwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-7lVHWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-X0Yjhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Ps1UPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:11 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-RiSrih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:12 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-VOjP1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:12 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-rmqoZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:12 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-G9eDff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:12 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-V42GX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:12 INFO - Running setup.py install for manifestparser 21:09:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Running setup.py install for mozcrash 21:09:12 INFO - Running setup.py install for mozdebug 21:09:12 INFO - Running setup.py install for mozdevice 21:09:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozfile 21:09:13 INFO - Running setup.py install for mozhttpd 21:09:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozinfo 21:09:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozInstall 21:09:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozleak 21:09:13 INFO - Running setup.py install for mozlog 21:09:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for moznetwork 21:09:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Running setup.py install for mozprocess 21:09:14 INFO - Running setup.py install for mozprofile 21:09:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Running setup.py install for mozrunner 21:09:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Running setup.py install for mozscreenshot 21:09:14 INFO - Running setup.py install for moztest 21:09:14 INFO - Running setup.py install for mozversion 21:09:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:15 INFO - Cleaning up... 21:09:15 INFO - Return code: 0 21:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:15 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 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:09:15 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 21:09:15 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 21:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:15 INFO - 'HOME': '/Users/cltbld', 21:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:15 INFO - 'LOGNAME': 'cltbld', 21:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:15 INFO - 'MOZ_NO_REMOTE': '1', 21:09:15 INFO - 'NO_EM_RESTART': '1', 21:09:15 INFO - 'PAGER': '/bin/cat', 21:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:15 INFO - 'PWD': '/builds/slave/test', 21:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:15 INFO - 'SHELL': '/bin/bash', 21:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:15 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:15 INFO - 'USER': 'cltbld', 21:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:15 INFO - 'XPC_FLAGS': '0x0', 21:09:15 INFO - 'XPC_SERVICE_NAME': '0', 21:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:15 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-4FimGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:15 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-9tpyHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:15 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-oB9xrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:15 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-cwRupM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:15 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-K1cjk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:15 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-WzOYqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:15 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-VVNqE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:16 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)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Plr70i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:16 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)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-kQQKO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-kI5o1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-QeQSqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-igPbcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:16 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)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-axrTVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-urp7lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-AEbOfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:16 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-nRDFO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:17 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-zaMaRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:17 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)) 21:09:17 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)) 21:09:17 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)) 21:09:17 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)) 21:09:17 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)) 21:09:17 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)) 21:09:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:17 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 21:09:17 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 21:09:17 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 21:09:17 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 21:09:17 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 21:09:17 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 21:09:19 INFO - Downloading blessings-1.6.tar.gz 21:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:19 INFO - Installing collected packages: blessings 21:09:19 INFO - Running setup.py install for blessings 21:09:19 INFO - Successfully installed blessings 21:09:19 INFO - Cleaning up... 21:09:20 INFO - Return code: 0 21:09:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:20 INFO - Reading from file tmpfile_stdout 21:09:20 INFO - Current package versions: 21:09:20 INFO - blessings == 1.6 21:09:20 INFO - blobuploader == 1.2.4 21:09:20 INFO - docopt == 0.6.1 21:09:20 INFO - functools32 == 3.2.3-2 21:09:20 INFO - jsonschema == 2.5.1 21:09:20 INFO - manifestparser == 1.1 21:09:20 INFO - mozInstall == 1.12 21:09:20 INFO - mozcrash == 1.0 21:09:20 INFO - mozdebug == 0.1 21:09:20 INFO - mozdevice == 0.48 21:09:20 INFO - mozfile == 1.2 21:09:20 INFO - mozhttpd == 0.7 21:09:20 INFO - mozinfo == 0.9 21:09:20 INFO - mozleak == 0.1 21:09:20 INFO - mozlog == 3.4 21:09:20 INFO - moznetwork == 0.27 21:09:20 INFO - mozprocess == 0.23 21:09:20 INFO - mozprofile == 0.28 21:09:20 INFO - mozrunner == 6.13 21:09:20 INFO - mozscreenshot == 0.1 21:09:20 INFO - mozsystemmonitor == 0.3 21:09:20 INFO - moztest == 0.8 21:09:20 INFO - mozversion == 1.4 21:09:20 INFO - psutil == 3.1.1 21:09:20 INFO - requests == 1.2.3 21:09:20 INFO - wsgiref == 0.1.2 21:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:20 INFO - 'HOME': '/Users/cltbld', 21:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:20 INFO - 'LOGNAME': 'cltbld', 21:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:20 INFO - 'MOZ_NO_REMOTE': '1', 21:09:20 INFO - 'NO_EM_RESTART': '1', 21:09:20 INFO - 'PAGER': '/bin/cat', 21:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:20 INFO - 'PWD': '/builds/slave/test', 21:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:20 INFO - 'SHELL': '/bin/bash', 21:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:20 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:20 INFO - 'USER': 'cltbld', 21:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:20 INFO - 'XPC_FLAGS': '0x0', 21:09:20 INFO - 'XPC_SERVICE_NAME': '0', 21:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:09:20 INFO - Cleaning up... 21:09:20 INFO - Return code: 0 21:09:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1082f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10826c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409c63800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, '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.j60vKIJHxx/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.SMpe8n6kY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 21:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:20 INFO - 'HOME': '/Users/cltbld', 21:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:20 INFO - 'LOGNAME': 'cltbld', 21:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:20 INFO - 'MOZ_NO_REMOTE': '1', 21:09:20 INFO - 'NO_EM_RESTART': '1', 21:09:20 INFO - 'PAGER': '/bin/cat', 21:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:20 INFO - 'PWD': '/builds/slave/test', 21:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:20 INFO - 'SHELL': '/bin/bash', 21:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:20 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:20 INFO - 'USER': 'cltbld', 21:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:20 INFO - 'XPC_FLAGS': '0x0', 21:09:20 INFO - 'XPC_SERVICE_NAME': '0', 21:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:09:20 INFO - Cleaning up... 21:09:20 INFO - Return code: 0 21:09:20 INFO - Running post-action listener: _resource_record_post_action 21:09:20 INFO - Running post-action listener: _start_resource_monitoring 21:09:20 INFO - Starting resource monitoring. 21:09:20 INFO - [mozharness: 2017-01-12 05:09:20.927473Z] Finished create-virtualenv step (success) 21:09:20 INFO - [mozharness: 2017-01-12 05:09:20.928458Z] Running install step. 21:09:20 INFO - Running pre-action listener: _resource_record_pre_action 21:09:20 INFO - Running main action method: install 21:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:21 INFO - Reading from file tmpfile_stdout 21:09:21 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:21 INFO - Reading from file tmpfile_stdout 21:09:21 INFO - Output received: 21:09:21 INFO - Usage: mozinstall [options] installer 21:09:21 INFO - Options: 21:09:21 INFO - -h, --help show this help message and exit 21:09:21 INFO - -d DEST, --destination=DEST 21:09:21 INFO - Directory to install application into. [default: 21:09:21 INFO - "/builds/slave/test"] 21:09:21 INFO - --app=APP Application being installed. [default: firefox] 21:09:21 INFO - mkdir: /builds/slave/test/build/application 21:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 21:09:52 INFO - Reading from file tmpfile_stdout 21:09:52 INFO - Output received: 21:09:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:09:52 INFO - Running post-action listener: _resource_record_post_action 21:09:52 INFO - [mozharness: 2017-01-12 05:09:52.355713Z] Finished install step (success) 21:09:52 INFO - [mozharness: 2017-01-12 05:09:52.355871Z] Running run-tests step. 21:09:52 INFO - Running pre-action listener: _resource_record_pre_action 21:09:52 INFO - Running main action method: run_tests 21:09:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:09:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:09:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:09:52 INFO - 2017-01-11 21:09:52.370 screenresolution[1633:8188] starting screenresolution argv=screenresolution get 21:09:52 INFO - 2017-01-11 21:09:52.372 screenresolution[1633:8188] Display 0: 1600x1200x32@60 21:09:52 INFO - 2017-01-11 21:09:52.378 screenresolution[1634:8191] starting screenresolution argv=screenresolution list 21:09:52 INFO - Available Modes on Display 0 21:09:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:09:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:09:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:09:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:09:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:09:52 INFO - Intel Iris: 21:09:52 INFO - Chipset Model: Intel Iris 21:09:52 INFO - Type: GPU 21:09:52 INFO - Bus: Built-In 21:09:52 INFO - VRAM (Dynamic, Max): 1536 MB 21:09:52 INFO - Vendor: Intel (0x8086) 21:09:52 INFO - Device ID: 0x0a2e 21:09:52 INFO - Revision ID: 0x0009 21:09:52 INFO - Displays: 21:09:52 INFO - Display: 21:09:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:09:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:09:52 INFO - Display Serial Number: 1600x1200 60 21:09:52 INFO - Main Display: Yes 21:09:52 INFO - Mirror: Off 21:09:52 INFO - Online: Yes 21:09:52 INFO - Rotation: Supported 21:09:52 INFO - Return code: 0 21:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:09:52 INFO - Python 2.7.3 21:09:52 INFO - Return code: 0 21:09:52 INFO - grabbing minidump binary from tooltool 21:09: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')]} 21:09: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 0x10810ad30>, '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 0x107f70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108102b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:09: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 21:09: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 21:09: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 21:09:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:09:52 INFO - Return code: 0 21:09:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:09:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:09:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:09:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:09:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--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 21:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0232 --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 21:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j60vKIJHxx/Render', 21:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:52 INFO - 'HOME': '/Users/cltbld', 21:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:52 INFO - 'LOGNAME': 'cltbld', 21:09:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:09:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:52 INFO - 'MOZ_NO_REMOTE': '1', 21:09:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:09:52 INFO - 'NO_EM_RESTART': '1', 21:09:52 INFO - 'PAGER': '/bin/cat', 21:09:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:52 INFO - 'PWD': '/builds/slave/test', 21:09:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:52 INFO - 'SHELL': '/bin/bash', 21:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SMpe8n6kY5/Listeners', 21:09:52 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 21:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:52 INFO - 'USER': 'cltbld', 21:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:52 INFO - 'XPC_FLAGS': '0x0', 21:09:52 INFO - 'XPC_SERVICE_NAME': '0', 21:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--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 21:09:52 INFO - mozversion application_buildid: 20170111185517 21:09:52 INFO - mozversion application_changeset: 1abb4b193740653f1161d86f38dbb79287e7d69b 21:09:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:09:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:09:52 INFO - mozversion application_name: Firefox 21:09:52 INFO - mozversion application_remotingname: firefox-dev 21:09:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:09:52 INFO - mozversion application_vendor: Mozilla 21:09:52 INFO - mozversion application_version: 52.0a2 21:09:52 INFO - mozversion platform_buildid: 20170111185517 21:09:52 INFO - mozversion platform_changeset: 1abb4b193740653f1161d86f38dbb79287e7d69b 21:09:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:09:52 INFO - mozversion platform_version: 52.0a2 21:09:52 INFO - using testdate: 1484197792 21:09:52 INFO - actual date: 1484197792 21:09:52 INFO - starting webserver on 'localhost:49248' 21:09:52 INFO - SUITE-START | Running 2 tests 21:09:52 INFO - TEST-START | dromaeo_css 21:09:52 INFO - operating with platform_type : mac_ 21:09:52 INFO - Initialising browser for dromaeo_css test... 21:09:52 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpL4x8Cz/profile http://localhost:49248/getInfo.html) 21:09:55 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 21:09:55 INFO - PROCESS | 1644 | colorDepth:24 21:09:55 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 21:09:55 INFO - PROCESS | 1644 | __metrics 21:09:55 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" 21:09:55 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:09:56 INFO - TEST-INFO | 1644: exit 0 21:09:56 INFO - Browser initialized. 21:09:56 INFO - Running cycle 1/1 for dromaeo_css test... 21:09:56 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpL4x8Cz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:10:08 INFO - PROCESS | 1647 | RSS: Main: 222081024 21:10:08 INFO - PROCESS | 1647 | 21:13:11 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 21:13:13 INFO - PROCESS | 1647 | RSS: Main: 342343680 21:13:13 INFO - PROCESS | 1647 | 21:16:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 21:16:16 INFO - PROCESS | 1647 | RSS: Main: 346779648 21:16:16 INFO - PROCESS | 1647 | 21:19:19 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 21:19:19 INFO - PROCESS | 1647 | RSS: Main: 342691840 21:19:19 INFO - PROCESS | 1647 | 21:22:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 21:22:22 INFO - PROCESS | 1647 | RSS: Main: 318898176 21:22:22 INFO - PROCESS | 1647 | 21:25:25 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 21:25:26 INFO - PROCESS | 1647 | RSS: Main: 309276672 21:25:26 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 21:28:29 INFO - PROCESS | 1647 | RSS: Main: 353452032 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | __start_tp_report 21:28:29 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 21:28:29 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 21:28:29 INFO - PROCESS | 1647 | |i|pagename|runs| 21:28:29 INFO - PROCESS | 1647 | |0;dojo.html;2769.80611357205;3277.4428347180983;3302.0589132097357;3328.434166191747;3341.5488908997277;5495.477929596687;5539.972300138494;5566.888662226753;5567.638103523268;5588.05003149465;4574.405327307453;5497.917531237034;5530.668159910399;5531.225628412026;5539.889202215953;4996.7251801151015;5028.7485625718755;5084.491550844905;5092.79628814847;5123.897522049557;5028.120078986181;5034.068697290994;5044.999999999982;5069.898602027957;5083.491650834924;5074.822381216658;5151.4075881273575;5154.407243167027;5165.896682066356;5182.792688292464;5119.948800512003;5144.948550514484;5148.3564554430695;5163.044836705221;5198.220266959948;4975.527324904165;4977.850664480072;5087.313212716273;5095.821646242363;5097.668651537675;5516.255305533742;5518.19986102017;5524.06090964537;5542.722863856791;5558.416366281523;5920;5983.252093488314;5986.28164620244;5992.8501787455225;6007.909881351783;6071.1803906472505;6090.908636370458;6110.9315565720835;6116.969415152896;6159.952808022602;4733.928991065137;5647.830565083054;5647.915281270784;5664;5665.6034077614995;5941.405859414024;6014.729337179838;6252.656103914237;6263.561550691408;6269.8746025079245;5882.794102206488;5914.378990206053;5939.287285525765;5954.821355359346;5997.0404735242155;6103.298120716086;6115.724792384353;6138.14066030756;6149.631022138686;6156.230471191101;5881.617694849907;5945.227120474311;6055.909161362583;6062.605930614584;6069.332373438918;5945.3757355477055;6002.369751176064;6012.368701286302;6018.21763170785;6084.026555751058;4796.616270698336;4807.543283388072;4808.422989241313;4809.470958194595;4829.348038014823;4297.656187504992;4316.352547117957;4326.848560300375;4334.306510958231;4382.2112019836095;5496.917546236809;5552;5562.694051827108;5571.0807716726285;5590.217369568182;6112.205413296243;6144.17053697754;6146.969265153645;6147.969260153671;6160.969195153995;5578.860528486739;5583.609147359646;5597.692126932976;5678.4605462480995;5713.600047996601;5194.480551944851;5217.217417387346;5221.503957124067;5224.2947202127225;5325.201219817059;6126.754929802847;6141.301904043321;6158.876822463436;6246.250449946036;6269.937300626935;6110.0424004731585;6141.301904043499;6173.722182501888;6182.381761823962;6190.876182476415;5025.47232540578;5355.3305836770405;6231.096491008869;6257.342978987141;6284.402981716729;5860.238169037998;5917.260342457193;5930.7924222652;6042.848928776816;6047.66737829406;6056.424639659225;6132.509399247961;6139.461473530676;6148.862460444832;6158.722857471335;5896.115582662635;5904.852378690395;5912.881742365214;5928.703564821828;5941.643501389931;5684.687342196054;5751.683657398883;5869.06095024794;5880.735366908414;5899.587028908107;5650.067738823048;5689.573282003949;5743.282089738783;5750.8849823002465;5751.913721294268;5688.0899056152475;5867.501262392574;5868.794592189253;5892.734826932712;5897.498712609477;4758.524147585353;5603.075492543685;5740.339860916049;5748.195252664714;5748.798792042258 21:28:29 INFO - PROCESS | 1647 | |1;ext.html;479.6115146731147;483.0146501137677;500.1397596134652;507.73851466494756;511.2025240624626;29544.26139346515;31177.844110779442;38667;39353.40969885447;39360.409593856115;40133.79933100338;40421.797891010574;40669.38995915056;40679;40686.57596984106;9148.130927561871;9315.720528384125;9317.534123293843;9327.020662830408;9351.158395744382;8359.331253499737;8462.66149354025;10895.019448249695;11115.888841111566;11154.888451115507;11033.117350611972;11088.778224435506;11090.722731931726;11106.944465277662;11109.166812489055;11098;11150.219484636078;11164.832527512013;11173;11197.888021119767;8405.95797021011;8624.094470080676;10771.676849694522;11041.889581104248;11093.72265693356;38739.806300968594;39039.024024399616;39079;39113.80443097795;39131.21737565261;3276.3283526876935;3605.4772058051435;3711.1464363196615;3728.660607593157;3735.551733791935;28210.717892821016;29110.70889291101;29153;29582;29626.851865740748;3079.7998130121696;3139.5133754268127;3189.1548739583795;3210.133264018702;3291.144302481348;494224;510652;511558;511875;512390;56238.718806405705;56628.43371566314;56723;56749.14876276859;56778;49418;59244;59253;59285.70357148186;59332;15455.845441545665;15667.216639168224;15684.137372444626;15696.607584810472;15698.76451853223;10935.617253396093;12155.696107597203;12224.75550489003;12241.143119981516;12244.81632775509;13071.346432678329;13454.461821527226;14533.982621216413;14861.993630859695;15007.549773506595;4943.72809495474;4961.925571116436;5886.529077673776;5938.990371636832;5957.076653118686;817.3624572833199;912.6577533424966;960.596549449233;966.1256562810527;982.9066238707311;28359.44023078709;28370.43259134847;28932.42135157327;29143.979960701698;29251.707482925325;820.9958950205211;873.8514452542955;948.8766460360109;1024.257413375312;1042.5569133118395;12727.93636031814;14058.437662493387;14688;15014.774778378332;15071.86960977931;651422;656322;659193;659345;660814;54635.180472292945;54682.72658636761;54716.905661886536;54762.45237547573;54767.178492322644;1310.0567591334225;1339.8861096806686;1352.2968056610705;1352.9729405412033;1354.2551596621622;28171.43657126887;28395.85802071059;28846.7115328844;29505.26236844096;29533.704662953096;47116.528834711215;51513.7424312891;52736;52828.73585632047;55585;445301;565569;567333;573289;575844;22864.885675571517;23401;23410;25215;25680.743192567836;35984;36786.63213367832;37804;39874.2025159501;45537.77231113823;35857.28285434329;36614.8169259152;37364.252714945;38385;38468.807655961544;37186;37478.62521374752;37500.062498436666;38397.61602384052;38398.040048999;35619.82190089033;36133.277334452636;36962.63037369699;37322.813385932895;37549.81225093966;31727.52408713825;33195;33396.332073358884;33494.66505335013;33666;24614.630780538664;24787.752122479265;24821.87589062043;25406.872965635794;25451.36371590725 21:28:29 INFO - PROCESS | 1647 | |2;jquery.html;305.81039755351685;380.2755750295686;383.8809968909638;386.71962826950454;408.77313091234373;12021.639350819478;14951.401943922243;15703.528894133195;19679.803201967978;20064.799352006474;18451.815481845177;19129.139188736506;19688.409347719557;19774.505637359074;19877.60244795103;5126.538611524962;5265.736713164327;5377.973110134444;5413.83758487246;5417.079096553595;4700.858974230779;4891.339669144655;5345.893082138355;5369.624126311141;5413.296271484702;5408.513233808956;5411.540019098381;5414.35027796663;5416.295881535395;5424.484673955968;5174.301469301652;5365.195220716884;5384.1923711443205;5402.459754024605;5408.756605952742;5139.743012849342;5187.118189907725;5256.474352564713;5260.079486089957;5279.049771041211;17475.5631109222;23868.64197037046;24615.63076553853;24649.260522184184;24921;2274.5223503064376;2420.491696743686;2445.6942882139733;2764.6682398112152;2837.0918311321325;7974.322182614426;9922.751931201705;10077.244206684529;10277.588896444133;10486.895131048668;1834.8623853211063;1847.2887938143776;1872.8782629129064;1874.372085351409;1964.1652297773533;117606.99999999914;117805.82194178035;119102;121061;121375;11366.715832104099;11601.651950441501;11660.416979151008;11676.649700508999;11763.823542646867;14725.410983560752;14756.48352307664;14763.89270804694;14764.114153150631;14786.186759728318;7447.733885239522;7774.339181169551;8395.412321137585;8416.705415310435;8580.184882436159;8220.917790822135;8234.752957411287;8241.423100382915;8393.992720873533;8414;3795.8291876865605;4437.977810110993;4539.364488971481;4589.58693717567;4620.653450991189;1860.7674040744907;1923.9038048097539;1929.24759343856;1929.729837822706;1930.3822776711318;654.1398061549048;695.1237071940343;730.7698075106324;762.8893810397461;822.8644470630611;19136.330228442217;19509.414717558495;19892.303769368293;20236.69644955327;20413.081411336527;792.9801754956172;905.6641453855642;908.2325435007408;914.085914085914;924.5515924776478;9543;9783.972682868338;10140.695779126638;10674.839877401846;10685.893141068489;606756;610672;617553;621538;622019;70492.64753676199;107590;133712;135858;137277;772.3705180278056;832.2052439919862;934.56075644447;963.6386355116831;967.3132076225959;14196;18449.262029518668;19007.42977710671;19046.238150473826;19094.427167185007;25905.74094259033;42339.788301058295;43630.12739745124;47557.762211188725;53416.46583534115;73382;74225.88661170195;75143.87284190633;77338.22661773536;78186.2181378179;5298;5512.91730624033;7541.7360392386;7811.320566078321;7992.36061115121;9975.538984125202;12011.879881201075;12118.151729378858;12377.257364558156;12388.31864247439;10462.372257664565;10739.355638661706;10821.621243256448;10835.837462437912;11077.169212308949;4896.681715688469;8046.678132874619;10441.269111162146;10551.683449496528;10979.945100274448;10925.781484370427;10999.395033273247;11185.944070279596;11230.831537527107;11318.886811132114;7809.2190780921455;7885.2114788520685;7987.680492780456;8203.425760196968;8257.090122452297;8120.309773669304;9125.498097604695;10601.144799660184;10784.838227426751;10902.890971090188 21:28:29 INFO - PROCESS | 1647 | |3;mootools.html;1460.656745664769;1475.2992328643895;1634.2237437217323;1775.5206094354533;1820.6722789897829;8071.273585377315;8476.533790641512;8487;8501.022382426023;8501.319894408449;7315.707371705139;7626.771196864089;7640.656170472328;7863.213678632134;8181.509109453422;2292.4498120451053;2328.5692146952783;2328.906843726249;2330.731965823935;2341.227394959668;1983.5437849294672;2330.8951097200584;2351.529694061186;2368.751281115484;2372.620380739082;2320.7563205863394;2322.5703244899746;2345.0736958901225;2346.1671106757112;2347.0377145370403;2302.067662596651;2305.43516838374;2325.3140323604575;2326.0811979268265;2327;2326.8720220387872;2346.671465994762;2349.635806450003;2353.870537120458;2357.1867705641525;8289.58552072394;8367.790805229917;8417.284530814888;8424.578771061422;8431.030431500394;5040.344755181803;5205.115130427836;5208.583313334924;5211.5049070338255;5214.296070030536;3241.773075884689;3305.6694330566993;3329.93340133196;3342.1644588852787;3570;1051.6529545250048;1052.978940421195;1081.4862940103467;1096.4243772019754;1100.510272928547;10745;10903;10910.781784364268;10923.945380273128;10925.781484370347;4496.775161241991;4500.954990450119;4691.053212916601;4703.365045718852;4749.3588365570895;9421.963584005754;9425.151736343762;9428.15146636806;9450.196733277611;9452.054794520493;5211.166213405837;5212.739363031833;5222.503862133091;5226.320578324793;5227.294315267391;4243.108947121139;4361.0841723237845;4483.865484035419;4748.572628463455;4796.496367881392;3386.8306584670668;3784;3861.937967059081;3893.0656642406184;3897.4543563901075;1257.4215860704178;1266.208619612742;1267.518343029643;1272.8154417609394;1277.6678063703505;816.6325153680749;821.4578378270313;844.8394804987033;907.0340087806464;938.558877327655;5534.7786088556;5678.716064196774;5717.142428635738;5761.251037365116;5990.131430942489;886.9778255543534;953.2278854128178;973.7370909854442;1024.3393011507535;1031.968031968032;3762.887113386603;3818.7517811342173;3894.4353068804867;3933.645971862546;3963.8612648557164;9644.710658680251;10113.393196408091;10113.69658910234;10133.797324053477;10140.44227567476;10053.899461005443;10075.949620251999;10076.798464030824;10079.042490963348;10092.444915529717;7552.848943021108;7742.690292388242;7744.728934487266;7904.604769761489;7946.920530794618;4573.794179261875;4950.950490495049;5644.971775141098;5649.293838270216;5667.914981275367;9297.349185557217;9410.294227932796;9415;9415.105564971316;9432.103950124727;9188.908110918805;9404.905950940403;9532.999035101215;9542.618295268112;9636;7136.143662760502;7140.6786694599905;7149.785506434815;7178.066851309505;7241.493095483265;7752.612369381621;7830.725924592612;7834.569098699399;7836.529808211526;7852.293293603603;6890.621015844176;6964.26875178099;7089.36195742365;7135.215126335995;7207.387372073223;6902.435395069769;7026.297370262932;7069.505134640526;7112.35988761014;7168.1756597989815;6645.900311495235;6646.8005959821285;6752.729890804313;6757.459403247827;6834.077399550997;4804.06320767447;4849.3210950467665;4879.243717223836;4904.3379143816555;4914.852554423373;4828.565429111256;4834.323194752667;4834.5890599299455;4992.8751781205765;5000.274960130833 21:28:29 INFO - PROCESS | 1647 | |4;prototype.html;298.26477732389657;301.53111910978436;309.2331019072699;313.2591421288653;314.0171263943855;4527.411436513257;4761.976160131943;4999.7500124993785;5251.054810134175;5256.789728410859;4284.093578357632;4475.418195634571;4497.1455423469515;4594.104149690803;4724.385829842125;3806.809659517027;3975.5428125765616;3979.562248152708;3998.720089593715;4017.5580686124504;3106.704863038019;3511.9648803511895;3980.7412518186225;4019.6985226108013;4044.1911617676437;3430.5883294004752;3485.7277093860685;3954.6638535724496;3965.385365268374;3970.9801450992704;3248.675132486744;3287.572615559986;3953.189596132786;3969.4839670842607;3970.0074981254543;3167.4932010878147;3260.6250281217726;3470.9132271693156;3487.5291835602125;3511.438169892805;4835.468098509161;4860.076585448789;5024.924626130611;5026.170681837492;5111.616628752821;3820.923581528382;3966.643002129822;4214.662826973835;4535.795889184995;4562.680612357136;5377.8117765878005;5475.561955043587;5502.339719233678;5547.362053363874;5556.888862222773;3004.354063876277;3598.298331825295;3764.5106136202116;3771.9057023574355;3793.412021136728;4718.787654555554;5217.713025783618;5714.79998200061;5736.24660163124;5747.827565173052;3111.859966301522;3630.3102410541915;3819.770813751128;3849.4225866119746;3851.557070936822;3342.782719123249;3736.6076561961145;3859.4982652255026;3881.6608270146753;3904.2386734587053;3914.980425097913;4266.765327906995;4491.742312152603;4500.729956202638;4532.5694059064335;4571.719918422847;4792.292354819516;5488.53347465462;5513.116243771446;5515.117581186991;1042.4058286776465;1157.89578937896;1187.4300335838673;1225.7180848404917;1244.321844594698;846.9407141500036;862.5557837713583;867.8915135608049;867.9194402968345;869.873513799631;4299.484061912528;4360.629346505519;4604.8388306409115;4658.277966915133;5021.322121513622;4428.4243048403505;4610.677252592353;4780.565830250911;5170.8448746536915;5402.459754024645;4291.527931927485;4526.23054080807;4616.030633566921;4653.906921861544;4772.611445873399;2505.3486093615425;2736.5758307462374;2794.5389010812987;2796.958045629317;2811.5820394460748;4274.444322238089;4740.410828947765;4905.351110400416;5546.861328466821;5547.5007249347755;4366.956330436718;5052.242163675404;5404.864878378072;5436.700981446058;5442.673439593637;4556.384888040072;5466.141511885899;5519.337679478408;5543.750531226105;5649.180868774005;4619.5611416915335;5110.97444512775;5255.448177941261;5358.258565965999;5531.045302608654;4679.742614156254;5625.296837895263;5635.8591035224445;5643.463870932255;5647.971760141173;5851.21008663825;5863.824085277449;5894.970525147347;5911.408859114054;5916.408359164049;3573.874914377984;3786.6402691744242;3796.7911764853197;3834.67405270544;3850.8267127978747;5625.103071917883;5637.689927054052;5647.639654405622;5699.629524080921;5721.370649228498;5037.5214354636255;5129.076766182123;5311.468853114658;5316.388615309134;5571.462121552762;4688.991866748665;5235.63350565472;5250.63215826262;5329.147336426153;5529.806456773994;4472.9776351118035;5302.946970530245;5327.680339179662;5330.387005494418;5332.653377530603;4619.736329198736;4723.197056500335;5265.998380922837;5269.656237659526;5425.83722488326;5332.9466705334;5361.5710743141235;5369.4093649697725;5395.56835453155;5473.945260547343 21:28:29 INFO - PROCESS | 1647 | |5;yui.html;691.4813889582813;700.1143553404944;719.8092505486047;732.5714457042629;743.8066102813267;13557.11878727882;13569;13586.864131358709;13609.979251556137;13612.455501779928;12834.614961551146;12842.293673847935;12851.742965140715;12960.870391296085;12961.222326660407;649.6037417175519;673.3165836675778;678.7285085965603;794.9602519873984;805.0942689474341;828.6271177969908;829.9917000830005;830.9986466308085;831.1978940322588;832.0930186097153;862.6420035685184;864.2955990867423;864.3258258558303;864.9783755406133;867.1371984875027;697.7801992372412;720.1574158234878;721.855628874222;722.0793488302456;856.4304737349686;533.3706226652548;623.1805176193292;640.0942666127424;644.5520363347475;645.1129696667083;14251.501197458143;14251.643708907257;14252.287385630678;14252.358643860947;14270.286485675779;12658.303793291365;12884.109964124818;13033.543825966046;13047.86952130476;13150.73698526024;11606.30362178272;11841.171118021743;11921.403929803475;12198.695032624166;12326.568570100004;4244.129953359554;4296.74219546825;4325.718828276184;4339.370791235285;4436.157130145262;82459;82792;83283.33433331299;87486;87491.56254218752;10170.389776613427;10304.536295866705;10385.792284154275;10419.791604168026;10513.84229236562;19731.704024439645;19750;19848;19930.800691992896;20046;7168.211496735355;7284.344409003215;7304.780856574312;7540.095188577406;7545.773626791205;4070.470838790938;4127.979360103241;4183.748975061506;4200.894977625584;4351.8694439166875;2733.72662733725;3289.687479689426;3345.5483509725877;3354.3291341731265;3359.10983589349;533.6184627991005;610.9755609775648;611.5688439650125;639.3223183425583;641.1056576076347;515.5205658737335;545.38916413617;578.991315130265;586.1331658667159;633.56917296239;8056.436049476598;8422.705205317785;8459.111793261618;8495.980482342158;8618.827623447496;590.5924911810837;601.4677010845434;610.5512448350458;630.7949916277229;635.7997230872353;4091.9590804091577;4273.722208056466;4274.059706864485;4313.525512193656;4336.371226172188;78962.60518697485;92376;116269.4186529062;119370;124251;102050.48974755227;104944.47527762465;105072.42391363982;105942.47028764807;106586;87840;88360;88406.55796721103;88442;91537.54231228802;8317.667293308199;8340.582970851554;8345.916540834756;8495.405321627673;8528.317734581095;57344.42655573391;57677;57895.71052144712;60388.396116038275;61075;54419;54579.72710136424;58450;68273.31726682669;81959;10279.640212592523;10490.265681402228;10618.628348007782;10680.62617808373;10892.727681808019;10722.731931701457;11300.265482743594;11514.42427878586;11586.304821710724;11687.590934317259;10153.289269751047;10228.59085636596;10430.165586753194;10866.891331086588;12308.199967002116;12057.336846473178;12749.553765618159;12879.420426081037;12965.02762292813;12971.740565188455;12466.937665311978;12507.061970352443;12511.311877846805;12686.985041196498;12762.808557871826;10443.843342349719;10867.836982445111;11055.557777689124;11337.489812958273;11385.715357116138;10167.339122956984;10790.784184316426;10938.781224375627;10955.397453140155;11219.214654974074 21:28:29 INFO - PROCESS | 1647 | __end_tp_report 21:28:29 INFO - PROCESS | 1647 | __start_cc_report 21:28:29 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1326 21:28:29 INFO - PROCESS | 1647 | __end_cc_report 21:28:29 INFO - PROCESS | 1647 | __startTimestamp1484198909793__endTimestamp 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | ------- Summary: start ------- 21:28:29 INFO - PROCESS | 1647 | Number of tests: 6 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5565.66 Median:5713.60 stddev:638.47 (11.2%) stddev-sans-first:601.58 21:28:29 INFO - PROCESS | 1647 | Values: 2769.8 3277.4 3302.1 3328.4 3341.5 5495.5 5540.0 5566.9 5567.6 5588.1 4574.4 5497.9 5530.7 5531.2 5539.9 4996.7 5028.7 5084.5 5092.8 5123.9 5028.1 5034.1 5045.0 5069.9 5083.5 5074.8 5151.4 5154.4 5165.9 5182.8 5119.9 5144.9 5148.4 5163.0 5198.2 4975.5 4977.9 5087.3 5095.8 5097.7 5516.3 5518.2 5524.1 5542.7 5558.4 5920.0 5983.3 5986.3 5992.9 6007.9 6071.2 6090.9 6110.9 6117.0 6160.0 4733.9 5647.8 5647.9 5664.0 5665.6 5941.4 6014.7 6252.7 6263.6 6269.9 5882.8 5914.4 5939.3 5954.8 5997.0 6103.3 6115.7 6138.1 6149.6 6156.2 5881.6 5945.2 6055.9 6062.6 6069.3 5945.4 6002.4 6012.4 6018.2 6084.0 4796.6 4807.5 4808.4 4809.5 4829.3 4297.7 4316.4 4326.8 4334.3 4382.2 5496.9 5552.0 5562.7 5571.1 5590.2 6112.2 6144.2 6147.0 6148.0 6161.0 5578.9 5583.6 5597.7 5678.5 5713.6 5194.5 5217.2 5221.5 5224.3 5325.2 6126.8 6141.3 6158.9 6246.3 6269.9 6110.0 6141.3 6173.7 6182.4 6190.9 5025.5 5355.3 6231.1 6257.3 6284.4 5860.2 5917.3 5930.8 6042.8 6047.7 6056.4 6132.5 6139.5 6148.9 6158.7 5896.1 5904.9 5912.9 5928.7 5941.6 5684.7 5751.7 5869.1 5880.7 5899.6 5650.1 5689.6 5743.3 5750.9 5751.9 5688.1 5867.5 5868.8 5892.7 5897.5 4758.5 5603.1 5740.3 5748.2 5748.8 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:69182.02 Median:20457.33 stddev:153798.20 (751.8%) stddev-sans-first:154143.14 21:28:29 INFO - PROCESS | 1647 | Values: 479.6 483.0 500.1 507.7 511.2 29544.3 31177.8 38667.0 39353.4 39360.4 40133.8 40421.8 40669.4 40679.0 40686.6 9148.1 9315.7 9317.5 9327.0 9351.2 8359.3 8462.7 10895.0 11115.9 11154.9 11033.1 11088.8 11090.7 11106.9 11109.2 11098.0 11150.2 11164.8 11173.0 11197.9 8406.0 8624.1 10771.7 11041.9 11093.7 38739.8 39039.0 39079.0 39113.8 39131.2 3276.3 3605.5 3711.1 3728.7 3735.6 28210.7 29110.7 29153.0 29582.0 29626.9 3079.8 3139.5 3189.2 3210.1 3291.1 494224.0 510652.0 511558.0 511875.0 512390.0 56238.7 56628.4 56723.0 56749.1 56778.0 49418.0 59244.0 59253.0 59285.7 59332.0 15455.8 15667.2 15684.1 15696.6 15698.8 10935.6 12155.7 12224.8 12241.1 12244.8 13071.3 13454.5 14534.0 14862.0 15007.5 4943.7 4961.9 5886.5 5939.0 5957.1 817.4 912.7 960.6 966.1 982.9 28359.4 28370.4 28932.4 29144.0 29251.7 821.0 873.9 948.9 1024.3 1042.6 12727.9 14058.4 14688.0 15014.8 15071.9 651422.0 656322.0 659193.0 659345.0 660814.0 54635.2 54682.7 54716.9 54762.5 54767.2 1310.1 1339.9 1352.3 1353.0 1354.3 28171.4 28395.9 28846.7 29505.3 29533.7 47116.5 51513.7 52736.0 52828.7 55585.0 445301.0 565569.0 567333.0 573289.0 575844.0 22864.9 23401.0 23410.0 25215.0 25680.7 35984.0 36786.6 37804.0 39874.2 45537.8 35857.3 36614.8 37364.3 38385.0 38468.8 37186.0 37478.6 37500.1 38397.6 38398.0 35619.8 36133.3 36962.6 37322.8 37549.8 31727.5 33195.0 33396.3 33494.7 33666.0 24614.6 24787.8 24821.9 25406.9 25451.4 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:34369.80 Median:397.75 stddev:102522.73 (25775.9%) stddev-sans-first:102778.43 21:28:29 INFO - PROCESS | 1647 | Values: 305.8 380.3 383.9 386.7 408.8 12021.6 14951.4 15703.5 19679.8 20064.8 18451.8 19129.1 19688.4 19774.5 19877.6 5126.5 5265.7 5378.0 5413.8 5417.1 4700.9 4891.3 5345.9 5369.6 5413.3 5408.5 5411.5 5414.4 5416.3 5424.5 5174.3 5365.2 5384.2 5402.5 5408.8 5139.7 5187.1 5256.5 5260.1 5279.0 17475.6 23868.6 24615.6 24649.3 24921.0 2274.5 2420.5 2445.7 2764.7 2837.1 7974.3 9922.8 10077.2 10277.6 10486.9 1834.9 1847.3 1872.9 1874.4 1964.2 117607.0 117805.8 119102.0 121061.0 121375.0 11366.7 11601.7 11660.4 11676.6 11763.8 14725.4 14756.5 14763.9 14764.1 14786.2 7447.7 7774.3 8395.4 8416.7 8580.2 8220.9 8234.8 8241.4 8394.0 8414.0 3795.8 4438.0 4539.4 4589.6 4620.7 1860.8 1923.9 1929.2 1929.7 1930.4 654.1 695.1 730.8 762.9 822.9 19136.3 19509.4 19892.3 20236.7 20413.1 793.0 905.7 908.2 914.1 924.6 9543.0 9784.0 10140.7 10674.8 10685.9 606756.0 610672.0 617553.0 621538.0 622019.0 70492.6 107590.0 133712.0 135858.0 137277.0 772.4 832.2 934.6 963.6 967.3 14196.0 18449.3 19007.4 19046.2 19094.4 25905.7 42339.8 43630.1 47557.8 53416.5 73382.0 74225.9 75143.9 77338.2 78186.2 5298.0 5512.9 7541.7 7811.3 7992.4 9975.5 12011.9 12118.2 12377.3 12388.3 10462.4 10739.4 10821.6 10835.8 11077.2 4896.7 8046.7 10441.3 10551.7 10979.9 10925.8 10999.4 11185.9 11230.8 11318.9 7809.2 7885.2 7987.7 8203.4 8257.1 8120.3 9125.5 10601.1 10784.8 10902.9 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5449.45 Median:4971.91 stddev:2974.05 (59.8%) stddev-sans-first:2967.28 21:28:29 INFO - PROCESS | 1647 | Values: 1460.7 1475.3 1634.2 1775.5 1820.7 8071.3 8476.5 8487.0 8501.0 8501.3 7315.7 7626.8 7640.7 7863.2 8181.5 2292.4 2328.6 2328.9 2330.7 2341.2 1983.5 2330.9 2351.5 2368.8 2372.6 2320.8 2322.6 2345.1 2346.2 2347.0 2302.1 2305.4 2325.3 2326.1 2327.0 2326.9 2346.7 2349.6 2353.9 2357.2 8289.6 8367.8 8417.3 8424.6 8431.0 5040.3 5205.1 5208.6 5211.5 5214.3 3241.8 3305.7 3329.9 3342.2 3570.0 1051.7 1053.0 1081.5 1096.4 1100.5 10745.0 10903.0 10910.8 10923.9 10925.8 4496.8 4501.0 4691.1 4703.4 4749.4 9422.0 9425.2 9428.2 9450.2 9452.1 5211.2 5212.7 5222.5 5226.3 5227.3 4243.1 4361.1 4483.9 4748.6 4796.5 3386.8 3784.0 3861.9 3893.1 3897.5 1257.4 1266.2 1267.5 1272.8 1277.7 816.6 821.5 844.8 907.0 938.6 5534.8 5678.7 5717.1 5761.3 5990.1 887.0 953.2 973.7 1024.3 1032.0 3762.9 3818.8 3894.4 3933.6 3963.9 9644.7 10113.4 10113.7 10133.8 10140.4 10053.9 10075.9 10076.8 10079.0 10092.4 7552.8 7742.7 7744.7 7904.6 7946.9 4573.8 4951.0 5645.0 5649.3 5667.9 9297.3 9410.3 9415.0 9415.1 9432.1 9188.9 9404.9 9533.0 9542.6 9636.0 7136.1 7140.7 7149.8 7178.1 7241.5 7752.6 7830.7 7834.6 7836.5 7852.3 6890.6 6964.3 7089.4 7135.2 7207.4 6902.4 7026.3 7069.5 7112.4 7168.2 6645.9 6646.8 6752.7 6757.5 6834.1 4804.1 4849.3 4879.2 4904.3 4914.9 4828.6 4834.3 4834.6 4992.9 5000.3 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4311.88 Median:4656.09 stddev:1336.39 (28.7%) stddev-sans-first:1305.74 21:28:29 INFO - PROCESS | 1647 | Values: 298.3 301.5 309.2 313.3 314.0 4527.4 4762.0 4999.8 5251.1 5256.8 4284.1 4475.4 4497.1 4594.1 4724.4 3806.8 3975.5 3979.6 3998.7 4017.6 3106.7 3512.0 3980.7 4019.7 4044.2 3430.6 3485.7 3954.7 3965.4 3971.0 3248.7 3287.6 3953.2 3969.5 3970.0 3167.5 3260.6 3470.9 3487.5 3511.4 4835.5 4860.1 5024.9 5026.2 5111.6 3820.9 3966.6 4214.7 4535.8 4562.7 5377.8 5475.6 5502.3 5547.4 5556.9 3004.4 3598.3 3764.5 3771.9 3793.4 4718.8 5217.7 5714.8 5736.2 5747.8 3111.9 3630.3 3819.8 3849.4 3851.6 3342.8 3736.6 3859.5 3881.7 3904.2 3915.0 4266.8 4491.7 4500.7 4532.6 4571.7 4792.3 5488.5 5513.1 5515.1 1042.4 1157.9 1187.4 1225.7 1244.3 846.9 862.6 867.9 867.9 869.9 4299.5 4360.6 4604.8 4658.3 5021.3 4428.4 4610.7 4780.6 5170.8 5402.5 4291.5 4526.2 4616.0 4653.9 4772.6 2505.3 2736.6 2794.5 2797.0 2811.6 4274.4 4740.4 4905.4 5546.9 5547.5 4367.0 5052.2 5404.9 5436.7 5442.7 4556.4 5466.1 5519.3 5543.8 5649.2 4619.6 5111.0 5255.4 5358.3 5531.0 4679.7 5625.3 5635.9 5643.5 5648.0 5851.2 5863.8 5895.0 5911.4 5916.4 3573.9 3786.6 3796.8 3834.7 3850.8 5625.1 5637.7 5647.6 5699.6 5721.4 5037.5 5129.1 5311.5 5316.4 5571.5 4689.0 5235.6 5250.6 5329.1 5529.8 4473.0 5302.9 5327.7 5330.4 5332.7 4619.7 4723.2 5266.0 5269.7 5425.8 5332.9 5361.6 5369.4 5395.6 5473.9 21:28:29 INFO - PROCESS | 1647 | 21:28:29 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:20262.27 Median:4285.40 stddev:30397.20 (709.3%) stddev-sans-first:30446.96 21:28:29 INFO - PROCESS | 1647 | Values: 691.5 700.1 719.8 732.6 743.8 13557.1 13569.0 13586.9 13610.0 13612.5 12834.6 12842.3 12851.7 12960.9 12961.2 649.6 673.3 678.7 795.0 805.1 828.6 830.0 831.0 831.2 832.1 862.6 864.3 864.3 865.0 867.1 697.8 720.2 721.9 722.1 856.4 533.4 623.2 640.1 644.6 645.1 14251.5 14251.6 14252.3 14252.4 14270.3 12658.3 12884.1 13033.5 13047.9 13150.7 11606.3 11841.2 11921.4 12198.7 12326.6 4244.1 4296.7 4325.7 4339.4 4436.2 82459.0 82792.0 83283.3 87486.0 87491.6 10170.4 10304.5 10385.8 10419.8 10513.8 19731.7 19750.0 19848.0 19930.8 20046.0 7168.2 7284.3 7304.8 7540.1 7545.8 4070.5 4128.0 4183.7 4200.9 4351.9 2733.7 3289.7 3345.5 3354.3 3359.1 533.6 611.0 611.6 639.3 641.1 515.5 545.4 579.0 586.1 633.6 8056.4 8422.7 8459.1 8496.0 8618.8 590.6 601.5 610.6 630.8 635.8 4092.0 4273.7 4274.1 4313.5 4336.4 78962.6 92376.0 116269.4 119370.0 124251.0 102050.5 104944.5 105072.4 105942.5 106586.0 87840.0 88360.0 88406.6 88442.0 91537.5 8317.7 8340.6 8345.9 8495.4 8528.3 57344.4 57677.0 57895.7 60388.4 61075.0 54419.0 54579.7 58450.0 68273.3 81959.0 10279.6 10490.3 10618.6 10680.6 10892.7 10722.7 11300.3 11514.4 11586.3 11687.6 10153.3 10228.6 10430.2 10866.9 12308.2 12057.3 12749.6 12879.4 12965.0 12971.7 12466.9 12507.1 12511.3 12687.0 12762.8 10443.8 10867.8 11055.6 11337.5 11385.7 10167.3 10790.8 10938.8 10955.4 11219.2 21:28:29 INFO - PROCESS | 1647 | -------- Summary: end -------- 21:28:29 INFO - PROCESS | 1647 | 21:28:30 INFO - TEST-INFO | 1647: exit 0 21:28:30 INFO - TEST-OK | dromaeo_css | took 1117489ms 21:28:30 INFO - TEST-START | kraken 21:28:30 INFO - operating with platform_type : mac_ 21:28:30 INFO - Initialising browser for kraken test... 21:28:30 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpPhE6Ft/profile http://localhost:49248/getInfo.html) 21:28:32 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 21:28:32 INFO - PROCESS | 1653 | colorDepth:24 21:28:32 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 21:28:32 INFO - PROCESS | 1653 | __metrics 21:28:32 INFO - PROCESS | 1653 | 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" 21:28:32 INFO - PROCESS | 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:28:33 INFO - TEST-INFO | 1653: exit 0 21:28:33 INFO - Browser initialized. 21:28:33 INFO - Running cycle 1/1 for kraken test... 21:28:33 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpPhE6Ft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:28:45 INFO - PROCESS | 1654 | RSS: Main: 222072832 21:28:45 INFO - PROCESS | 1654 | 21:28:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 21:28:49 INFO - PROCESS | 1654 | RSS: Main: 272240640 21:28:49 INFO - PROCESS | 1654 | 21:28:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 21:28:52 INFO - PROCESS | 1654 | RSS: Main: 283201536 21:28:52 INFO - PROCESS | 1654 | 21:28:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 21:28:56 INFO - PROCESS | 1654 | RSS: Main: 379400192 21:28:56 INFO - PROCESS | 1654 | 21:28:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 21:28:59 INFO - PROCESS | 1654 | RSS: Main: 283615232 21:28:59 INFO - PROCESS | 1654 | 21:29:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:29:01 INFO - PROCESS | 1654 | RSS: Main: 284438528 21:29:01 INFO - PROCESS | 1654 | 21:29:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 21:29:05 INFO - PROCESS | 1654 | RSS: Main: 324988928 21:29:05 INFO - PROCESS | 1654 | 21:29:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 21:29:08 INFO - PROCESS | 1654 | RSS: Main: 325668864 21:29:08 INFO - PROCESS | 1654 | 21:29:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 21:29:12 INFO - PROCESS | 1654 | RSS: Main: 324489216 21:29:12 INFO - PROCESS | 1654 | 21:29:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:29:14 INFO - PROCESS | 1654 | RSS: Main: 299204608 21:29:14 INFO - PROCESS | 1654 | 21:29:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:16 INFO - PROCESS | 1654 | RSS: Main: 302907392 21:29:16 INFO - PROCESS | 1654 | 21:29:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:19 INFO - PROCESS | 1654 | RSS: Main: 303685632 21:29:19 INFO - PROCESS | 1654 | 21:29:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:23 INFO - PROCESS | 1654 | RSS: Main: 321495040 21:29:23 INFO - PROCESS | 1654 | 21:29:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:27 INFO - PROCESS | 1654 | RSS: Main: 315035648 21:29:27 INFO - PROCESS | 1654 | 21:29:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 21:29:29 INFO - PROCESS | 1654 | RSS: Main: 359284736 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | __start_tp_report 21:29:29 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 21:29:29 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 21:29:29 INFO - PROCESS | 1654 | |i|pagename|runs| 21:29:29 INFO - PROCESS | 1654 | |0;ai-astar;115;113;113;114;113;115;114;123;168;114 21:29:29 INFO - PROCESS | 1654 | |1;audio-beat-detection;143;110;112;155;145;111;108;120;124;132 21:29:29 INFO - PROCESS | 1654 | |2;audio-dft;184;179;182;182;182;185;184;181;183;184 21:29:29 INFO - PROCESS | 1654 | |3;audio-fft;76;73;59;88;59;58;59;58;81;57 21:29:29 INFO - PROCESS | 1654 | |4;audio-oscillator;89;70;92;68;68;69;88;66;70;92 21:29:29 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;86;85;87;85;86;84;87;85;86;85 21:29:29 INFO - PROCESS | 1654 | |6;imaging-darkroom;143;105;94;93;107;135;93;102;93;94 21:29:29 INFO - PROCESS | 1654 | |7;imaging-desaturate;82;84;81;82;82;81;82;86;80;84 21:29:29 INFO - PROCESS | 1654 | |8;json-parse-financial;56;56;55;55;57;59;58;60;58;57 21:29:29 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;66;72;69;81;76;69;71;70;71;75 21:29:29 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;85;84;82;102;97;101;94;84;84;85 21:29:29 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;147;139;138;138;141;142;145;142;193;167 21:29:29 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;172;220;205;165;164;165;163;165;165;176 21:29:29 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;69;71;63;75;87;82;85;84;65;64 21:29:29 INFO - PROCESS | 1654 | __end_tp_report 21:29:29 INFO - PROCESS | 1654 | __start_cc_report 21:29:29 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1956 21:29:29 INFO - PROCESS | 1654 | __end_cc_report 21:29:29 INFO - PROCESS | 1654 | __startTimestamp1484198969195__endTimestamp 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | ------- Summary: start ------- 21:29:29 INFO - PROCESS | 1654 | Number of tests: 14 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:120.20 Median:114.50 stddev:17.05 (14.9%) stddev-sans-first:17.98 21:29:29 INFO - PROCESS | 1654 | Values: 115.0 113.0 113.0 114.0 113.0 115.0 114.0 123.0 168.0 114.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:128.00 stddev:16.89 (13.2%) stddev-sans-first:16.76 21:29:29 INFO - PROCESS | 1654 | Values: 143.0 110.0 112.0 155.0 145.0 111.0 108.0 120.0 124.0 132.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.50 stddev:1.78 (1.0%) stddev-sans-first:1.81 21:29:29 INFO - PROCESS | 1654 | Values: 184.0 179.0 182.0 182.0 182.0 185.0 184.0 181.0 183.0 184.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.80 Median:66.00 stddev:11.58 (17.6%) stddev-sans-first:11.80 21:29:29 INFO - PROCESS | 1654 | Values: 76.0 73.0 59.0 88.0 59.0 58.0 59.0 58.0 81.0 57.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.00 stddev:11.35 (14.4%) stddev-sans-first:11.21 21:29:29 INFO - PROCESS | 1654 | Values: 89.0 70.0 92.0 68.0 68.0 69.0 88.0 66.0 70.0 92.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 21:29:29 INFO - PROCESS | 1654 | Values: 86.0 85.0 87.0 85.0 86.0 84.0 87.0 85.0 86.0 85.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:93.00 stddev:18.33 (19.7%) stddev-sans-first:13.66 21:29:29 INFO - PROCESS | 1654 | Values: 143.0 105.0 94.0 93.0 107.0 135.0 93.0 102.0 93.0 94.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:82.00 stddev:1.78 (2.2%) stddev-sans-first:1.88 21:29:29 INFO - PROCESS | 1654 | Values: 82.0 84.0 81.0 82.0 82.0 81.0 82.0 86.0 80.0 84.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:1.66 (2.9%) stddev-sans-first:1.72 21:29:29 INFO - PROCESS | 1654 | Values: 56.0 56.0 55.0 55.0 57.0 59.0 58.0 60.0 58.0 57.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:71.50 stddev:4.29 (6.0%) stddev-sans-first:3.97 21:29:29 INFO - PROCESS | 1654 | Values: 66.0 72.0 69.0 81.0 76.0 69.0 71.0 70.0 71.0 75.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:84.50 stddev:7.83 (9.3%) stddev-sans-first:8.11 21:29:29 INFO - PROCESS | 1654 | Values: 85.0 84.0 82.0 102.0 97.0 101.0 94.0 84.0 84.0 85.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:143.50 stddev:17.59 (12.3%) stddev-sans-first:18.64 21:29:29 INFO - PROCESS | 1654 | Values: 147.0 139.0 138.0 138.0 141.0 142.0 145.0 142.0 193.0 167.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:168.50 stddev:19.97 (11.9%) stddev-sans-first:21.13 21:29:29 INFO - PROCESS | 1654 | Values: 172.0 220.0 205.0 165.0 164.0 165.0 163.0 165.0 165.0 176.0 21:29:29 INFO - PROCESS | 1654 | 21:29:29 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:78.50 stddev:9.36 (11.9%) stddev-sans-first:9.71 21:29:29 INFO - PROCESS | 1654 | Values: 69.0 71.0 63.0 75.0 87.0 82.0 85.0 84.0 65.0 64.0 21:29:29 INFO - PROCESS | 1654 | -------- Summary: end -------- 21:29:29 INFO - PROCESS | 1654 | 21:29:30 INFO - TEST-INFO | 1654: exit 0 21:29:30 INFO - TEST-OK | kraken | took 59809ms 21:29:30 INFO - SUITE-END | took 1177s 21:29:30 INFO - Completed test suite (00:19:37) 21:29:30 INFO - javascript benchmark 21:29:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2769.80611357205, 3277.4428347180983, 3302.0589132097357, 3328.434166191747, 3341.5488908997277, 5495.477929596687, 5539.972300138494, 5566.888662226753, 5567.638103523268, 5588.05003149465, 4574.405327307453, 5497.917531237034, 5530.668159910399, 5531.225628412026, 5539.889202215953, 4996.7251801151015, 5028.7485625718755, 5084.491550844905, 5092.79628814847, 5123.897522049557, 5028.120078986181, 5034.068697290994, 5044.999999999982, 5069.898602027957, 5083.491650834924, 5074.822381216658, 5151.4075881273575, 5154.407243167027, 5165.896682066356, 5182.792688292464, 5119.948800512003, 5144.948550514484, 5148.3564554430695, 5163.044836705221, 5198.220266959948, 4975.527324904165, 4977.850664480072, 5087.313212716273, 5095.821646242363, 5097.668651537675, 5516.255305533742, 5518.19986102017, 5524.06090964537, 5542.722863856791, 5558.416366281523, 5920.0, 5983.252093488314, 5986.28164620244, 5992.8501787455225, 6007.909881351783, 6071.1803906472505, 6090.908636370458, 6110.9315565720835, 6116.969415152896, 6159.952808022602, 4733.928991065137, 5647.830565083054, 5647.915281270784, 5664.0, 5665.6034077614995, 5941.405859414024, 6014.729337179838, 6252.656103914237, 6263.561550691408, 6269.8746025079245, 5882.794102206488, 5914.378990206053, 5939.287285525765, 5954.821355359346, 5997.0404735242155, 6103.298120716086, 6115.724792384353, 6138.14066030756, 6149.631022138686, 6156.230471191101, 5881.617694849907, 5945.227120474311, 6055.909161362583, 6062.605930614584, 6069.332373438918, 5945.3757355477055, 6002.369751176064, 6012.368701286302, 6018.21763170785, 6084.026555751058, 4796.616270698336, 4807.543283388072, 4808.422989241313, 4809.470958194595, 4829.348038014823, 4297.656187504992, 4316.352547117957, 4326.848560300375, 4334.306510958231, 4382.2112019836095, 5496.917546236809, 5552.0, 5562.694051827108, 5571.0807716726285, 5590.217369568182, 6112.205413296243, 6144.17053697754, 6146.969265153645, 6147.969260153671, 6160.969195153995, 5578.860528486739, 5583.609147359646, 5597.692126932976, 5678.4605462480995, 5713.600047996601, 5194.480551944851, 5217.217417387346, 5221.503957124067, 5224.2947202127225, 5325.201219817059, 6126.754929802847, 6141.301904043321, 6158.876822463436, 6246.250449946036, 6269.937300626935, 6110.0424004731585, 6141.301904043499, 6173.722182501888, 6182.381761823962, 6190.876182476415, 5025.47232540578, 5355.3305836770405, 6231.096491008869, 6257.342978987141, 6284.402981716729, 5860.238169037998, 5917.260342457193, 5930.7924222652, 6042.848928776816, 6047.66737829406, 6056.424639659225, 6132.509399247961, 6139.461473530676, 6148.862460444832, 6158.722857471335, 5896.115582662635, 5904.852378690395, 5912.881742365214, 5928.703564821828, 5941.643501389931, 5684.687342196054, 5751.683657398883, 5869.06095024794, 5880.735366908414, 5899.587028908107, 5650.067738823048, 5689.573282003949, 5743.282089738783, 5750.8849823002465, 5751.913721294268, 5688.0899056152475, 5867.501262392574, 5868.794592189253, 5892.734826932712, 5897.498712609477, 4758.524147585353, 5603.075492543685, 5740.339860916049, 5748.195252664714, 5748.798792042258], "value": 5524.763949985479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.6115146731147, 483.0146501137677, 500.1397596134652, 507.73851466494756, 511.2025240624626, 29544.26139346515, 31177.844110779442, 38667.0, 39353.40969885447, 39360.409593856115, 40133.79933100338, 40421.797891010574, 40669.38995915056, 40679.0, 40686.57596984106, 9148.130927561871, 9315.720528384125, 9317.534123293843, 9327.020662830408, 9351.158395744382, 8359.331253499737, 8462.66149354025, 10895.019448249695, 11115.888841111566, 11154.888451115507, 11033.117350611972, 11088.778224435506, 11090.722731931726, 11106.944465277662, 11109.166812489055, 11098.0, 11150.219484636078, 11164.832527512013, 11173.0, 11197.888021119767, 8405.95797021011, 8624.094470080676, 10771.676849694522, 11041.889581104248, 11093.72265693356, 38739.806300968594, 39039.024024399616, 39079.0, 39113.80443097795, 39131.21737565261, 3276.3283526876935, 3605.4772058051435, 3711.1464363196615, 3728.660607593157, 3735.551733791935, 28210.717892821016, 29110.70889291101, 29153.0, 29582.0, 29626.851865740748, 3079.7998130121696, 3139.5133754268127, 3189.1548739583795, 3210.133264018702, 3291.144302481348, 494224.0, 510652.0, 511558.0, 511875.0, 512390.0, 56238.718806405705, 56628.43371566314, 56723.0, 56749.14876276859, 56778.0, 49418.0, 59244.0, 59253.0, 59285.70357148186, 59332.0, 15455.845441545665, 15667.216639168224, 15684.137372444626, 15696.607584810472, 15698.76451853223, 10935.617253396093, 12155.696107597203, 12224.75550489003, 12241.143119981516, 12244.81632775509, 13071.346432678329, 13454.461821527226, 14533.982621216413, 14861.993630859695, 15007.549773506595, 4943.72809495474, 4961.925571116436, 5886.529077673776, 5938.990371636832, 5957.076653118686, 817.3624572833199, 912.6577533424966, 960.596549449233, 966.1256562810527, 982.9066238707311, 28359.44023078709, 28370.43259134847, 28932.42135157327, 29143.979960701698, 29251.707482925325, 820.9958950205211, 873.8514452542955, 948.8766460360109, 1024.257413375312, 1042.5569133118395, 12727.93636031814, 14058.437662493387, 14688.0, 15014.774778378332, 15071.86960977931, 651422.0, 656322.0, 659193.0, 659345.0, 660814.0, 54635.180472292945, 54682.72658636761, 54716.905661886536, 54762.45237547573, 54767.178492322644, 1310.0567591334225, 1339.8861096806686, 1352.2968056610705, 1352.9729405412033, 1354.2551596621622, 28171.43657126887, 28395.85802071059, 28846.7115328844, 29505.26236844096, 29533.704662953096, 47116.528834711215, 51513.7424312891, 52736.0, 52828.73585632047, 55585.0, 445301.0, 565569.0, 567333.0, 573289.0, 575844.0, 22864.885675571517, 23401.0, 23410.0, 25215.0, 25680.743192567836, 35984.0, 36786.63213367832, 37804.0, 39874.2025159501, 45537.77231113823, 35857.28285434329, 36614.8169259152, 37364.252714945, 38385.0, 38468.807655961544, 37186.0, 37478.62521374752, 37500.062498436666, 38397.61602384052, 38398.040048999, 35619.82190089033, 36133.277334452636, 36962.63037369699, 37322.813385932895, 37549.81225093966, 31727.52408713825, 33195.0, 33396.332073358884, 33494.66505335013, 33666.0, 24614.630780538664, 24787.752122479265, 24821.87589062043, 25406.872965635794, 25451.36371590725], "value": 19175.900547261772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.81039755351685, 380.2755750295686, 383.8809968909638, 386.71962826950454, 408.77313091234373, 12021.639350819478, 14951.401943922243, 15703.528894133195, 19679.803201967978, 20064.799352006474, 18451.815481845177, 19129.139188736506, 19688.409347719557, 19774.505637359074, 19877.60244795103, 5126.538611524962, 5265.736713164327, 5377.973110134444, 5413.83758487246, 5417.079096553595, 4700.858974230779, 4891.339669144655, 5345.893082138355, 5369.624126311141, 5413.296271484702, 5408.513233808956, 5411.540019098381, 5414.35027796663, 5416.295881535395, 5424.484673955968, 5174.301469301652, 5365.195220716884, 5384.1923711443205, 5402.459754024605, 5408.756605952742, 5139.743012849342, 5187.118189907725, 5256.474352564713, 5260.079486089957, 5279.049771041211, 17475.5631109222, 23868.64197037046, 24615.63076553853, 24649.260522184184, 24921.0, 2274.5223503064376, 2420.491696743686, 2445.6942882139733, 2764.6682398112152, 2837.0918311321325, 7974.322182614426, 9922.751931201705, 10077.244206684529, 10277.588896444133, 10486.895131048668, 1834.8623853211063, 1847.2887938143776, 1872.8782629129064, 1874.372085351409, 1964.1652297773533, 117606.99999999914, 117805.82194178035, 119102.0, 121061.0, 121375.0, 11366.715832104099, 11601.651950441501, 11660.416979151008, 11676.649700508999, 11763.823542646867, 14725.410983560752, 14756.48352307664, 14763.89270804694, 14764.114153150631, 14786.186759728318, 7447.733885239522, 7774.339181169551, 8395.412321137585, 8416.705415310435, 8580.184882436159, 8220.917790822135, 8234.752957411287, 8241.423100382915, 8393.992720873533, 8414.0, 3795.8291876865605, 4437.977810110993, 4539.364488971481, 4589.58693717567, 4620.653450991189, 1860.7674040744907, 1923.9038048097539, 1929.24759343856, 1929.729837822706, 1930.3822776711318, 654.1398061549048, 695.1237071940343, 730.7698075106324, 762.8893810397461, 822.8644470630611, 19136.330228442217, 19509.414717558495, 19892.303769368293, 20236.69644955327, 20413.081411336527, 792.9801754956172, 905.6641453855642, 908.2325435007408, 914.085914085914, 924.5515924776478, 9543.0, 9783.972682868338, 10140.695779126638, 10674.839877401846, 10685.893141068489, 606756.0, 610672.0, 617553.0, 621538.0, 622019.0, 70492.64753676199, 107590.0, 133712.0, 135858.0, 137277.0, 772.3705180278056, 832.2052439919862, 934.56075644447, 963.6386355116831, 967.3132076225959, 14196.0, 18449.262029518668, 19007.42977710671, 19046.238150473826, 19094.427167185007, 25905.74094259033, 42339.788301058295, 43630.12739745124, 47557.762211188725, 53416.46583534115, 73382.0, 74225.88661170195, 75143.87284190633, 77338.22661773536, 78186.2181378179, 5298.0, 5512.91730624033, 7541.7360392386, 7811.320566078321, 7992.36061115121, 9975.538984125202, 12011.879881201075, 12118.151729378858, 12377.257364558156, 12388.31864247439, 10462.372257664565, 10739.355638661706, 10821.621243256448, 10835.837462437912, 11077.169212308949, 4896.681715688469, 8046.678132874619, 10441.269111162146, 10551.683449496528, 10979.945100274448, 10925.781484370427, 10999.395033273247, 11185.944070279596, 11230.831537527107, 11318.886811132114, 7809.2190780921455, 7885.2114788520685, 7987.680492780456, 8203.425760196968, 8257.090122452297, 8120.309773669304, 9125.498097604695, 10601.144799660184, 10784.838227426751, 10902.890971090188], "value": 8982.80921598174, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.656745664769, 1475.2992328643895, 1634.2237437217323, 1775.5206094354533, 1820.6722789897829, 8071.273585377315, 8476.533790641512, 8487.0, 8501.022382426023, 8501.319894408449, 7315.707371705139, 7626.771196864089, 7640.656170472328, 7863.213678632134, 8181.509109453422, 2292.4498120451053, 2328.5692146952783, 2328.906843726249, 2330.731965823935, 2341.227394959668, 1983.5437849294672, 2330.8951097200584, 2351.529694061186, 2368.751281115484, 2372.620380739082, 2320.7563205863394, 2322.5703244899746, 2345.0736958901225, 2346.1671106757112, 2347.0377145370403, 2302.067662596651, 2305.43516838374, 2325.3140323604575, 2326.0811979268265, 2327.0, 2326.8720220387872, 2346.671465994762, 2349.635806450003, 2353.870537120458, 2357.1867705641525, 8289.58552072394, 8367.790805229917, 8417.284530814888, 8424.578771061422, 8431.030431500394, 5040.344755181803, 5205.115130427836, 5208.583313334924, 5211.5049070338255, 5214.296070030536, 3241.773075884689, 3305.6694330566993, 3329.93340133196, 3342.1644588852787, 3570.0, 1051.6529545250048, 1052.978940421195, 1081.4862940103467, 1096.4243772019754, 1100.510272928547, 10745.0, 10903.0, 10910.781784364268, 10923.945380273128, 10925.781484370347, 4496.775161241991, 4500.954990450119, 4691.053212916601, 4703.365045718852, 4749.3588365570895, 9421.963584005754, 9425.151736343762, 9428.15146636806, 9450.196733277611, 9452.054794520493, 5211.166213405837, 5212.739363031833, 5222.503862133091, 5226.320578324793, 5227.294315267391, 4243.108947121139, 4361.0841723237845, 4483.865484035419, 4748.572628463455, 4796.496367881392, 3386.8306584670668, 3784.0, 3861.937967059081, 3893.0656642406184, 3897.4543563901075, 1257.4215860704178, 1266.208619612742, 1267.518343029643, 1272.8154417609394, 1277.6678063703505, 816.6325153680749, 821.4578378270313, 844.8394804987033, 907.0340087806464, 938.558877327655, 5534.7786088556, 5678.716064196774, 5717.142428635738, 5761.251037365116, 5990.131430942489, 886.9778255543534, 953.2278854128178, 973.7370909854442, 1024.3393011507535, 1031.968031968032, 3762.887113386603, 3818.7517811342173, 3894.4353068804867, 3933.645971862546, 3963.8612648557164, 9644.710658680251, 10113.393196408091, 10113.69658910234, 10133.797324053477, 10140.44227567476, 10053.899461005443, 10075.949620251999, 10076.798464030824, 10079.042490963348, 10092.444915529717, 7552.848943021108, 7742.690292388242, 7744.728934487266, 7904.604769761489, 7946.920530794618, 4573.794179261875, 4950.950490495049, 5644.971775141098, 5649.293838270216, 5667.914981275367, 9297.349185557217, 9410.294227932796, 9415.0, 9415.105564971316, 9432.103950124727, 9188.908110918805, 9404.905950940403, 9532.999035101215, 9542.618295268112, 9636.0, 7136.143662760502, 7140.6786694599905, 7149.785506434815, 7178.066851309505, 7241.493095483265, 7752.612369381621, 7830.725924592612, 7834.569098699399, 7836.529808211526, 7852.293293603603, 6890.621015844176, 6964.26875178099, 7089.36195742365, 7135.215126335995, 7207.387372073223, 6902.435395069769, 7026.297370262932, 7069.505134640526, 7112.35988761014, 7168.1756597989815, 6645.900311495235, 6646.8005959821285, 6752.729890804313, 6757.459403247827, 6834.077399550997, 4804.06320767447, 4849.3210950467665, 4879.243717223836, 4904.3379143816555, 4914.852554423373, 4828.565429111256, 4834.323194752667, 4834.5890599299455, 4992.8751781205765, 5000.274960130833], "value": 4430.64185597458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.26477732389657, 301.53111910978436, 309.2331019072699, 313.2591421288653, 314.0171263943855, 4527.411436513257, 4761.976160131943, 4999.7500124993785, 5251.054810134175, 5256.789728410859, 4284.093578357632, 4475.418195634571, 4497.1455423469515, 4594.104149690803, 4724.385829842125, 3806.809659517027, 3975.5428125765616, 3979.562248152708, 3998.720089593715, 4017.5580686124504, 3106.704863038019, 3511.9648803511895, 3980.7412518186225, 4019.6985226108013, 4044.1911617676437, 3430.5883294004752, 3485.7277093860685, 3954.6638535724496, 3965.385365268374, 3970.9801450992704, 3248.675132486744, 3287.572615559986, 3953.189596132786, 3969.4839670842607, 3970.0074981254543, 3167.4932010878147, 3260.6250281217726, 3470.9132271693156, 3487.5291835602125, 3511.438169892805, 4835.468098509161, 4860.076585448789, 5024.924626130611, 5026.170681837492, 5111.616628752821, 3820.923581528382, 3966.643002129822, 4214.662826973835, 4535.795889184995, 4562.680612357136, 5377.8117765878005, 5475.561955043587, 5502.339719233678, 5547.362053363874, 5556.888862222773, 3004.354063876277, 3598.298331825295, 3764.5106136202116, 3771.9057023574355, 3793.412021136728, 4718.787654555554, 5217.713025783618, 5714.79998200061, 5736.24660163124, 5747.827565173052, 3111.859966301522, 3630.3102410541915, 3819.770813751128, 3849.4225866119746, 3851.557070936822, 3342.782719123249, 3736.6076561961145, 3859.4982652255026, 3881.6608270146753, 3904.2386734587053, 3914.980425097913, 4266.765327906995, 4491.742312152603, 4500.729956202638, 4532.5694059064335, 4571.719918422847, 4792.292354819516, 5488.53347465462, 5513.116243771446, 5515.117581186991, 1042.4058286776465, 1157.89578937896, 1187.4300335838673, 1225.7180848404917, 1244.321844594698, 846.9407141500036, 862.5557837713583, 867.8915135608049, 867.9194402968345, 869.873513799631, 4299.484061912528, 4360.629346505519, 4604.8388306409115, 4658.277966915133, 5021.322121513622, 4428.4243048403505, 4610.677252592353, 4780.565830250911, 5170.8448746536915, 5402.459754024645, 4291.527931927485, 4526.23054080807, 4616.030633566921, 4653.906921861544, 4772.611445873399, 2505.3486093615425, 2736.5758307462374, 2794.5389010812987, 2796.958045629317, 2811.5820394460748, 4274.444322238089, 4740.410828947765, 4905.351110400416, 5546.861328466821, 5547.5007249347755, 4366.956330436718, 5052.242163675404, 5404.864878378072, 5436.700981446058, 5442.673439593637, 4556.384888040072, 5466.141511885899, 5519.337679478408, 5543.750531226105, 5649.180868774005, 4619.5611416915335, 5110.97444512775, 5255.448177941261, 5358.258565965999, 5531.045302608654, 4679.742614156254, 5625.296837895263, 5635.8591035224445, 5643.463870932255, 5647.971760141173, 5851.21008663825, 5863.824085277449, 5894.970525147347, 5911.408859114054, 5916.408359164049, 3573.874914377984, 3786.6402691744242, 3796.7911764853197, 3834.67405270544, 3850.8267127978747, 5625.103071917883, 5637.689927054052, 5647.639654405622, 5699.629524080921, 5721.370649228498, 5037.5214354636255, 5129.076766182123, 5311.468853114658, 5316.388615309134, 5571.462121552762, 4688.991866748665, 5235.63350565472, 5250.63215826262, 5329.147336426153, 5529.806456773994, 4472.9776351118035, 5302.946970530245, 5327.680339179662, 5330.387005494418, 5332.653377530603, 4619.736329198736, 4723.197056500335, 5265.998380922837, 5269.656237659526, 5425.83722488326, 5332.9466705334, 5361.5710743141235, 5369.4093649697725, 5395.56835453155, 5473.945260547343], "value": 3891.075647843494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4813889582813, 700.1143553404944, 719.8092505486047, 732.5714457042629, 743.8066102813267, 13557.11878727882, 13569.0, 13586.864131358709, 13609.979251556137, 13612.455501779928, 12834.614961551146, 12842.293673847935, 12851.742965140715, 12960.870391296085, 12961.222326660407, 649.6037417175519, 673.3165836675778, 678.7285085965603, 794.9602519873984, 805.0942689474341, 828.6271177969908, 829.9917000830005, 830.9986466308085, 831.1978940322588, 832.0930186097153, 862.6420035685184, 864.2955990867423, 864.3258258558303, 864.9783755406133, 867.1371984875027, 697.7801992372412, 720.1574158234878, 721.855628874222, 722.0793488302456, 856.4304737349686, 533.3706226652548, 623.1805176193292, 640.0942666127424, 644.5520363347475, 645.1129696667083, 14251.501197458143, 14251.643708907257, 14252.287385630678, 14252.358643860947, 14270.286485675779, 12658.303793291365, 12884.109964124818, 13033.543825966046, 13047.86952130476, 13150.73698526024, 11606.30362178272, 11841.171118021743, 11921.403929803475, 12198.695032624166, 12326.568570100004, 4244.129953359554, 4296.74219546825, 4325.718828276184, 4339.370791235285, 4436.157130145262, 82459.0, 82792.0, 83283.33433331299, 87486.0, 87491.56254218752, 10170.389776613427, 10304.536295866705, 10385.792284154275, 10419.791604168026, 10513.84229236562, 19731.704024439645, 19750.0, 19848.0, 19930.800691992896, 20046.0, 7168.211496735355, 7284.344409003215, 7304.780856574312, 7540.095188577406, 7545.773626791205, 4070.470838790938, 4127.979360103241, 4183.748975061506, 4200.894977625584, 4351.8694439166875, 2733.72662733725, 3289.687479689426, 3345.5483509725877, 3354.3291341731265, 3359.10983589349, 533.6184627991005, 610.9755609775648, 611.5688439650125, 639.3223183425583, 641.1056576076347, 515.5205658737335, 545.38916413617, 578.991315130265, 586.1331658667159, 633.56917296239, 8056.436049476598, 8422.705205317785, 8459.111793261618, 8495.980482342158, 8618.827623447496, 590.5924911810837, 601.4677010845434, 610.5512448350458, 630.7949916277229, 635.7997230872353, 4091.9590804091577, 4273.722208056466, 4274.059706864485, 4313.525512193656, 4336.371226172188, 78962.60518697485, 92376.0, 116269.4186529062, 119370.0, 124251.0, 102050.48974755227, 104944.47527762465, 105072.42391363982, 105942.47028764807, 106586.0, 87840.0, 88360.0, 88406.55796721103, 88442.0, 91537.54231228802, 8317.667293308199, 8340.582970851554, 8345.916540834756, 8495.405321627673, 8528.317734581095, 57344.42655573391, 57677.0, 57895.71052144712, 60388.396116038275, 61075.0, 54419.0, 54579.72710136424, 58450.0, 68273.31726682669, 81959.0, 10279.640212592523, 10490.265681402228, 10618.628348007782, 10680.62617808373, 10892.727681808019, 10722.731931701457, 11300.265482743594, 11514.42427878586, 11586.304821710724, 11687.590934317259, 10153.289269751047, 10228.59085636596, 10430.165586753194, 10866.891331086588, 12308.199967002116, 12057.336846473178, 12749.553765618159, 12879.420426081037, 12965.02762292813, 12971.740565188455, 12466.937665311978, 12507.061970352443, 12511.311877846805, 12686.985041196498, 12762.808557871826, 10443.843342349719, 10867.836982445111, 11055.557777689124, 11337.489812958273, 11385.715357116138, 10167.339122956984, 10790.784184316426, 10938.781224375627, 10955.397453140155, 11219.214654974074], "value": 7020.603233611651, "unit": "score"}], "name": "dromaeo_css", "value": 6975.467570885981, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 114.0, 113.0, 115.0, 114.0, 123.0, 168.0, 114.0], "value": 120.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 112.0, 155.0, 145.0, 111.0, 108.0, 120.0, 124.0, 132.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 182.0, 182.0, 182.0, 185.0, 184.0, 181.0, 183.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 59.0, 88.0, 59.0, 58.0, 59.0, 58.0, 81.0, 57.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 92.0, 68.0, 68.0, 69.0, 88.0, 66.0, 70.0, 92.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 85.0, 86.0, 84.0, 87.0, 85.0, 86.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 105.0, 94.0, 93.0, 107.0, 135.0, 93.0, 102.0, 93.0, 94.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 81.0, 82.0, 82.0, 81.0, 82.0, 86.0, 80.0, 84.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 57.0, 59.0, 58.0, 60.0, 58.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 69.0, 81.0, 76.0, 69.0, 71.0, 70.0, 71.0, 75.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 82.0, 102.0, 97.0, 101.0, 94.0, 84.0, 84.0, 85.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 139.0, 138.0, 138.0, 141.0, 142.0, 145.0, 142.0, 193.0, 167.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 220.0, 205.0, 165.0, 164.0, 165.0, 163.0, 165.0, 165.0, 176.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 63.0, 75.0, 87.0, 82.0, 85.0, 84.0, 65.0, 64.0], "value": 74.5, "unit": "score"}], "name": "kraken", "value": 1465.3, "alertThreshold": 2.0}]} 21:29:30 INFO - Return code: 0 21:29:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:29:30 INFO - # TBPL SUCCESS # 21:29:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:29:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:29:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:29:30 INFO - 2017-01-11 21:29:30.535 screenresolution[1658:10553] starting screenresolution argv=screenresolution get 21:29:30 INFO - 2017-01-11 21:29:30.538 screenresolution[1658:10553] Display 0: 1600x1200x32@60 21:29:30 INFO - 2017-01-11 21:29:30.545 screenresolution[1659:10556] starting screenresolution argv=screenresolution list 21:29:30 INFO - Available Modes on Display 0 21:29:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:29:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:29:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:29:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:29:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:29:30 INFO - Intel Iris: 21:29:30 INFO - Chipset Model: Intel Iris 21:29:30 INFO - Type: GPU 21:29:30 INFO - Bus: Built-In 21:29:30 INFO - VRAM (Dynamic, Max): 1536 MB 21:29:30 INFO - Vendor: Intel (0x8086) 21:29:30 INFO - Device ID: 0x0a2e 21:29:30 INFO - Revision ID: 0x0009 21:29:30 INFO - Displays: 21:29:30 INFO - Display: 21:29:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:29:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:29:30 INFO - Display Serial Number: 1600x1200 60 21:29:30 INFO - Main Display: Yes 21:29:30 INFO - Mirror: Off 21:29:30 INFO - Online: Yes 21:29:30 INFO - Rotation: Supported 21:29:30 INFO - Return code: 0 21:29:30 INFO - Running post-action listener: _resource_record_post_action 21:29:30 INFO - [mozharness: 2017-01-12 05:29:30.789949Z] Finished run-tests step (success) 21:29:30 INFO - Running post-run listener: _resource_record_post_run 21:29:30 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32545792; Write bytes: 660470784; Read time: 197; Write time: 1912 21:29:30 INFO - TinderboxPrint: CPU usage
53.5% 21:29:30 INFO - TinderboxPrint: I/O read bytes / time
32,545,792 / 197 21:29:30 INFO - TinderboxPrint: I/O write bytes / time
660,470,784 / 1,912 21:29:30 INFO - TinderboxPrint: CPU idle
2,249.7 (46.5%) 21:29:30 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 21:29:30 INFO - TinderboxPrint: CPU user
1,619.1 (33.5%) 21:29:30 INFO - TinderboxPrint: Swap in / out
378,249,216 / 0 21:29:30 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 346401280; Write bytes: 346310656; Read time: 26671; Write time: 719 21:29:30 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30522368; Write bytes: 307139584; Read time: 180; Write time: 1164 21:29:31 INFO - Running post-run listener: _upload_blobber_files 21:29:31 INFO - Blob upload gear active. 21:29:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:29:31 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 21:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:29:31 INFO - (blobuploader) - INFO - Open directory for files ... 21:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:32 INFO - (blobuploader) - INFO - Done attempting. 21:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:33 INFO - (blobuploader) - INFO - Done attempting. 21:29:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:29:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:29:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:36 INFO - (blobuploader) - INFO - Done attempting. 21:29:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:29:36 INFO - Return code: 0 21:29:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:29:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:29:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ae6b17319538036503f0f665ecf86b284bd7bf7f1243e7d48c13cb3ce5dd857e63149c3373253e4d9617ef84909f21d857fb9e8335d4f98d4747dc24590865b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01b6b34168efec66db6c67aa723e1f40f369c314ae6c7045fafe0be73abef684485d161238928f4a3d66401c68136c5d404eadf8433562c5fb52fc5242df7ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f91e418843b5f54b526eec6a219eda603a4f403f657272c43e0ccccc083c1f1fe623f9cdea08ecf1bb32b67b27561d3523af6f988db1a1ae5883027b7d5a17a1"} 21:29:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:29:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:29:36 INFO - Contents: 21:29:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ae6b17319538036503f0f665ecf86b284bd7bf7f1243e7d48c13cb3ce5dd857e63149c3373253e4d9617ef84909f21d857fb9e8335d4f98d4747dc24590865b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01b6b34168efec66db6c67aa723e1f40f369c314ae6c7045fafe0be73abef684485d161238928f4a3d66401c68136c5d404eadf8433562c5fb52fc5242df7ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f91e418843b5f54b526eec6a219eda603a4f403f657272c43e0ccccc083c1f1fe623f9cdea08ecf1bb32b67b27561d3523af6f988db1a1ae5883027b7d5a17a1"} 21:29:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:29:36 INFO - Copying logs to upload dir... 21:29:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:29:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.096317 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-11 21:29:36.213963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 21:29:36.217516) ========= 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.j60vKIJHxx/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.SMpe8n6kY5/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ae6b17319538036503f0f665ecf86b284bd7bf7f1243e7d48c13cb3ce5dd857e63149c3373253e4d9617ef84909f21d857fb9e8335d4f98d4747dc24590865b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01b6b34168efec66db6c67aa723e1f40f369c314ae6c7045fafe0be73abef684485d161238928f4a3d66401c68136c5d404eadf8433562c5fb52fc5242df7ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f91e418843b5f54b526eec6a219eda603a4f403f657272c43e0ccccc083c1f1fe623f9cdea08ecf1bb32b67b27561d3523af6f988db1a1ae5883027b7d5a17a1"} build_url:https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011048 build_url: 'https://queue.taskcluster.net/v1/task/Og0lMSOuTtis1c1qo5EN7A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ae6b17319538036503f0f665ecf86b284bd7bf7f1243e7d48c13cb3ce5dd857e63149c3373253e4d9617ef84909f21d857fb9e8335d4f98d4747dc24590865b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01b6b34168efec66db6c67aa723e1f40f369c314ae6c7045fafe0be73abef684485d161238928f4a3d66401c68136c5d404eadf8433562c5fb52fc5242df7ad7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f91e418843b5f54b526eec6a219eda603a4f403f657272c43e0ccccc083c1f1fe623f9cdea08ecf1bb32b67b27561d3523af6f988db1a1ae5883027b7d5a17a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 21:29:36.252096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 21:29:36.252421) ========= 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.j60vKIJHxx/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.SMpe8n6kY5/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.005039 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 21:29:36.301861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 21:29:36.302238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 21:29:36.302660) ========= ========= Total master_lag: 0.18 =========