builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1480252199.57 results: success (0) buildid: 20161127030208 builduid: 9e07daac04eb472fa45bf8c774080d1f revision: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 05:09:59.569078) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 05:09:59.569673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 05:09:59.569988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 05:09:59.597414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:09:59.597803) ========= 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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 --2016-11-27 05:09:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.4M=0s 2016-11-27 05:10:00 (29.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.511052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:10:00.133387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:10:00.133718) ========= 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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.027153 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:10:00.183638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-27 05:10:00.184022) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a0abcff5cfce087c12f3e4820b5e8b773cffaca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2a0abcff5cfce087c12f3e4820b5e8b773cffaca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 2016-11-27 05:10:00,279 truncating revision to first 12 chars 2016-11-27 05:10:00,279 Setting DEBUG logging. 2016-11-27 05:10:00,279 attempt 1/10 2016-11-27 05:10:00,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a0abcff5cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 05:10:01,527 unpacking tar archive at: mozilla-central-2a0abcff5cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.537617 ========= master_lag: 0.65 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-27 05:10:02.366988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 05:10:02.367319) ========= script_repo_revision: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 05:10:02.367707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 05:10:02.367993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 05:10:02.389630) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-27 05:10:02.389898) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:02 INFO - MultiFileLogger online at 20161127 05:10:02 in /builds/slave/test 05:10:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:10:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:02 INFO - {'append_to_log': False, 05:10:02 INFO - 'base_work_dir': '/builds/slave/test', 05:10:02 INFO - 'blob_upload_branch': 'Firefox', 05:10:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:02 INFO - 'branch': 'Firefox', 05:10:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:02 INFO - 'config_files': ('talos/mac_config.py',), 05:10:02 INFO - 'default_actions': ('clobber', 05:10:02 INFO - 'read-buildbot-config', 05:10:02 INFO - 'download-and-extract', 05:10:02 INFO - 'populate-webroot', 05:10:02 INFO - 'create-virtualenv', 05:10:02 INFO - 'install', 05:10:02 INFO - 'run-tests'), 05:10:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:02 INFO - 'download_minidump_stackwalk': True, 05:10:02 INFO - 'download_symbols': 'ondemand', 05:10:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:02 INFO - 'installer_path': 'installer.exe', 05:10:02 INFO - 'log_level': 'info', 05:10:02 INFO - 'log_name': 'talos', 05:10:02 INFO - 'log_to_console': True, 05:10:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:10:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:10:02 INFO - 'opt_config_files': (), 05:10:02 INFO - 'pip_index': False, 05:10:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:02 INFO - 'cmd': ('bash', 05:10:02 INFO - '-c', 05:10:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:02 INFO - 'enabled': True, 05:10:02 INFO - 'halt_on_failure': False, 05:10:02 INFO - 'name': 'check_screen_resolution'},), 05:10:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:02 INFO - 'cmd': ('bash', 05:10:02 INFO - '-c', 05:10:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:02 INFO - 'enabled': True, 05:10:02 INFO - 'halt_on_failure': False, 05:10:02 INFO - 'name': 'check_screen_resolution'},), 05:10:02 INFO - 'run_cmd_checks_enabled': True, 05:10:02 INFO - 'sps_profile': False, 05:10:02 INFO - 'sps_profile_interval': 0, 05:10:02 INFO - 'suite': 'dromaeojs', 05:10:02 INFO - 'system_bits': '32', 05:10:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:02 INFO - 'title': 't-yosemite-r7-0060', 05:10:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:02 INFO - 'use_talos_json': True, 05:10:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:02 INFO - 'work_dir': 'build'} 05:10:02 INFO - [mozharness: 2016-11-27 13:10:02.594252Z] Running clobber step. 05:10:02 INFO - Running pre-action listener: _resource_record_pre_action 05:10:02 INFO - Running main action method: clobber 05:10:02 INFO - rmtree: /builds/slave/test/build 05:10:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:04 INFO - Running post-action listener: _resource_record_post_action 05:10:04 INFO - [mozharness: 2016-11-27 13:10:04.674589Z] Finished clobber step (success) 05:10:04 INFO - [mozharness: 2016-11-27 13:10:04.674765Z] Running read-buildbot-config step. 05:10:04 INFO - Running pre-action listener: _resource_record_pre_action 05:10:04 INFO - Running main action method: read_buildbot_config 05:10:04 INFO - Using buildbot properties: 05:10:04 INFO - { 05:10:04 INFO - "project": "", 05:10:04 INFO - "product": "firefox", 05:10:04 INFO - "script_repo_revision": "production", 05:10:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:10:04 INFO - "repository": "", 05:10:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:10:04 INFO - "buildid": "20161127030208", 05:10:04 INFO - "stage_platform": "macosx64", 05:10:04 INFO - "basedir": "/builds/slave/test", 05:10:04 INFO - "nightly_build": "True", 05:10:04 INFO - "buildnumber": 34, 05:10:04 INFO - "slavename": "t-yosemite-r7-0060", 05:10:04 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:10:04 INFO - "platform": "yosemite_r7", 05:10:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:10:04 INFO - "branch": "mozilla-central", 05:10:04 INFO - "repo_path": "mozilla-central", 05:10:04 INFO - "revision": "2a0abcff5cfce087c12f3e4820b5e8b773cffaca", 05:10:04 INFO - "pgo_build": "False", 05:10:04 INFO - "builduid": "9e07daac04eb472fa45bf8c774080d1f", 05:10:04 INFO - "slavebuilddir": "test" 05:10:04 INFO - } 05:10:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:10:04 INFO - Running post-action listener: _resource_record_post_action 05:10:04 INFO - [mozharness: 2016-11-27 13:10:04.678156Z] Finished read-buildbot-config step (success) 05:10:04 INFO - [mozharness: 2016-11-27 13:10:04.678294Z] Running download-and-extract step. 05:10:04 INFO - Running pre-action listener: _resource_record_pre_action 05:10:04 INFO - Running main action method: download_and_extract 05:10:04 INFO - mkdir: /builds/slave/test/build/tests 05:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:04 INFO - trying https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:10:04 INFO - Downloading https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:10:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 05:10:05 INFO - Downloaded 1199 bytes. 05:10:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:10:05 INFO - Using the following test package requirements: 05:10:05 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:10:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:10:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:10:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'jsshell-mac.zip'], 05:10:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:10:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:10:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:10:05 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:10:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:10:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:10:05 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:10:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:10:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:10:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:05 INFO - Fetch https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:10:06 INFO - Http code: 200 05:10:06 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 05:10:06 INFO - x-amz-cf-id: vDlNyuoAYUh812TPcRcuGDaWRteyehynO-05cYC5vc0DQEe5GIBcHA== 05:10:06 INFO - x-amz-version-id: nLmwaBfCNaTHoiBadPDmobn6p3zh_Cl_ 05:10:06 INFO - Expected file size: 16282663 05:10:06 INFO - Obtained file size: 16282663 05:10:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:10:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:10:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:13 INFO - Fetch https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:10:13 INFO - Http code: 200 05:10:13 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:10:13 INFO - x-amz-cf-id: jB2tbe6qI_XU-65DlhZicELJKAeU145cpwbCd_N7yC2GA28zNN9PXg== 05:10:13 INFO - x-amz-version-id: nLmwaBfCNaTHoiBadPDmobn6p3zh_Cl_ 05:10:14 INFO - Expected file size: 16282663 05:10:14 INFO - Obtained file size: 16282663 05:10:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:10:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:10:20 INFO - Fetch https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:10:21 INFO - Http code: 200 05:10:21 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 05:10:21 INFO - x-amz-cf-id: bxRBKuOO2ArgsR-mPwRKR-M-TPDyzk4X3_TY_A9--vfCrlRui9Nfmg== 05:10:21 INFO - x-amz-version-id: XH42sGlh.Y94hUF5p_QTFuB5BuzVV2n_ 05:10:21 INFO - Expected file size: 14409702 05:10:21 INFO - Obtained file size: 14409702 05:10:21 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')]} 05:10:21 INFO - trying https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:10:21 INFO - Downloading https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 05:10:24 INFO - Downloaded 107719733 bytes. 05:10:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:10:24 INFO - mkdir: /builds/slave/test/properties 05:10:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:24 INFO - Contents: 05:10:24 INFO - build_url:https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:10:25 INFO - Running post-action listener: _resource_record_post_action 05:10:25 INFO - Running post-action listener: set_extra_try_arguments 05:10:25 INFO - [mozharness: 2016-11-27 13:10:25.161956Z] Finished download-and-extract step (success) 05:10:25 INFO - [mozharness: 2016-11-27 13:10:25.162092Z] Running populate-webroot step. 05:10:25 INFO - Running pre-action listener: _resource_record_pre_action 05:10:25 INFO - Running main action method: populate_webroot 05:10:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:25 INFO - '--tppagecycles', 05:10:25 INFO - '7'], 05:10:25 INFO - 'tests': ['tsvgm']}}, 05:10:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['damp', 'tps']}, 05:10:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'tests': ['damp', 'tps']}, 05:10:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['dromaeo_dom']}, 05:10:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['basic_compositor_video']}, 05:10:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:10:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['a11yr', 05:10:25 INFO - 'ts_paint', 05:10:25 INFO - 'tpaint', 05:10:25 INFO - 'sessionrestore', 05:10:25 INFO - 'sessionrestore_no_auto_restore', 05:10:25 INFO - 'tabpaint']}, 05:10:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tsvgx', 05:10:25 INFO - 'tsvgr_opacity', 05:10:25 INFO - 'tart', 05:10:25 INFO - 'tscrollx', 05:10:25 INFO - 'cart', 05:10:25 INFO - 'tsvg_static']}, 05:10:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:25 INFO - 'tsvgr_opacity', 05:10:25 INFO - 'tart', 05:10:25 INFO - 'tscrollx', 05:10:25 INFO - 'cart', 05:10:25 INFO - 'tsvg_static']}, 05:10:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s'], 05:10:25 INFO - 'tests': ['tp5o']}, 05:10:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:10:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--disable-e10s', 05:10:25 INFO - '--xperf_path', 05:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:25 INFO - 'tests': ['tp5n']}, 05:10:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:10:25 INFO - 'talos_options': ['--xperf_path', 05:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:25 INFO - 'tests': ['tp5n']}}, 05:10:25 INFO - 'talos.zip': {'path': '', 05:10:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:25 INFO - Running post-action listener: _resource_record_post_action 05:10:25 INFO - [mozharness: 2016-11-27 13:10:25.180682Z] Finished populate-webroot step (success) 05:10:25 INFO - [mozharness: 2016-11-27 13:10:25.180817Z] Running create-virtualenv step. 05:10:25 INFO - Running pre-action listener: _resource_record_pre_action 05:10:25 INFO - Running main action method: create_virtualenv 05:10:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:25 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 05:10:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:25 INFO - Using real prefix '/tools/python27' 05:10:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:28 INFO - Installing pip.................done. 05:10:28 INFO - Return code: 0 05:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:10:29 INFO - Reading from file tmpfile_stdout 05:10:29 INFO - Output received: 05:10:29 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) 05:10:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:29 INFO - 'HOME': '/Users/cltbld', 05:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:29 INFO - 'LOGNAME': 'cltbld', 05:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:29 INFO - 'MOZ_NO_REMOTE': '1', 05:10:29 INFO - 'NO_EM_RESTART': '1', 05:10:29 INFO - 'PAGER': '/bin/cat', 05:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:29 INFO - 'PWD': '/builds/slave/test', 05:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:29 INFO - 'SHELL': '/bin/bash', 05:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:29 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:29 INFO - 'USER': 'cltbld', 05:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:29 INFO - 'XPC_FLAGS': '0x0', 05:10:29 INFO - 'XPC_SERVICE_NAME': '0', 05:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:29 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 05:10:29 INFO - Cleaning up... 05:10:29 INFO - Return code: 0 05:10:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:29 INFO - 'HOME': '/Users/cltbld', 05:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:29 INFO - 'LOGNAME': 'cltbld', 05:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:29 INFO - 'MOZ_NO_REMOTE': '1', 05:10:29 INFO - 'NO_EM_RESTART': '1', 05:10:29 INFO - 'PAGER': '/bin/cat', 05:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:29 INFO - 'PWD': '/builds/slave/test', 05:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:29 INFO - 'SHELL': '/bin/bash', 05:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:29 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:29 INFO - 'USER': 'cltbld', 05:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:29 INFO - 'XPC_FLAGS': '0x0', 05:10:29 INFO - 'XPC_SERVICE_NAME': '0', 05:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:29 INFO - Downloading/unpacking psutil>=3.1.1 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:33 INFO - Installing collected packages: psutil 05:10:33 INFO - Running setup.py install for psutil 05:10:33 INFO - building 'psutil._psutil_osx' extension 05:10:33 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 05:10:34 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 05:10:34 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 05:10:34 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 05:10:34 INFO - building 'psutil._psutil_posix' extension 05:10:34 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 05:10:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:10:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:10:34 INFO - ^ 05:10:34 INFO - 1 warning generated. 05:10:34 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 05:10:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:34 INFO - Successfully installed psutil 05:10:34 INFO - Cleaning up... 05:10:34 INFO - Return code: 0 05:10:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:34 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')]} 05:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:34 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')]} 05:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:34 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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:34 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 05:10:34 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 05:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:34 INFO - 'HOME': '/Users/cltbld', 05:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:34 INFO - 'LOGNAME': 'cltbld', 05:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:34 INFO - 'MOZ_NO_REMOTE': '1', 05:10:34 INFO - 'NO_EM_RESTART': '1', 05:10:34 INFO - 'PAGER': '/bin/cat', 05:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:34 INFO - 'PWD': '/builds/slave/test', 05:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:34 INFO - 'SHELL': '/bin/bash', 05:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:34 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:34 INFO - 'USER': 'cltbld', 05:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:34 INFO - 'XPC_FLAGS': '0x0', 05:10:34 INFO - 'XPC_SERVICE_NAME': '0', 05:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:35 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 05:10:35 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 05:10:35 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 05:10:35 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 05:10:35 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 05:10:35 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 05:10:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:37 INFO - Installing collected packages: mozsystemmonitor 05:10:37 INFO - Running setup.py install for mozsystemmonitor 05:10:37 INFO - Successfully installed mozsystemmonitor 05:10:37 INFO - Cleaning up... 05:10:37 INFO - Return code: 0 05:10:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:37 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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:37 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 05:10:37 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 05:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:37 INFO - 'HOME': '/Users/cltbld', 05:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:37 INFO - 'LOGNAME': 'cltbld', 05:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:37 INFO - 'MOZ_NO_REMOTE': '1', 05:10:37 INFO - 'NO_EM_RESTART': '1', 05:10:37 INFO - 'PAGER': '/bin/cat', 05:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:37 INFO - 'PWD': '/builds/slave/test', 05:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:37 INFO - 'SHELL': '/bin/bash', 05:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:37 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:37 INFO - 'USER': 'cltbld', 05:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:37 INFO - 'XPC_FLAGS': '0x0', 05:10:37 INFO - 'XPC_SERVICE_NAME': '0', 05:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:40 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 05:10:40 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 05:10:40 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 05:10:40 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 05:10:40 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 05:10:40 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 05:10:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:41 INFO - warning: no files found matching '*.txt' 05:10:41 INFO - no previously-included directories found matching 'build' 05:10:41 INFO - no previously-included directories found matching 'dist' 05:10:41 INFO - no previously-included directories found matching '.git*' 05:10:41 INFO - Installing collected packages: jsonschema, functools32 05:10:41 INFO - Running setup.py install for functools32 05:10:41 INFO - warning: no files found matching '*.txt' 05:10:41 INFO - no previously-included directories found matching 'build' 05:10:41 INFO - no previously-included directories found matching 'dist' 05:10:41 INFO - no previously-included directories found matching '.git*' 05:10:41 INFO - Successfully installed jsonschema functools32 05:10:41 INFO - Cleaning up... 05:10:41 INFO - Return code: 0 05:10:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:41 INFO - 'HOME': '/Users/cltbld', 05:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:41 INFO - 'LOGNAME': 'cltbld', 05:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:41 INFO - 'MOZ_NO_REMOTE': '1', 05:10:41 INFO - 'NO_EM_RESTART': '1', 05:10:41 INFO - 'PAGER': '/bin/cat', 05:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:41 INFO - 'PWD': '/builds/slave/test', 05:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:41 INFO - 'SHELL': '/bin/bash', 05:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:41 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:41 INFO - 'USER': 'cltbld', 05:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:41 INFO - 'XPC_FLAGS': '0x0', 05:10:41 INFO - 'XPC_SERVICE_NAME': '0', 05:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:10:41 INFO - Cleaning up... 05:10:41 INFO - Return code: 0 05:10:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:41 INFO - 'HOME': '/Users/cltbld', 05:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:41 INFO - 'LOGNAME': 'cltbld', 05:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:41 INFO - 'MOZ_NO_REMOTE': '1', 05:10:41 INFO - 'NO_EM_RESTART': '1', 05:10:41 INFO - 'PAGER': '/bin/cat', 05:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:41 INFO - 'PWD': '/builds/slave/test', 05:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:41 INFO - 'SHELL': '/bin/bash', 05:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:41 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:41 INFO - 'USER': 'cltbld', 05:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:41 INFO - 'XPC_FLAGS': '0x0', 05:10:41 INFO - 'XPC_SERVICE_NAME': '0', 05:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:42 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 05:10:42 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 05:10:42 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 05:10:42 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 05:10:42 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 05:10:42 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 05:10:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:45 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 05:10:45 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 05:10:45 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 05:10:45 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 05:10:45 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 05:10:45 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 05:10:45 INFO - Downloading docopt-0.6.1.tar.gz 05:10:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:45 INFO - Running setup.py install for blobuploader 05:10:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:46 INFO - Running setup.py install for requests 05:10:46 INFO - Running setup.py install for docopt 05:10:46 INFO - Successfully installed blobuploader requests docopt 05:10:46 INFO - Cleaning up... 05:10:46 INFO - Return code: 0 05:10:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:46 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')]} 05:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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')]} 05:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:46 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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:46 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 05:10:46 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 05:10:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:46 INFO - 'HOME': '/Users/cltbld', 05:10:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:46 INFO - 'LOGNAME': 'cltbld', 05:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:46 INFO - 'MOZ_NO_REMOTE': '1', 05:10:46 INFO - 'NO_EM_RESTART': '1', 05:10:46 INFO - 'PAGER': '/bin/cat', 05:10:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:46 INFO - 'PWD': '/builds/slave/test', 05:10:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:46 INFO - 'SHELL': '/bin/bash', 05:10:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:46 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:46 INFO - 'USER': 'cltbld', 05:10:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:46 INFO - 'XPC_FLAGS': '0x0', 05:10:46 INFO - 'XPC_SERVICE_NAME': '0', 05:10:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-4rEgSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-L_6HoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-SmuTi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-TJPcTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-l6F64N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-MgUM5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-yS8R50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-v9EPGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-OVONDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-upczT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-jOFSzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-EjkT3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-XYhxOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-MXDSfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-9B1ISf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-gTIZcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:48 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-7l3UYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:48 INFO - Running setup.py install for manifestparser 05:10:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:48 INFO - Running setup.py install for mozcrash 05:10:49 INFO - Running setup.py install for mozdebug 05:10:49 INFO - Running setup.py install for mozdevice 05:10:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozfile 05:10:49 INFO - Running setup.py install for mozhttpd 05:10:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozinfo 05:10:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozInstall 05:10:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozleak 05:10:50 INFO - Running setup.py install for mozlog 05:10:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for moznetwork 05:10:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozprocess 05:10:50 INFO - Running setup.py install for mozprofile 05:10:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozrunner 05:10:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozscreenshot 05:10:51 INFO - Running setup.py install for moztest 05:10:51 INFO - Running setup.py install for mozversion 05:10:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:51 INFO - Cleaning up... 05:10:51 INFO - Return code: 0 05:10:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:51 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 05:10:51 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 05:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:51 INFO - 'HOME': '/Users/cltbld', 05:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:51 INFO - 'LOGNAME': 'cltbld', 05:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:51 INFO - 'MOZ_NO_REMOTE': '1', 05:10:51 INFO - 'NO_EM_RESTART': '1', 05:10:51 INFO - 'PAGER': '/bin/cat', 05:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:51 INFO - 'PWD': '/builds/slave/test', 05:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:51 INFO - 'SHELL': '/bin/bash', 05:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:51 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:51 INFO - 'USER': 'cltbld', 05:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:51 INFO - 'XPC_FLAGS': '0x0', 05:10:51 INFO - 'XPC_SERVICE_NAME': '0', 05:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-wr9RGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-70lfV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-GyGUgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:51 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-zZ83i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Ovcrf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-90BFvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-kgTfkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-rWpc6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-flpdSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-7EnaZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-HVd_xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-bBaN4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:52 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-gdCvqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:53 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-CPd7p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:53 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-cL60m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:53 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:53 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-SAr5HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:53 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Ri6xoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:53 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)) 05:10:53 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)) 05:10:53 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)) 05:10:53 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)) 05:10:53 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:53 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:53 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 05:10:53 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 05:10:53 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 05:10:53 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 05:10:53 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 05:10:53 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 05:10:56 INFO - Downloading blessings-1.6.tar.gz 05:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:56 INFO - Installing collected packages: blessings 05:10:56 INFO - Running setup.py install for blessings 05:10:56 INFO - Successfully installed blessings 05:10:56 INFO - Cleaning up... 05:10:56 INFO - Return code: 0 05:10:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:56 INFO - Reading from file tmpfile_stdout 05:10:56 INFO - Current package versions: 05:10:56 INFO - blessings == 1.6 05:10:56 INFO - blobuploader == 1.2.4 05:10:56 INFO - docopt == 0.6.1 05:10:56 INFO - functools32 == 3.2.3-2 05:10:56 INFO - jsonschema == 2.5.1 05:10:56 INFO - manifestparser == 1.1 05:10:56 INFO - mozInstall == 1.12 05:10:56 INFO - mozcrash == 1.0 05:10:56 INFO - mozdebug == 0.1 05:10:56 INFO - mozdevice == 0.49 05:10:56 INFO - mozfile == 1.2 05:10:56 INFO - mozhttpd == 0.7 05:10:56 INFO - mozinfo == 0.9 05:10:56 INFO - mozleak == 0.1 05:10:56 INFO - mozlog == 3.4 05:10:56 INFO - moznetwork == 0.27 05:10:56 INFO - mozprocess == 0.23 05:10:56 INFO - mozprofile == 0.28 05:10:56 INFO - mozrunner == 6.13 05:10:56 INFO - mozscreenshot == 0.1 05:10:56 INFO - mozsystemmonitor == 0.3 05:10:56 INFO - moztest == 0.7 05:10:56 INFO - mozversion == 1.4 05:10:56 INFO - psutil == 3.1.1 05:10:56 INFO - requests == 1.2.3 05:10:56 INFO - wsgiref == 0.1.2 05:10:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:56 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')]} 05:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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')]} 05:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:56 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 05:10:56 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 05:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:56 INFO - 'HOME': '/Users/cltbld', 05:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:56 INFO - 'LOGNAME': 'cltbld', 05:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:56 INFO - 'MOZ_NO_REMOTE': '1', 05:10:56 INFO - 'NO_EM_RESTART': '1', 05:10:56 INFO - 'PAGER': '/bin/cat', 05:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:56 INFO - 'PWD': '/builds/slave/test', 05:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:56 INFO - 'SHELL': '/bin/bash', 05:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:56 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:56 INFO - 'USER': 'cltbld', 05:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:56 INFO - 'XPC_FLAGS': '0x0', 05:10:56 INFO - 'XPC_SERVICE_NAME': '0', 05:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 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)) 05:10:56 INFO - Cleaning up... 05:10:56 INFO - Return code: 0 05:10:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:56 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')]} 05:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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')]} 05:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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 0x1068413f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a25bb4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, '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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 05:10:56 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 05:10:56 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 05:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:56 INFO - 'HOME': '/Users/cltbld', 05:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:56 INFO - 'LOGNAME': 'cltbld', 05:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:56 INFO - 'MOZ_NO_REMOTE': '1', 05:10:56 INFO - 'NO_EM_RESTART': '1', 05:10:56 INFO - 'PAGER': '/bin/cat', 05:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:56 INFO - 'PWD': '/builds/slave/test', 05:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:56 INFO - 'SHELL': '/bin/bash', 05:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:10:56 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:56 INFO - 'USER': 'cltbld', 05:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:56 INFO - 'XPC_FLAGS': '0x0', 05:10:56 INFO - 'XPC_SERVICE_NAME': '0', 05:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:57 INFO - Cleaning up... 05:10:57 INFO - Return code: 0 05:10:57 INFO - Running post-action listener: _resource_record_post_action 05:10:57 INFO - Running post-action listener: _start_resource_monitoring 05:10:57 INFO - Starting resource monitoring. 05:10:57 INFO - [mozharness: 2016-11-27 13:10:57.277511Z] Finished create-virtualenv step (success) 05:10:57 INFO - [mozharness: 2016-11-27 13:10:57.278579Z] Running install step. 05:10:57 INFO - Running pre-action listener: _resource_record_pre_action 05:10:57 INFO - Running main action method: install 05:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:57 INFO - Reading from file tmpfile_stdout 05:10:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:57 INFO - Reading from file tmpfile_stdout 05:10:57 INFO - Output received: 05:10:57 INFO - Usage: mozinstall [options] installer 05:10:57 INFO - Options: 05:10:57 INFO - -h, --help show this help message and exit 05:10:57 INFO - -d DEST, --destination=DEST 05:10:57 INFO - Directory to install application into. [default: 05:10:57 INFO - "/builds/slave/test"] 05:10:57 INFO - --app=APP Application being installed. [default: firefox] 05:10:57 INFO - mkdir: /builds/slave/test/build/application 05:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:11:30 INFO - Reading from file tmpfile_stdout 05:11:30 INFO - Output received: 05:11:30 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:11:30 INFO - Running post-action listener: _resource_record_post_action 05:11:30 INFO - [mozharness: 2016-11-27 13:11:30.618900Z] Finished install step (success) 05:11:30 INFO - [mozharness: 2016-11-27 13:11:30.619058Z] Running run-tests step. 05:11:30 INFO - Running pre-action listener: _resource_record_pre_action 05:11:30 INFO - Running main action method: run_tests 05:11:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:30 INFO - 2016-11-27 05:11:30.633 screenresolution[1629:7973] starting screenresolution argv=screenresolution get 05:11:30 INFO - 2016-11-27 05:11:30.636 screenresolution[1629:7973] Display 0: 1600x1200x32@60 05:11:30 INFO - 2016-11-27 05:11:30.642 screenresolution[1630:7975] starting screenresolution argv=screenresolution list 05:11:30 INFO - Available Modes on Display 0 05:11:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:30 INFO - Intel Iris: 05:11:30 INFO - Chipset Model: Intel Iris 05:11:30 INFO - Type: GPU 05:11:30 INFO - Bus: Built-In 05:11:30 INFO - VRAM (Dynamic, Max): 1536 MB 05:11:30 INFO - Vendor: Intel (0x8086) 05:11:30 INFO - Device ID: 0x0a2e 05:11:30 INFO - Revision ID: 0x0009 05:11:30 INFO - Displays: 05:11:30 INFO - Display: 05:11:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:30 INFO - Display Serial Number: 1600x1200 60 05:11:30 INFO - Main Display: Yes 05:11:30 INFO - Mirror: Off 05:11:30 INFO - Online: Yes 05:11:30 INFO - Rotation: Supported 05:11:30 INFO - Return code: 0 05:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:30 INFO - Python 2.7.3 05:11:30 INFO - Return code: 0 05:11:30 INFO - grabbing minidump binary from tooltool 05:11:30 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')]} 05:11:30 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 0x106657d30>, '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 0x1064bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10664fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:30 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 05:11:30 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 05:11:30 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 05:11:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:30 INFO - Return code: 0 05:11:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:11:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:11:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 05:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --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 05:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mzBgAl9ufZ/Render', 05:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:31 INFO - 'HOME': '/Users/cltbld', 05:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:31 INFO - 'LOGNAME': 'cltbld', 05:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:31 INFO - 'MOZ_NO_REMOTE': '1', 05:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:31 INFO - 'NO_EM_RESTART': '1', 05:11:31 INFO - 'PAGER': '/bin/cat', 05:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:31 INFO - 'PWD': '/builds/slave/test', 05:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:31 INFO - 'SHELL': '/bin/bash', 05:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ny6KOUAdRb/Listeners', 05:11:31 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 05:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:31 INFO - 'USER': 'cltbld', 05:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:31 INFO - 'XPC_FLAGS': '0x0', 05:11:31 INFO - 'XPC_SERVICE_NAME': '0', 05:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 05:11:31 INFO - mozversion application_buildid: 20161127030208 05:11:31 INFO - mozversion application_changeset: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca 05:11:31 INFO - mozversion application_display_name: Nightly 05:11:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:31 INFO - mozversion application_name: Firefox 05:11:31 INFO - mozversion application_remotingname: firefox 05:11:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:11:31 INFO - mozversion application_vendor: Mozilla 05:11:31 INFO - mozversion application_version: 53.0a1 05:11:31 INFO - mozversion platform_buildid: 20161127030208 05:11:31 INFO - mozversion platform_changeset: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca 05:11:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:11:31 INFO - mozversion platform_version: 53.0a1 05:11:31 INFO - using testdate: 1480252291 05:11:31 INFO - actual date: 1480252291 05:11:31 INFO - starting webserver on 'localhost:49240' 05:11:31 INFO - SUITE-START | Running 2 tests 05:11:31 INFO - TEST-START | dromaeo_css 05:11:31 INFO - operating with platform_type : mac_ 05:11:31 INFO - Initialising browser for dromaeo_css test... 05:11:31 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpMFD2hE/profile http://localhost:49240/getInfo.html) 05:11:33 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 05:11:33 INFO - PROCESS | 1640 | colorDepth:24 05:11:33 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 05:11:33 INFO - PROCESS | 1640 | __metrics 05:11:34 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:11:34 INFO - PROCESS | 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:34 INFO - TEST-INFO | 1640: exit 0 05:11:34 INFO - Browser initialized. 05:11:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:34 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpMFD2hE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:47 INFO - PROCESS | 1644 | RSS: Main: 245063680 05:11:47 INFO - PROCESS | 1644 | 05:12:38 INFO - PROCESS | 1644 | 1480252358039 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:14:53 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 05:14:55 INFO - PROCESS | 1644 | RSS: Main: 393904128 05:14:55 INFO - PROCESS | 1644 | 05:17:58 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 05:17:59 INFO - PROCESS | 1644 | RSS: Main: 394928128 05:17:59 INFO - PROCESS | 1644 | 05:21:01 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 05:21:02 INFO - PROCESS | 1644 | RSS: Main: 346415104 05:21:02 INFO - PROCESS | 1644 | 05:24:04 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 05:24:05 INFO - PROCESS | 1644 | RSS: Main: 354074624 05:24:05 INFO - PROCESS | 1644 | 05:27:08 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 05:27:09 INFO - PROCESS | 1644 | RSS: Main: 334270464 05:27:09 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 05:30:12 INFO - PROCESS | 1644 | RSS: Main: 445857792 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | __start_tp_report 05:30:12 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 05:30:12 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 05:30:12 INFO - PROCESS | 1644 | |i|pagename|runs| 05:30:12 INFO - PROCESS | 1644 | |0;dojo.html;3292.967070329297;3297.4724044152927;3308;3330.9833450832743;3371.578552680915;5551.278333816604;5566.526845218162;5577.609567330289;5626.690532020737;5703.429657034295;5592.0773072443;5610.214569960199;5634.605577609569;5653.010723123447;5654.038813401721;5061.569766569846;5090.643654944155;5105.208692652626;5113.463086375933;5133.614978876581;5194.766235519392;5232.084385232588;5239.292695486099;5246.658967167141;5292.417834038252;5044.8234311798915;5089.440161582223;5200;5202.791888324463;5253.0544501989625;4234.830606775725;5159.793608255665;5167.457416971239;5171.50870667286;5171.637985341028;4184.7070705050655;5013.248012798073;5099.872503187413;5105.9489405106215;5114.820981265638;5043.747812609392;5302.840914772563;5587.944120558783;5591.916121258185;5617.9719101404235;6111.409422667723;6113.241709320084;6115.0578074940495;6117.501829277382;6118.449339559461;6159.784407545714;6247.125402443661;6249.656268905208;6265;6270.247570291549;5682.971585142089;5709.371969083439;5711.571632127607;5715.257016587817;5725.685087320154;6190.907136392868;6275.874482510416;6327.651979141099;6345.7144428499905;6349.68251587428;5998.700064996733;6026.728797204137;6032.457078862835;6059.757609695651;6142.846428839315;6115.487130524749;6176.66028368444;6187.474064704461;6203.844903877439;6215.689215539205;6111.266648002268;6112.847178820565;6118.479929205978;6118.785842495491;6123.84690382744;5982.0727787193055;6062.393760623991;6064.090386442069;6130.846728831815;6139.048447490646;4823.807047718052;4854.805807767721;4866.46468888422;4869.074875773592;4884.3161957326;4322.805473753689;4332.415123958225;4434.733915964988;4436.268015777425;4460.8661740147845;5524.309461317335;5634.239377684042;5683.54531637468;5687.232223649837;5693.943060569424;6162.198914141133;6162.753489860355;6166.383361663798;6169.074638804215;6177.073438984188;4993.251012348104;5578.86052848682;5605.159226116115;5635.436456354331;5669.149627555899;5335.306410166653;5337.092694241988;5343.973280133574;5352.437994010651;5361.437049109865;6346.1432706585865;6347.492200623939;6349.809505714744;6352.015437606993;6360.427561519486;5987.461128498456;6129.450483693955;6137.560853825989;6142.191841058572;6260.561760676709;6335.714892829741;6341.365863413622;6342.080398342307;6354.682265886595;6363.109164717036;4846.636502262274;6118.816435506942;6119.868162944114;6145.432914606747;6146.832101900624;6240.843978900564;6246.718897649525;6246.718897649707;6263.530235232284;6266.624002559861;5973.492253158356;6076.696165191811;6091.5126789857595;6097.085437184458;6107.725152368243;5849.64902105875;5904.261967254093;5907.822765317047;5912.379200183918;6027.397260273938;5791.565632577489;5817.2146760188525;5819.098039803837;5870.0607902735355;5880.441358070976;5872.941270587239;5918.467337939606;5949.494292985145;5955.40445955401;5967.880642387215;5716.857078573069;5777.94222057774;5792.015357389169;5802.912956305574;5810.535157187331 05:30:12 INFO - PROCESS | 1644 | |1;ext.html;448.47080445074806;479.69299648225143;506.5997861689266;512.19073863296;520.1495554767953;30301.24246893826;38472.80763596181;39902.201955960896;39958.80020599893;42613.14773704524;41260.79369603156;41719.58280417195;41725.791371043175;41757.58242417575;41987.58012419875;8391.916080839204;9246.583903724331;9412.105849944279;9417;9435.19800816928;8451.53516556589;11097.778044439106;11354.091672666209;11355.545778168864;11456.942715286412;11148.498317575728;11254.987051165393;11284.943575282154;11331.206815522917;11358.261712988671;11227.989480946713;11283.717907052389;11290.548378064868;11317.886821131766;11319.151063670217;11170.776584468347;11233.887661123366;11259.380734059623;11265.605703800327;11276.887231127666;38856.611433885584;39052.02369940746;39142;39175;39179;3302.9504557431655;3369.6967272945553;3393.372226138172;3485.546878905726;3862.8841134766003;25938.74061259382;28749.281267968257;30183.849080754677;30612.846935765403;30715.078547643607;3129.874805007797;3150.8739650414186;3183.4428974929297;3215.8713651453913;3292.0453068610313;441160;444278;444809;446337;450775;57442.7127864358;57524.71237643785;58696.413035869096;58869.52435232121;59206;49324;59608;59828.10257846136;59909.313149593065;59921;15638.3744650215;15842.366305347658;15850;15868.127253001196;15921.044737315566;11108.500117494732;11343.262687925258;11355.545778168946;12222.26666400001;12306.323152226714;16877.40929067477;16970.745438818427;17221.31114755396;17461.214245358988;17565.824341756674;6839.255989722589;6886.139232595926;6925.515213935077;6966.338197871295;6976.965115174392;876.3164731509432;947.327397547735;1001.7044971733357;1014.452195814252;1091.3997301484153;25855.48289034209;27560.724392756216;28713.138605841857;29365.26586835346;29419.264518386783;924.2282693950492;950.3062764182048;959.5250351076122;1042.3224903812581;1104.2546281260118;14255.572332830032;14397.064190827563;15029;15120.621984450478;15251.247870251445;559975;562841;569077;569956;572169;56227;56305;56450;56466.43533564694;56568.43431565632;1206.9698257543455;1240.0947308464872;1326.7810811216427;1361.6051345109806;1368.7673095573775;29262.975795847044;29587.85206073956;29692.703072968994;30374.696253037186;30429;49359.50640493549;53775.46224537704;55714.88570228492;58509.12236316373;58616.12075818781;460920;463232;463430;463505;466787;24524.632130518414;24931.37671558153;25044.499110017332;25446.872765636053;25800.870995644902;44757.77621111873;44963.32555011743;45561;45561.54438455573;46056.53943460523;37275;37439.43840842444;37711.514909145226;38177.61822381741;38323.23353532858;36784.08039799026;36958.63041369659;37472.64059486067;38090.61909380871;38178.809105955406;36071.09822254465;36344.45483317699;37117.504436724004;37151.25697485981;37190.44214336841;30669.386612268077;33357.83321083379;33763;33776.986690399324;33955.4906676405;19691.212351506354;24229.151979680628;24281.635775463736;24427.14504992317;24981.500369992136 05:30:12 INFO - PROCESS | 1644 | |2;jquery.html;282.47036805988773;348.4059678248586;357.917678933845;362.11101745215507;387.3550538353641;14465.783013254782;14749.778753318695;15652.373905043785;15728.21358932053;19620.509487262825;19540.41378758636;19725.309614163507;19729;20183.899080504612;20411.979401029963;5728.971355143219;5956.106584012389;6099.664518451484;6110.602810817305;6125.326214116466;4731.503192164825;5896.35140134587;6018.518518518508;6602.900956485657;6679.43224825888;6662;6686.1308029956035;6690.866182676368;6694.0962969999155;6700.296468870772;6379.07503412005;6579.736810527597;6606.669666516703;6654;6656.70044847983;4835.371401717789;5507.642003269774;5696.572757043238;5772.538196944234;5788.392218817048;25712.742872571223;25760.969561217527;25898.96404143832;25961;26124.34689132787;2010.9296174633816;2179.934601961928;2476.1581062438677;2628.1852625686097;2893.8697758600915;9904.108630223242;10108.241881858816;10293.228007899437;10427.895721042843;14725.410983560645;1768.3103589600066;1831.8809277396927;1840.7330937014192;1853.9165737541844;1861.7393564900924;98083;110732;115036;116765;116809.41595291969;11131.387773672526;11199.94400028011;11461.312321260584;11484.712882177846;11632.172648351008;13951.720965580835;14363.856361436252;14449;14474.927625361806;14517.128972261698;8144.389170812095;8331.875021874677;8344.541050242173;8358.414910956297;8493.490390576586;6634.900476492857;8070.1526339734655;8178.423796504082;8382.455140415854;8388.454750441324;4378.715383500063;4475.977620111878;4488.865334039984;4558.817647294138;4618.30725391194;1818.7635607370958;1878.1736036144052;1890.5179179309189;1914.6457905287566;1924.124523341876;792.9008873890764;801.8693641964802;804.3806269172704;862;949.2074118111316;18885.244590216513;20304.796952030585;21236.575268494544;21365.185678369537;21891;839.9668407858369;854.717923115327;854.8418542569644;938.1884669760608;975.8048390321964;10581.894181058246;11105.83341249882;11258.268212566158;11312.943435282936;11358.977692007593;407335;525534;546014;565049;566832;103559;124230.75769242372;132422.33788830994;133562;138182;824.6041899888087;970.7670159161751;999.695092996643;1006.3609607899036;1008.9445080520642;17156.485305440856;18566.443006709822;18796.812031880054;18908.621827563646;19395.3211637592;54134.72932635312;55741;55932.44067559273;56023.67775061363;57060;80155.59922200351;80845;82323.5883820577;83130;84630;7060.8940865886025;7982.800429989296;8005.719799806979;8408.789780255542;8470.49177049379;10235.385876847413;11346.716332091764;12364.81452778227;12668.619941401772;13173.934130329288;9434.764130896783;10642.73393165146;10962.725931851768;11254.324740515594;11441.199116061796;10058.446785426871;10240.231982601485;10366.948165259126;10449.9477502612;11615;9485.762855928657;11107.777844442904;11287.266327688674;11742.354170520362;11869.169158158846;6996.755113571001;7060.6116663584;7377.96311018463;7428.888566671396;8536.871946920925;9308.64566223666;11643.59247426336;11741.823872641746;11788.23376480526;11798.705032374259 05:30:12 INFO - PROCESS | 1644 | |3;mootools.html;1319.716261003884;1472.4331132513978;1504.1200897474978;1671.2729962466328;1849.2510533234035;7349.154847192574;7719.073711154662;7972.68109275629;8213.835723285545;8244.711435099773;8135.91864081359;8183.91816081839;8189.795255118625;8190.918090819105;8192.508449493034;1808.8643351748606;2020.333290014299;2257.875816830078;2296.8621882687007;2302.1482051640915;2093.696414019966;2245.124401483423;2316.698829152216;2329.4758679297192;2343.297010896733;2258.7176602924633;2260.4461906832767;2263.0721404224273;2273.056681477185;2278.3278932714807;2274.2608652188023;2296.4144143243366;2300.0914638717613;2301.4361481436986;2302.251768175341;2283.988580057089;2311.110222564308;2312.1329501436962;2317.675525426425;2319.4549280918973;7012.929870701279;8229.876551851727;8304.750857474286;8319.500829950222;8327.541985190812;4615.607673347769;5164.664296820694;5177.430482646906;5184.585233181337;5186.092433824066;2647.827891187086;3346.498025296201;3438.484227365915;3489.755717099804;3498.7201023918024;1001.5643195210107;1049.3336731175682;1075.0754351257913;1077.7251800790748;1083;10725.892741072568;10797.784044319149;10808.459577021118;10835.02484776366;10900.947734634394;4317.956820431818;4567.451905771329;4628.467726211529;4629.907401851944;4638.628909687217;9348.345615806827;9352.251819854395;9371;9372.484513351832;9372.671956481627;5127.2052831811125;5134.332536770271;5138.3577052868395;5141.5886729061585;5151.459096794858;4269.594388533146;4436.201483732959;4506.414166158378;4726.621870250372;4727.149113159596;3507.94738078929;3649.7810131392202;3724.5158129443;3786.3752480840353;3800.1069748609057;1059.2902755154066;1251.8873301402919;1253.4547471849774;1253.5111306590436;1269.752398282326;874.4272501511393;874.91250874912;876.8202518483696;888.7778055486128;902.0122965352928;5552.944470555323;5554.611177217636;5626.212330273765;5779.566532510079;5849.970750146307;920.8158368326361;928.679605536089;930.3162175800916;947.8436058050482;989.9110977924225;3626.8367923443507;3663.413853783382;3747.306748251582;3810.333191691443;3892.7664340139117;9711.125998660154;9969.50152492387;10067.496625168713;10068.04353586408;10081.949590252148;9813;9968.252381071448;10031.097201251923;10032.548535315927;10037.146842518321;7337.853242935218;7668.501547399513;7807.930898311952;7816.101148367897;7816.335611473089;5397.973010134924;5535.363433205233;5734.05388110957;5755.71221438918;5777.133429985536;9043.864342034743;9239;9345.0654934506;9377.953110234404;9433.858492122486;8607.053224145464;8839.248663863644;9187.173154416134;9283.535823208947;9385.671501497414;6500.837479063061;6911.896321555281;7095.8935615964765;7166.820829479305;7171;7245.7826265212125;7430.071241094864;7523.661435235537;7781.844363112593;7806.1803510632835;5959.314678811818;6768.153980752406;6945;6953.408960238234;6990.23107458169;6882.414994725505;6916.896246556406;6919.308069193242;6963;6966.582005079711;6280.246370435577;6547.836304092436;6551.312112228147;6642.667866606747;6647.302033286629;4681.578657920803;4734.384530011076;4788.880277993078;4832.371791667061;4854.538818812207;4815.590674792682;4849.2726091086615;4852.902941941212;4917.065757506062;4986.276989836526 05:30:12 INFO - PROCESS | 1644 | |4;prototype.html;285.43911214463577;290.5061395627434;294.53463527626354;301.35660365120464;307.83376976432726;4232.433999420211;4793.496682848303;5059.519345662161;5162.870928226796;5164;4847.369841920554;4913.680610760298;4957.083903716069;4958;5013.298138260638;3924.274009308273;3927.725059245854;3947.9210415791667;3954.5254569451563;3972.0864201233735;3427.246005878703;3920.8431662733456;3946.171304026158;3976.6421022108007;3987.5813039630857;3774.811259437031;3897.162110146318;3908.9022774430723;3920.3923391874164;3945.9802700986456;3893.902652433669;3897.162110146304;3900.863469778544;3927.8036098194975;3933.656392066749;2834.8015638905285;3401.914952126192;3409.147713071732;3418.8461519231696;3433.8454769535433;4377.649788016983;4801.519848015206;4818.55443366992;5008.749562521859;5036.657954051347;3882.378819388884;3891.0855948851995;4165.250254954107;4453.330001249531;4504.301833215857;4711.670183087185;5139.12634852076;5281.656692314988;5416.458354164592;5444.972775136099;3303.240254741399;3721.6836568891677;3757.135858752475;3770.906437133228;3777.7166712496396;4855.635827312965;5123.257127716461;5284.815031473919;5604.206653870763;5628.380878103405;3798.53756303825;3805.391137418055;3818.255440189192;3825.254075455315;3833.1792398610437;3469.6703813138215;3833.9233215336094;3866.5940076292145;3870.3613903706137;3885.067583779929;4123.371268348986;4224.648112603937;4455.665825063068;4480.641548676098;4488.416505854283;4661.720296782204;5005.923726398769;5016.799328026911;5273.947260527346;5418.620696551204;1040.869891263592;1121.7139629394615;1139.6751925701135;1179.9646010619695;1248;745.970161193557;801.7234054251275;821.482466046387;860.5955201055494;882.7042940614838;4410.360497727812;4722.244440889442;4729.6452766042685;4757.35775670287;4777.402824646919;4571.748553829571;5121.897562048738;5174.715390653475;5219.329814459413;5242.004019236333;3767.6797472215167;3973.1591911782634;4031.7177797554477;4714.929276060861;4756.9762151189025;2213.8118259947764;2697.905573304964;2708.0251109600526;2721.333273348003;2722.7957903157344;4792.784324705397;4957.281194226817;5363.471410648024;5372.7313634318125;5374.48942350476;4769.332293478916;4921.458639549646;5044.335369328113;5184;5281.894362112736;4141.482314710661;4737.360456338351;5086.949130508721;5305.991861546371;5396.946030539644;4562.771861406983;5135.306733590917;5180.274761533464;5184.914975589518;5289.603279754111;4423.778811059498;4827.396575428072;5116.948830511797;5128.333316668809;5157.303763991813;4641.489436161952;5351.254122114613;5351.732413379394;5366.329208848894;5377.354717433933;3074.8936978170027;3185.984070079635;3422.418188907842;3605.8197090145914;3613.9638603613625;4734.384530011076;4781.967663742826;4936.456989731055;5020.0461912238015;5253.369595648546;4560.361549383156;4644.7514308830805;4972.930819873744;4974.403071631427;5050.747462626928;4871.732054737024;4954.777035033504;5010.7745151469;5011.398632164018;5036.6726162799305;4218.978905105455;4422.783734473046;4494.5505449454795;4661.324108004388;4902.9305676289305;4882.194437917704;4968.329275547755;5251.453045273116;5295.4846447936925;5441.564674826083;4945.554900059012;5107.463716309882;5265.289185959847;5292.814751483679;5313 05:30:12 INFO - PROCESS | 1644 | |5;yui.html;697.2887654592316;727.984461675962;758.2985738192173;776.4913981342223;793.6349279331507;14977.925110374446;15082.849171508282;15625.843741562581;15629.062256264631;15632.609184770386;13892.81911037563;14127.434902603909;14127.505537306197;14143.929280353585;14161.433542658282;647.7473785223743;667.6728403082503;798.9001374828147;805.4442434720039;828.9917100828975;817.2195553246635;825.1500954017372;825.2366560931144;828.2090603473698;828.7513745876244;845.3828705045321;877.0746862060523;880.3265501891059;880.5773228850156;881.2949640287776;868.513632365874;874.0647507167333;877.4603618774407;878.3456325037888;879.5997820991465;496.84101087651607;513.2224679610393;519.0941806547598;521.2415934814835;648.6789039425514;10874.347539147677;13673.453061877513;14173.716525669532;14220.431182752678;14493.42026318946;13770.724585508335;13956.441742330295;14007.929960350235;14011.08927919682;14061.437542498288;11341.43292835355;11497.482613282338;11705.941470292679;11711.765764684658;11799.46902389386;3603.40543810271;3653.1232504199065;3655.6344365563496;3673.6326367363317;3784.924301513982;106374;108304;109646;113193.43403283013;116058.41970790092;10748.94625526883;10770.24608277413;10841.620543280947;10867;11162.107031437465;18237.544061398305;21133.78866211349;22434.775652243596;22510.88744556267;22623;7087.043249161297;7147.213806481387;7200.495965282485;7351.742689005966;7577.0907491100315;4185.769782661922;4260.318349064135;4290.3616318518825;4330.220560299176;4408.404865343202;3276.361819090455;3347.9497807532907;3394.8981530554124;3399.4900764885465;3401.9489707654407;535.7696190637985;605.6971514242879;607.4077774170149;621.3506885304777;634.1059106659587;582.8659408336107;618.2364779497317;619.5477301569789;653.5555822041058;658.0754040573003;8426.368022398345;8534.573271336409;8573.485590864568;9034.954825225832;9374;491.5330436085733;545.9836204913859;553.7923278770461;618.6411881108946;656.4321861589787;4040.5151381834366;4253.404523366731;4557.680962332605;4571.9314210286875;4574.313852922089;89830.55084724535;93401;104402;104408;107231.39152912713;77910.22089779143;91554.54222728843;93493;93537;94424;72508.63745681237;73357.6332118336;73484.63257683784;73861;79393.60303198679;9319.953400233228;9600.959496264517;9606.903930960601;9609.807803843743;9626.9037309626;39585.2082958345;45364.54635453603;48231;49854.52473079513;52142.21786673279;56956.43043569511;62792;64757;65603.67198163978;70543.64728176326;10220.643547832684;12742.171758835646;12838.358082096045;12989.025823063119;13103.048729159951;13773.38019789132;14180.432782688576;14421.168908415799;14738.705225895637;15158.696826063637;13386.26375549354;13679.726405472034;13687.315634218448;13739.725205496034;14069.929650351683;11332.546698131982;13488.32558372097;13632.454701811816;13674.658133546742;13716.3827627755;12727.299998500172;12839.807402889151;12941.870581294066;13231.470741170246;13554.25451600132;10074.395536267848;10928.071113955402;11086.074359153301;11283.266587671775;11647.242929209575;9538.427694338361;11006.174536909604;11050.115990720884;11229.326240425275;11304.660860174208 05:30:12 INFO - PROCESS | 1644 | __end_tp_report 05:30:12 INFO - PROCESS | 1644 | __start_cc_report 05:30:12 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1571 05:30:12 INFO - PROCESS | 1644 | __end_cc_report 05:30:12 INFO - PROCESS | 1644 | __startTimestamp1480253412838__endTimestamp 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | ------- Summary: start ------- 05:30:12 INFO - PROCESS | 1644 | Number of tests: 6 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5653.37 Median:5817.21 stddev:660.33 (11.4%) stddev-sans-first:635.86 05:30:12 INFO - PROCESS | 1644 | Values: 3293.0 3297.5 3308.0 3331.0 3371.6 5551.3 5566.5 5577.6 5626.7 5703.4 5592.1 5610.2 5634.6 5653.0 5654.0 5061.6 5090.6 5105.2 5113.5 5133.6 5194.8 5232.1 5239.3 5246.7 5292.4 5044.8 5089.4 5200.0 5202.8 5253.1 4234.8 5159.8 5167.5 5171.5 5171.6 4184.7 5013.2 5099.9 5105.9 5114.8 5043.7 5302.8 5587.9 5591.9 5618.0 6111.4 6113.2 6115.1 6117.5 6118.4 6159.8 6247.1 6249.7 6265.0 6270.2 5683.0 5709.4 5711.6 5715.3 5725.7 6190.9 6275.9 6327.7 6345.7 6349.7 5998.7 6026.7 6032.5 6059.8 6142.8 6115.5 6176.7 6187.5 6203.8 6215.7 6111.3 6112.8 6118.5 6118.8 6123.8 5982.1 6062.4 6064.1 6130.8 6139.0 4823.8 4854.8 4866.5 4869.1 4884.3 4322.8 4332.4 4434.7 4436.3 4460.9 5524.3 5634.2 5683.5 5687.2 5693.9 6162.2 6162.8 6166.4 6169.1 6177.1 4993.3 5578.9 5605.2 5635.4 5669.1 5335.3 5337.1 5344.0 5352.4 5361.4 6346.1 6347.5 6349.8 6352.0 6360.4 5987.5 6129.5 6137.6 6142.2 6260.6 6335.7 6341.4 6342.1 6354.7 6363.1 4846.6 6118.8 6119.9 6145.4 6146.8 6240.8 6246.7 6246.7 6263.5 6266.6 5973.5 6076.7 6091.5 6097.1 6107.7 5849.6 5904.3 5907.8 5912.4 6027.4 5791.6 5817.2 5819.1 5870.1 5880.4 5872.9 5918.5 5949.5 5955.4 5967.9 5716.9 5777.9 5792.0 5802.9 5810.5 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:63323.99 Median:36564.27 stddev:131670.55 (360.1%) stddev-sans-first:131955.30 05:30:12 INFO - PROCESS | 1644 | Values: 448.5 479.7 506.6 512.2 520.1 30301.2 38472.8 39902.2 39958.8 42613.1 41260.8 41719.6 41725.8 41757.6 41987.6 8391.9 9246.6 9412.1 9417.0 9435.2 8451.5 11097.8 11354.1 11355.5 11456.9 11148.5 11255.0 11284.9 11331.2 11358.3 11228.0 11283.7 11290.5 11317.9 11319.2 11170.8 11233.9 11259.4 11265.6 11276.9 38856.6 39052.0 39142.0 39175.0 39179.0 3303.0 3369.7 3393.4 3485.5 3862.9 25938.7 28749.3 30183.8 30612.8 30715.1 3129.9 3150.9 3183.4 3215.9 3292.0 441160.0 444278.0 444809.0 446337.0 450775.0 57442.7 57524.7 58696.4 58869.5 59206.0 49324.0 59608.0 59828.1 59909.3 59921.0 15638.4 15842.4 15850.0 15868.1 15921.0 11108.5 11343.3 11355.5 12222.3 12306.3 16877.4 16970.7 17221.3 17461.2 17565.8 6839.3 6886.1 6925.5 6966.3 6977.0 876.3 947.3 1001.7 1014.5 1091.4 25855.5 27560.7 28713.1 29365.3 29419.3 924.2 950.3 959.5 1042.3 1104.3 14255.6 14397.1 15029.0 15120.6 15251.2 559975.0 562841.0 569077.0 569956.0 572169.0 56227.0 56305.0 56450.0 56466.4 56568.4 1207.0 1240.1 1326.8 1361.6 1368.8 29263.0 29587.9 29692.7 30374.7 30429.0 49359.5 53775.5 55714.9 58509.1 58616.1 460920.0 463232.0 463430.0 463505.0 466787.0 24524.6 24931.4 25044.5 25446.9 25800.9 44757.8 44963.3 45561.0 45561.5 46056.5 37275.0 37439.4 37711.5 38177.6 38323.2 36784.1 36958.6 37472.6 38090.6 38178.8 36071.1 36344.5 37117.5 37151.3 37190.4 30669.4 33357.8 33763.0 33777.0 33955.5 19691.2 24229.2 24281.6 24427.1 24981.5 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:32748.32 Median:1455.33 stddev:88410.36 (6074.9%) stddev-sans-first:88624.77 05:30:12 INFO - PROCESS | 1644 | Values: 282.5 348.4 357.9 362.1 387.4 14465.8 14749.8 15652.4 15728.2 19620.5 19540.4 19725.3 19729.0 20183.9 20412.0 5729.0 5956.1 6099.7 6110.6 6125.3 4731.5 5896.4 6018.5 6602.9 6679.4 6662.0 6686.1 6690.9 6694.1 6700.3 6379.1 6579.7 6606.7 6654.0 6656.7 4835.4 5507.6 5696.6 5772.5 5788.4 25712.7 25761.0 25899.0 25961.0 26124.3 2010.9 2179.9 2476.2 2628.2 2893.9 9904.1 10108.2 10293.2 10427.9 14725.4 1768.3 1831.9 1840.7 1853.9 1861.7 98083.0 110732.0 115036.0 116765.0 116809.4 11131.4 11199.9 11461.3 11484.7 11632.2 13951.7 14363.9 14449.0 14474.9 14517.1 8144.4 8331.9 8344.5 8358.4 8493.5 6634.9 8070.2 8178.4 8382.5 8388.5 4378.7 4476.0 4488.9 4558.8 4618.3 1818.8 1878.2 1890.5 1914.6 1924.1 792.9 801.9 804.4 862.0 949.2 18885.2 20304.8 21236.6 21365.2 21891.0 840.0 854.7 854.8 938.2 975.8 10581.9 11105.8 11258.3 11312.9 11359.0 407335.0 525534.0 546014.0 565049.0 566832.0 103559.0 124230.8 132422.3 133562.0 138182.0 824.6 970.8 999.7 1006.4 1008.9 17156.5 18566.4 18796.8 18908.6 19395.3 54134.7 55741.0 55932.4 56023.7 57060.0 80155.6 80845.0 82323.6 83130.0 84630.0 7060.9 7982.8 8005.7 8408.8 8470.5 10235.4 11346.7 12364.8 12668.6 13173.9 9434.8 10642.7 10962.7 11254.3 11441.2 10058.4 10240.2 10366.9 10449.9 11615.0 9485.8 11107.8 11287.3 11742.4 11869.2 6996.8 7060.6 7378.0 7428.9 8536.9 9308.6 11643.6 11741.8 11788.2 11798.7 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5359.32 Median:5146.52 stddev:2935.98 (57.0%) stddev-sans-first:2928.51 05:30:12 INFO - PROCESS | 1644 | Values: 1319.7 1472.4 1504.1 1671.3 1849.3 7349.2 7719.1 7972.7 8213.8 8244.7 8135.9 8183.9 8189.8 8190.9 8192.5 1808.9 2020.3 2257.9 2296.9 2302.1 2093.7 2245.1 2316.7 2329.5 2343.3 2258.7 2260.4 2263.1 2273.1 2278.3 2274.3 2296.4 2300.1 2301.4 2302.3 2284.0 2311.1 2312.1 2317.7 2319.5 7012.9 8229.9 8304.8 8319.5 8327.5 4615.6 5164.7 5177.4 5184.6 5186.1 2647.8 3346.5 3438.5 3489.8 3498.7 1001.6 1049.3 1075.1 1077.7 1083.0 10725.9 10797.8 10808.5 10835.0 10900.9 4318.0 4567.5 4628.5 4629.9 4638.6 9348.3 9352.3 9371.0 9372.5 9372.7 5127.2 5134.3 5138.4 5141.6 5151.5 4269.6 4436.2 4506.4 4726.6 4727.1 3507.9 3649.8 3724.5 3786.4 3800.1 1059.3 1251.9 1253.5 1253.5 1269.8 874.4 874.9 876.8 888.8 902.0 5552.9 5554.6 5626.2 5779.6 5850.0 920.8 928.7 930.3 947.8 989.9 3626.8 3663.4 3747.3 3810.3 3892.8 9711.1 9969.5 10067.5 10068.0 10081.9 9813.0 9968.3 10031.1 10032.5 10037.1 7337.9 7668.5 7807.9 7816.1 7816.3 5398.0 5535.4 5734.1 5755.7 5777.1 9043.9 9239.0 9345.1 9378.0 9433.9 8607.1 8839.2 9187.2 9283.5 9385.7 6500.8 6911.9 7095.9 7166.8 7171.0 7245.8 7430.1 7523.7 7781.8 7806.2 5959.3 6768.2 6945.0 6953.4 6990.2 6882.4 6916.9 6919.3 6963.0 6966.6 6280.2 6547.8 6551.3 6642.7 6647.3 4681.6 4734.4 4788.9 4832.4 4854.5 4815.6 4849.3 4852.9 4917.1 4986.3 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4199.26 Median:4725.94 stddev:1252.33 (26.5%) stddev-sans-first:1220.90 05:30:12 INFO - PROCESS | 1644 | Values: 285.4 290.5 294.5 301.4 307.8 4232.4 4793.5 5059.5 5162.9 5164.0 4847.4 4913.7 4957.1 4958.0 5013.3 3924.3 3927.7 3947.9 3954.5 3972.1 3427.2 3920.8 3946.2 3976.6 3987.6 3774.8 3897.2 3908.9 3920.4 3946.0 3893.9 3897.2 3900.9 3927.8 3933.7 2834.8 3401.9 3409.1 3418.8 3433.8 4377.6 4801.5 4818.6 5008.7 5036.7 3882.4 3891.1 4165.3 4453.3 4504.3 4711.7 5139.1 5281.7 5416.5 5445.0 3303.2 3721.7 3757.1 3770.9 3777.7 4855.6 5123.3 5284.8 5604.2 5628.4 3798.5 3805.4 3818.3 3825.3 3833.2 3469.7 3833.9 3866.6 3870.4 3885.1 4123.4 4224.6 4455.7 4480.6 4488.4 4661.7 5005.9 5016.8 5273.9 5418.6 1040.9 1121.7 1139.7 1180.0 1248.0 746.0 801.7 821.5 860.6 882.7 4410.4 4722.2 4729.6 4757.4 4777.4 4571.7 5121.9 5174.7 5219.3 5242.0 3767.7 3973.2 4031.7 4714.9 4757.0 2213.8 2697.9 2708.0 2721.3 2722.8 4792.8 4957.3 5363.5 5372.7 5374.5 4769.3 4921.5 5044.3 5184.0 5281.9 4141.5 4737.4 5086.9 5306.0 5396.9 4562.8 5135.3 5180.3 5184.9 5289.6 4423.8 4827.4 5116.9 5128.3 5157.3 4641.5 5351.3 5351.7 5366.3 5377.4 3074.9 3186.0 3422.4 3605.8 3614.0 4734.4 4782.0 4936.5 5020.0 5253.4 4560.4 4644.8 4972.9 4974.4 5050.7 4871.7 4954.8 5010.8 5011.4 5036.7 4219.0 4422.8 4494.6 4661.3 4902.9 4882.2 4968.3 5251.5 5295.5 5441.6 4945.6 5107.5 5265.3 5292.8 5313.0 05:30:12 INFO - PROCESS | 1644 | 05:30:12 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20100.31 Median:4256.86 stddev:29326.73 (688.9%) stddev-sans-first:29372.81 05:30:12 INFO - PROCESS | 1644 | Values: 697.3 728.0 758.3 776.5 793.6 14977.9 15082.8 15625.8 15629.1 15632.6 13892.8 14127.4 14127.5 14143.9 14161.4 647.7 667.7 798.9 805.4 829.0 817.2 825.2 825.2 828.2 828.8 845.4 877.1 880.3 880.6 881.3 868.5 874.1 877.5 878.3 879.6 496.8 513.2 519.1 521.2 648.7 10874.3 13673.5 14173.7 14220.4 14493.4 13770.7 13956.4 14007.9 14011.1 14061.4 11341.4 11497.5 11705.9 11711.8 11799.5 3603.4 3653.1 3655.6 3673.6 3784.9 106374.0 108304.0 109646.0 113193.4 116058.4 10748.9 10770.2 10841.6 10867.0 11162.1 18237.5 21133.8 22434.8 22510.9 22623.0 7087.0 7147.2 7200.5 7351.7 7577.1 4185.8 4260.3 4290.4 4330.2 4408.4 3276.4 3347.9 3394.9 3399.5 3401.9 535.8 605.7 607.4 621.4 634.1 582.9 618.2 619.5 653.6 658.1 8426.4 8534.6 8573.5 9035.0 9374.0 491.5 546.0 553.8 618.6 656.4 4040.5 4253.4 4557.7 4571.9 4574.3 89830.6 93401.0 104402.0 104408.0 107231.4 77910.2 91554.5 93493.0 93537.0 94424.0 72508.6 73357.6 73484.6 73861.0 79393.6 9320.0 9601.0 9606.9 9609.8 9626.9 39585.2 45364.5 48231.0 49854.5 52142.2 56956.4 62792.0 64757.0 65603.7 70543.6 10220.6 12742.2 12838.4 12989.0 13103.0 13773.4 14180.4 14421.2 14738.7 15158.7 13386.3 13679.7 13687.3 13739.7 14069.9 11332.5 13488.3 13632.5 13674.7 13716.4 12727.3 12839.8 12941.9 13231.5 13554.3 10074.4 10928.1 11086.1 11283.3 11647.2 9538.4 11006.2 11050.1 11229.3 11304.7 05:30:12 INFO - PROCESS | 1644 | -------- Summary: end -------- 05:30:12 INFO - PROCESS | 1644 | 05:30:13 INFO - TEST-INFO | 1644: exit 0 05:30:13 INFO - TEST-OK | dromaeo_css | took 1122434ms 05:30:13 INFO - TEST-START | kraken 05:30:13 INFO - operating with platform_type : mac_ 05:30:13 INFO - Initialising browser for kraken test... 05:30:13 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpl7KP2O/profile http://localhost:49240/getInfo.html) 05:30:16 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 05:30:16 INFO - PROCESS | 1650 | colorDepth:24 05:30:16 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 05:30:16 INFO - PROCESS | 1650 | __metrics 05:30:16 INFO - PROCESS | 1650 | 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" 05:30:16 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:17 INFO - TEST-INFO | 1650: exit 0 05:30:17 INFO - Browser initialized. 05:30:17 INFO - Running cycle 1/1 for kraken test... 05:30:17 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpl7KP2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:29 INFO - PROCESS | 1652 | RSS: Main: 244101120 05:30:29 INFO - PROCESS | 1652 | 05:30:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:33 INFO - PROCESS | 1652 | RSS: Main: 295079936 05:30:33 INFO - PROCESS | 1652 | 05:30:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 05:30:36 INFO - PROCESS | 1652 | RSS: Main: 296308736 05:30:36 INFO - PROCESS | 1652 | 05:30:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 05:30:40 INFO - PROCESS | 1652 | RSS: Main: 386744320 05:30:40 INFO - PROCESS | 1652 | 05:30:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 05:30:43 INFO - PROCESS | 1652 | RSS: Main: 290263040 05:30:43 INFO - PROCESS | 1652 | 05:30:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:45 INFO - PROCESS | 1652 | RSS: Main: 292433920 05:30:45 INFO - PROCESS | 1652 | 05:30:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:49 INFO - PROCESS | 1652 | RSS: Main: 334962688 05:30:49 INFO - PROCESS | 1652 | 05:30:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:52 INFO - PROCESS | 1652 | RSS: Main: 334712832 05:30:52 INFO - PROCESS | 1652 | 05:30:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 05:30:56 INFO - PROCESS | 1652 | RSS: Main: 333651968 05:30:56 INFO - PROCESS | 1652 | 05:30:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:58 INFO - PROCESS | 1652 | RSS: Main: 310173696 05:30:58 INFO - PROCESS | 1652 | 05:31:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:01 INFO - PROCESS | 1652 | RSS: Main: 313294848 05:31:01 INFO - PROCESS | 1652 | 05:31:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:03 INFO - PROCESS | 1652 | RSS: Main: 314859520 05:31:03 INFO - PROCESS | 1652 | 05:31:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:07 INFO - PROCESS | 1652 | RSS: Main: 332062720 05:31:07 INFO - PROCESS | 1652 | 05:31:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:11 INFO - PROCESS | 1652 | RSS: Main: 326115328 05:31:11 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 05:31:13 INFO - PROCESS | 1652 | RSS: Main: 369991680 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | __start_tp_report 05:31:13 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:31:13 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:31:13 INFO - PROCESS | 1652 | |i|pagename|runs| 05:31:13 INFO - PROCESS | 1652 | |0;ai-astar;113;114;114;114;113;115;113;115;113;112 05:31:13 INFO - PROCESS | 1652 | |1;audio-beat-detection;151;114;101;172;144;144;115;113;132;140 05:31:13 INFO - PROCESS | 1652 | |2;audio-dft;184;185;182;183;181;178;183;182;183;183 05:31:13 INFO - PROCESS | 1652 | |3;audio-fft;79;59;58;85;61;59;59;61;75;73 05:31:13 INFO - PROCESS | 1652 | |4;audio-oscillator;90;71;87;96;99;103;93;67;68;84 05:31:13 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;90;90;136;88;90;87;90;86;89;85 05:31:13 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;103;142;93;93;94;98;94;94;95 05:31:13 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;85;85;85;87;86;86;85;85;86 05:31:13 INFO - PROCESS | 1652 | |8;json-parse-financial;56;55;54;55;55;57;55;55;54;54 05:31:13 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;66;65;76;81;73;73;74;72;72;73 05:31:13 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;84;110;89;89;88;89;86;88;88;88 05:31:13 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;149;149;149;148;158;164;153;149;190;158 05:31:13 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;173;175;173;175;175;179;239;166;239;192 05:31:13 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;69;70;70;70;72;83;90;87;76;70 05:31:13 INFO - PROCESS | 1652 | __end_tp_report 05:31:13 INFO - PROCESS | 1652 | __start_cc_report 05:31:13 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2145 05:31:13 INFO - PROCESS | 1652 | __end_cc_report 05:31:13 INFO - PROCESS | 1652 | __startTimestamp1480253473661__endTimestamp 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:31:13 INFO - PROCESS | 1652 | Number of tests: 14 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.00 05:31:13 INFO - PROCESS | 1652 | Values: 113.0 114.0 114.0 114.0 113.0 115.0 113.0 115.0 113.0 112.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:142.00 stddev:21.72 (15.3%) stddev-sans-first:21.99 05:31:13 INFO - PROCESS | 1652 | Values: 151.0 114.0 101.0 172.0 144.0 144.0 115.0 113.0 132.0 140.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.00 stddev:1.90 (1.0%) stddev-sans-first:1.92 05:31:13 INFO - PROCESS | 1652 | Values: 184.0 185.0 182.0 183.0 181.0 178.0 183.0 182.0 183.0 183.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:66.90 Median:67.00 stddev:10.07 (15.0%) stddev-sans-first:9.68 05:31:13 INFO - PROCESS | 1652 | Values: 79.0 59.0 58.0 85.0 61.0 59.0 59.0 61.0 75.0 73.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:88.50 stddev:13.07 (14.8%) stddev-sans-first:13.77 05:31:13 INFO - PROCESS | 1652 | Values: 90.0 71.0 87.0 96.0 99.0 103.0 93.0 67.0 68.0 84.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:89.50 stddev:15.18 (17.0%) stddev-sans-first:16.06 05:31:13 INFO - PROCESS | 1652 | Values: 90.0 90.0 136.0 88.0 90.0 87.0 90.0 86.0 89.0 85.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:94.00 stddev:15.07 (16.0%) stddev-sans-first:15.83 05:31:13 INFO - PROCESS | 1652 | Values: 94.0 103.0 142.0 93.0 93.0 94.0 98.0 94.0 94.0 95.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.73 05:31:13 INFO - PROCESS | 1652 | Values: 84.0 85.0 85.0 85.0 87.0 86.0 86.0 85.0 85.0 86.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.94 (1.7%) stddev-sans-first:0.93 05:31:13 INFO - PROCESS | 1652 | Values: 56.0 55.0 54.0 55.0 55.0 57.0 55.0 55.0 54.0 54.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:4.55 (6.2%) stddev-sans-first:4.18 05:31:13 INFO - PROCESS | 1652 | Values: 66.0 65.0 76.0 81.0 73.0 73.0 74.0 72.0 72.0 73.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.00 stddev:7.23 (8.2%) stddev-sans-first:7.35 05:31:13 INFO - PROCESS | 1652 | Values: 84.0 110.0 89.0 89.0 88.0 89.0 86.0 88.0 88.0 88.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:156.70 Median:155.50 stddev:12.88 (8.3%) stddev-sans-first:13.35 05:31:13 INFO - PROCESS | 1652 | Values: 149.0 149.0 149.0 148.0 158.0 164.0 153.0 149.0 190.0 158.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.60 Median:177.00 stddev:27.36 (15.5%) stddev-sans-first:28.43 05:31:13 INFO - PROCESS | 1652 | Values: 173.0 175.0 173.0 175.0 175.0 179.0 239.0 166.0 239.0 192.0 05:31:13 INFO - PROCESS | 1652 | 05:31:13 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:74.00 stddev:7.99 (10.8%) stddev-sans-first:8.09 05:31:13 INFO - PROCESS | 1652 | Values: 69.0 70.0 70.0 70.0 72.0 83.0 90.0 87.0 76.0 70.0 05:31:13 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:31:13 INFO - PROCESS | 1652 | 05:31:14 INFO - TEST-INFO | 1652: exit 0 05:31:14 INFO - TEST-OK | kraken | took 61058ms 05:31:14 INFO - SUITE-END | took 1183s 05:31:14 INFO - Completed test suite (00:19:43) 05:31:14 INFO - javascript benchmark 05:31:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.967070329297, 3297.4724044152927, 3308.0, 3330.9833450832743, 3371.578552680915, 5551.278333816604, 5566.526845218162, 5577.609567330289, 5626.690532020737, 5703.429657034295, 5592.0773072443, 5610.214569960199, 5634.605577609569, 5653.010723123447, 5654.038813401721, 5061.569766569846, 5090.643654944155, 5105.208692652626, 5113.463086375933, 5133.614978876581, 5194.766235519392, 5232.084385232588, 5239.292695486099, 5246.658967167141, 5292.417834038252, 5044.8234311798915, 5089.440161582223, 5200.0, 5202.791888324463, 5253.0544501989625, 4234.830606775725, 5159.793608255665, 5167.457416971239, 5171.50870667286, 5171.637985341028, 4184.7070705050655, 5013.248012798073, 5099.872503187413, 5105.9489405106215, 5114.820981265638, 5043.747812609392, 5302.840914772563, 5587.944120558783, 5591.916121258185, 5617.9719101404235, 6111.409422667723, 6113.241709320084, 6115.0578074940495, 6117.501829277382, 6118.449339559461, 6159.784407545714, 6247.125402443661, 6249.656268905208, 6265.0, 6270.247570291549, 5682.971585142089, 5709.371969083439, 5711.571632127607, 5715.257016587817, 5725.685087320154, 6190.907136392868, 6275.874482510416, 6327.651979141099, 6345.7144428499905, 6349.68251587428, 5998.700064996733, 6026.728797204137, 6032.457078862835, 6059.757609695651, 6142.846428839315, 6115.487130524749, 6176.66028368444, 6187.474064704461, 6203.844903877439, 6215.689215539205, 6111.266648002268, 6112.847178820565, 6118.479929205978, 6118.785842495491, 6123.84690382744, 5982.0727787193055, 6062.393760623991, 6064.090386442069, 6130.846728831815, 6139.048447490646, 4823.807047718052, 4854.805807767721, 4866.46468888422, 4869.074875773592, 4884.3161957326, 4322.805473753689, 4332.415123958225, 4434.733915964988, 4436.268015777425, 4460.8661740147845, 5524.309461317335, 5634.239377684042, 5683.54531637468, 5687.232223649837, 5693.943060569424, 6162.198914141133, 6162.753489860355, 6166.383361663798, 6169.074638804215, 6177.073438984188, 4993.251012348104, 5578.86052848682, 5605.159226116115, 5635.436456354331, 5669.149627555899, 5335.306410166653, 5337.092694241988, 5343.973280133574, 5352.437994010651, 5361.437049109865, 6346.1432706585865, 6347.492200623939, 6349.809505714744, 6352.015437606993, 6360.427561519486, 5987.461128498456, 6129.450483693955, 6137.560853825989, 6142.191841058572, 6260.561760676709, 6335.714892829741, 6341.365863413622, 6342.080398342307, 6354.682265886595, 6363.109164717036, 4846.636502262274, 6118.816435506942, 6119.868162944114, 6145.432914606747, 6146.832101900624, 6240.843978900564, 6246.718897649525, 6246.718897649707, 6263.530235232284, 6266.624002559861, 5973.492253158356, 6076.696165191811, 6091.5126789857595, 6097.085437184458, 6107.725152368243, 5849.64902105875, 5904.261967254093, 5907.822765317047, 5912.379200183918, 6027.397260273938, 5791.565632577489, 5817.2146760188525, 5819.098039803837, 5870.0607902735355, 5880.441358070976, 5872.941270587239, 5918.467337939606, 5949.494292985145, 5955.40445955401, 5967.880642387215, 5716.857078573069, 5777.94222057774, 5792.015357389169, 5802.912956305574, 5810.535157187331], "value": 5610.524703390525, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.47080445074806, 479.69299648225143, 506.5997861689266, 512.19073863296, 520.1495554767953, 30301.24246893826, 38472.80763596181, 39902.201955960896, 39958.80020599893, 42613.14773704524, 41260.79369603156, 41719.58280417195, 41725.791371043175, 41757.58242417575, 41987.58012419875, 8391.916080839204, 9246.583903724331, 9412.105849944279, 9417.0, 9435.19800816928, 8451.53516556589, 11097.778044439106, 11354.091672666209, 11355.545778168864, 11456.942715286412, 11148.498317575728, 11254.987051165393, 11284.943575282154, 11331.206815522917, 11358.261712988671, 11227.989480946713, 11283.717907052389, 11290.548378064868, 11317.886821131766, 11319.151063670217, 11170.776584468347, 11233.887661123366, 11259.380734059623, 11265.605703800327, 11276.887231127666, 38856.611433885584, 39052.02369940746, 39142.0, 39175.0, 39179.0, 3302.9504557431655, 3369.6967272945553, 3393.372226138172, 3485.546878905726, 3862.8841134766003, 25938.74061259382, 28749.281267968257, 30183.849080754677, 30612.846935765403, 30715.078547643607, 3129.874805007797, 3150.8739650414186, 3183.4428974929297, 3215.8713651453913, 3292.0453068610313, 441160.0, 444278.0, 444809.0, 446337.0, 450775.0, 57442.7127864358, 57524.71237643785, 58696.413035869096, 58869.52435232121, 59206.0, 49324.0, 59608.0, 59828.10257846136, 59909.313149593065, 59921.0, 15638.3744650215, 15842.366305347658, 15850.0, 15868.127253001196, 15921.044737315566, 11108.500117494732, 11343.262687925258, 11355.545778168946, 12222.26666400001, 12306.323152226714, 16877.40929067477, 16970.745438818427, 17221.31114755396, 17461.214245358988, 17565.824341756674, 6839.255989722589, 6886.139232595926, 6925.515213935077, 6966.338197871295, 6976.965115174392, 876.3164731509432, 947.327397547735, 1001.7044971733357, 1014.452195814252, 1091.3997301484153, 25855.48289034209, 27560.724392756216, 28713.138605841857, 29365.26586835346, 29419.264518386783, 924.2282693950492, 950.3062764182048, 959.5250351076122, 1042.3224903812581, 1104.2546281260118, 14255.572332830032, 14397.064190827563, 15029.0, 15120.621984450478, 15251.247870251445, 559975.0, 562841.0, 569077.0, 569956.0, 572169.0, 56227.0, 56305.0, 56450.0, 56466.43533564694, 56568.43431565632, 1206.9698257543455, 1240.0947308464872, 1326.7810811216427, 1361.6051345109806, 1368.7673095573775, 29262.975795847044, 29587.85206073956, 29692.703072968994, 30374.696253037186, 30429.0, 49359.50640493549, 53775.46224537704, 55714.88570228492, 58509.12236316373, 58616.12075818781, 460920.0, 463232.0, 463430.0, 463505.0, 466787.0, 24524.632130518414, 24931.37671558153, 25044.499110017332, 25446.872765636053, 25800.870995644902, 44757.77621111873, 44963.32555011743, 45561.0, 45561.54438455573, 46056.53943460523, 37275.0, 37439.43840842444, 37711.514909145226, 38177.61822381741, 38323.23353532858, 36784.08039799026, 36958.63041369659, 37472.64059486067, 38090.61909380871, 38178.809105955406, 36071.09822254465, 36344.45483317699, 37117.504436724004, 37151.25697485981, 37190.44214336841, 30669.386612268077, 33357.83321083379, 33763.0, 33776.986690399324, 33955.4906676405, 19691.212351506354, 24229.151979680628, 24281.635775463736, 24427.14504992317, 24981.500369992136], "value": 19512.228126831193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.47036805988773, 348.4059678248586, 357.917678933845, 362.11101745215507, 387.3550538353641, 14465.783013254782, 14749.778753318695, 15652.373905043785, 15728.21358932053, 19620.509487262825, 19540.41378758636, 19725.309614163507, 19729.0, 20183.899080504612, 20411.979401029963, 5728.971355143219, 5956.106584012389, 6099.664518451484, 6110.602810817305, 6125.326214116466, 4731.503192164825, 5896.35140134587, 6018.518518518508, 6602.900956485657, 6679.43224825888, 6662.0, 6686.1308029956035, 6690.866182676368, 6694.0962969999155, 6700.296468870772, 6379.07503412005, 6579.736810527597, 6606.669666516703, 6654.0, 6656.70044847983, 4835.371401717789, 5507.642003269774, 5696.572757043238, 5772.538196944234, 5788.392218817048, 25712.742872571223, 25760.969561217527, 25898.96404143832, 25961.0, 26124.34689132787, 2010.9296174633816, 2179.934601961928, 2476.1581062438677, 2628.1852625686097, 2893.8697758600915, 9904.108630223242, 10108.241881858816, 10293.228007899437, 10427.895721042843, 14725.410983560645, 1768.3103589600066, 1831.8809277396927, 1840.7330937014192, 1853.9165737541844, 1861.7393564900924, 98083.0, 110732.0, 115036.0, 116765.0, 116809.41595291969, 11131.387773672526, 11199.94400028011, 11461.312321260584, 11484.712882177846, 11632.172648351008, 13951.720965580835, 14363.856361436252, 14449.0, 14474.927625361806, 14517.128972261698, 8144.389170812095, 8331.875021874677, 8344.541050242173, 8358.414910956297, 8493.490390576586, 6634.900476492857, 8070.1526339734655, 8178.423796504082, 8382.455140415854, 8388.454750441324, 4378.715383500063, 4475.977620111878, 4488.865334039984, 4558.817647294138, 4618.30725391194, 1818.7635607370958, 1878.1736036144052, 1890.5179179309189, 1914.6457905287566, 1924.124523341876, 792.9008873890764, 801.8693641964802, 804.3806269172704, 862.0, 949.2074118111316, 18885.244590216513, 20304.796952030585, 21236.575268494544, 21365.185678369537, 21891.0, 839.9668407858369, 854.717923115327, 854.8418542569644, 938.1884669760608, 975.8048390321964, 10581.894181058246, 11105.83341249882, 11258.268212566158, 11312.943435282936, 11358.977692007593, 407335.0, 525534.0, 546014.0, 565049.0, 566832.0, 103559.0, 124230.75769242372, 132422.33788830994, 133562.0, 138182.0, 824.6041899888087, 970.7670159161751, 999.695092996643, 1006.3609607899036, 1008.9445080520642, 17156.485305440856, 18566.443006709822, 18796.812031880054, 18908.621827563646, 19395.3211637592, 54134.72932635312, 55741.0, 55932.44067559273, 56023.67775061363, 57060.0, 80155.59922200351, 80845.0, 82323.5883820577, 83130.0, 84630.0, 7060.8940865886025, 7982.800429989296, 8005.719799806979, 8408.789780255542, 8470.49177049379, 10235.385876847413, 11346.716332091764, 12364.81452778227, 12668.619941401772, 13173.934130329288, 9434.764130896783, 10642.73393165146, 10962.725931851768, 11254.324740515594, 11441.199116061796, 10058.446785426871, 10240.231982601485, 10366.948165259126, 10449.9477502612, 11615.0, 9485.762855928657, 11107.777844442904, 11287.266327688674, 11742.354170520362, 11869.169158158846, 6996.755113571001, 7060.6116663584, 7377.96311018463, 7428.888566671396, 8536.871946920925, 9308.64566223666, 11643.59247426336, 11741.823872641746, 11788.23376480526, 11798.705032374259], "value": 9430.583417127198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.716261003884, 1472.4331132513978, 1504.1200897474978, 1671.2729962466328, 1849.2510533234035, 7349.154847192574, 7719.073711154662, 7972.68109275629, 8213.835723285545, 8244.711435099773, 8135.91864081359, 8183.91816081839, 8189.795255118625, 8190.918090819105, 8192.508449493034, 1808.8643351748606, 2020.333290014299, 2257.875816830078, 2296.8621882687007, 2302.1482051640915, 2093.696414019966, 2245.124401483423, 2316.698829152216, 2329.4758679297192, 2343.297010896733, 2258.7176602924633, 2260.4461906832767, 2263.0721404224273, 2273.056681477185, 2278.3278932714807, 2274.2608652188023, 2296.4144143243366, 2300.0914638717613, 2301.4361481436986, 2302.251768175341, 2283.988580057089, 2311.110222564308, 2312.1329501436962, 2317.675525426425, 2319.4549280918973, 7012.929870701279, 8229.876551851727, 8304.750857474286, 8319.500829950222, 8327.541985190812, 4615.607673347769, 5164.664296820694, 5177.430482646906, 5184.585233181337, 5186.092433824066, 2647.827891187086, 3346.498025296201, 3438.484227365915, 3489.755717099804, 3498.7201023918024, 1001.5643195210107, 1049.3336731175682, 1075.0754351257913, 1077.7251800790748, 1083.0, 10725.892741072568, 10797.784044319149, 10808.459577021118, 10835.02484776366, 10900.947734634394, 4317.956820431818, 4567.451905771329, 4628.467726211529, 4629.907401851944, 4638.628909687217, 9348.345615806827, 9352.251819854395, 9371.0, 9372.484513351832, 9372.671956481627, 5127.2052831811125, 5134.332536770271, 5138.3577052868395, 5141.5886729061585, 5151.459096794858, 4269.594388533146, 4436.201483732959, 4506.414166158378, 4726.621870250372, 4727.149113159596, 3507.94738078929, 3649.7810131392202, 3724.5158129443, 3786.3752480840353, 3800.1069748609057, 1059.2902755154066, 1251.8873301402919, 1253.4547471849774, 1253.5111306590436, 1269.752398282326, 874.4272501511393, 874.91250874912, 876.8202518483696, 888.7778055486128, 902.0122965352928, 5552.944470555323, 5554.611177217636, 5626.212330273765, 5779.566532510079, 5849.970750146307, 920.8158368326361, 928.679605536089, 930.3162175800916, 947.8436058050482, 989.9110977924225, 3626.8367923443507, 3663.413853783382, 3747.306748251582, 3810.333191691443, 3892.7664340139117, 9711.125998660154, 9969.50152492387, 10067.496625168713, 10068.04353586408, 10081.949590252148, 9813.0, 9968.252381071448, 10031.097201251923, 10032.548535315927, 10037.146842518321, 7337.853242935218, 7668.501547399513, 7807.930898311952, 7816.101148367897, 7816.335611473089, 5397.973010134924, 5535.363433205233, 5734.05388110957, 5755.71221438918, 5777.133429985536, 9043.864342034743, 9239.0, 9345.0654934506, 9377.953110234404, 9433.858492122486, 8607.053224145464, 8839.248663863644, 9187.173154416134, 9283.535823208947, 9385.671501497414, 6500.837479063061, 6911.896321555281, 7095.8935615964765, 7166.820829479305, 7171.0, 7245.7826265212125, 7430.071241094864, 7523.661435235537, 7781.844363112593, 7806.1803510632835, 5959.314678811818, 6768.153980752406, 6945.0, 6953.408960238234, 6990.23107458169, 6882.414994725505, 6916.896246556406, 6919.308069193242, 6963.0, 6966.582005079711, 6280.246370435577, 6547.836304092436, 6551.312112228147, 6642.667866606747, 6647.302033286629, 4681.578657920803, 4734.384530011076, 4788.880277993078, 4832.371791667061, 4854.538818812207, 4815.590674792682, 4849.2726091086615, 4852.902941941212, 4917.065757506062, 4986.276989836526], "value": 4350.346110704268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.43911214463577, 290.5061395627434, 294.53463527626354, 301.35660365120464, 307.83376976432726, 4232.433999420211, 4793.496682848303, 5059.519345662161, 5162.870928226796, 5164.0, 4847.369841920554, 4913.680610760298, 4957.083903716069, 4958.0, 5013.298138260638, 3924.274009308273, 3927.725059245854, 3947.9210415791667, 3954.5254569451563, 3972.0864201233735, 3427.246005878703, 3920.8431662733456, 3946.171304026158, 3976.6421022108007, 3987.5813039630857, 3774.811259437031, 3897.162110146318, 3908.9022774430723, 3920.3923391874164, 3945.9802700986456, 3893.902652433669, 3897.162110146304, 3900.863469778544, 3927.8036098194975, 3933.656392066749, 2834.8015638905285, 3401.914952126192, 3409.147713071732, 3418.8461519231696, 3433.8454769535433, 4377.649788016983, 4801.519848015206, 4818.55443366992, 5008.749562521859, 5036.657954051347, 3882.378819388884, 3891.0855948851995, 4165.250254954107, 4453.330001249531, 4504.301833215857, 4711.670183087185, 5139.12634852076, 5281.656692314988, 5416.458354164592, 5444.972775136099, 3303.240254741399, 3721.6836568891677, 3757.135858752475, 3770.906437133228, 3777.7166712496396, 4855.635827312965, 5123.257127716461, 5284.815031473919, 5604.206653870763, 5628.380878103405, 3798.53756303825, 3805.391137418055, 3818.255440189192, 3825.254075455315, 3833.1792398610437, 3469.6703813138215, 3833.9233215336094, 3866.5940076292145, 3870.3613903706137, 3885.067583779929, 4123.371268348986, 4224.648112603937, 4455.665825063068, 4480.641548676098, 4488.416505854283, 4661.720296782204, 5005.923726398769, 5016.799328026911, 5273.947260527346, 5418.620696551204, 1040.869891263592, 1121.7139629394615, 1139.6751925701135, 1179.9646010619695, 1248.0, 745.970161193557, 801.7234054251275, 821.482466046387, 860.5955201055494, 882.7042940614838, 4410.360497727812, 4722.244440889442, 4729.6452766042685, 4757.35775670287, 4777.402824646919, 4571.748553829571, 5121.897562048738, 5174.715390653475, 5219.329814459413, 5242.004019236333, 3767.6797472215167, 3973.1591911782634, 4031.7177797554477, 4714.929276060861, 4756.9762151189025, 2213.8118259947764, 2697.905573304964, 2708.0251109600526, 2721.333273348003, 2722.7957903157344, 4792.784324705397, 4957.281194226817, 5363.471410648024, 5372.7313634318125, 5374.48942350476, 4769.332293478916, 4921.458639549646, 5044.335369328113, 5184.0, 5281.894362112736, 4141.482314710661, 4737.360456338351, 5086.949130508721, 5305.991861546371, 5396.946030539644, 4562.771861406983, 5135.306733590917, 5180.274761533464, 5184.914975589518, 5289.603279754111, 4423.778811059498, 4827.396575428072, 5116.948830511797, 5128.333316668809, 5157.303763991813, 4641.489436161952, 5351.254122114613, 5351.732413379394, 5366.329208848894, 5377.354717433933, 3074.8936978170027, 3185.984070079635, 3422.418188907842, 3605.8197090145914, 3613.9638603613625, 4734.384530011076, 4781.967663742826, 4936.456989731055, 5020.0461912238015, 5253.369595648546, 4560.361549383156, 4644.7514308830805, 4972.930819873744, 4974.403071631427, 5050.747462626928, 4871.732054737024, 4954.777035033504, 5010.7745151469, 5011.398632164018, 5036.6726162799305, 4218.978905105455, 4422.783734473046, 4494.5505449454795, 4661.324108004388, 4902.9305676289305, 4882.194437917704, 4968.329275547755, 5251.453045273116, 5295.4846447936925, 5441.564674826083, 4945.554900059012, 5107.463716309882, 5265.289185959847, 5292.814751483679, 5313.0], "value": 3796.6147111137034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.2887654592316, 727.984461675962, 758.2985738192173, 776.4913981342223, 793.6349279331507, 14977.925110374446, 15082.849171508282, 15625.843741562581, 15629.062256264631, 15632.609184770386, 13892.81911037563, 14127.434902603909, 14127.505537306197, 14143.929280353585, 14161.433542658282, 647.7473785223743, 667.6728403082503, 798.9001374828147, 805.4442434720039, 828.9917100828975, 817.2195553246635, 825.1500954017372, 825.2366560931144, 828.2090603473698, 828.7513745876244, 845.3828705045321, 877.0746862060523, 880.3265501891059, 880.5773228850156, 881.2949640287776, 868.513632365874, 874.0647507167333, 877.4603618774407, 878.3456325037888, 879.5997820991465, 496.84101087651607, 513.2224679610393, 519.0941806547598, 521.2415934814835, 648.6789039425514, 10874.347539147677, 13673.453061877513, 14173.716525669532, 14220.431182752678, 14493.42026318946, 13770.724585508335, 13956.441742330295, 14007.929960350235, 14011.08927919682, 14061.437542498288, 11341.43292835355, 11497.482613282338, 11705.941470292679, 11711.765764684658, 11799.46902389386, 3603.40543810271, 3653.1232504199065, 3655.6344365563496, 3673.6326367363317, 3784.924301513982, 106374.0, 108304.0, 109646.0, 113193.43403283013, 116058.41970790092, 10748.94625526883, 10770.24608277413, 10841.620543280947, 10867.0, 11162.107031437465, 18237.544061398305, 21133.78866211349, 22434.775652243596, 22510.88744556267, 22623.0, 7087.043249161297, 7147.213806481387, 7200.495965282485, 7351.742689005966, 7577.0907491100315, 4185.769782661922, 4260.318349064135, 4290.3616318518825, 4330.220560299176, 4408.404865343202, 3276.361819090455, 3347.9497807532907, 3394.8981530554124, 3399.4900764885465, 3401.9489707654407, 535.7696190637985, 605.6971514242879, 607.4077774170149, 621.3506885304777, 634.1059106659587, 582.8659408336107, 618.2364779497317, 619.5477301569789, 653.5555822041058, 658.0754040573003, 8426.368022398345, 8534.573271336409, 8573.485590864568, 9034.954825225832, 9374.0, 491.5330436085733, 545.9836204913859, 553.7923278770461, 618.6411881108946, 656.4321861589787, 4040.5151381834366, 4253.404523366731, 4557.680962332605, 4571.9314210286875, 4574.313852922089, 89830.55084724535, 93401.0, 104402.0, 104408.0, 107231.39152912713, 77910.22089779143, 91554.54222728843, 93493.0, 93537.0, 94424.0, 72508.63745681237, 73357.6332118336, 73484.63257683784, 73861.0, 79393.60303198679, 9319.953400233228, 9600.959496264517, 9606.903930960601, 9609.807803843743, 9626.9037309626, 39585.2082958345, 45364.54635453603, 48231.0, 49854.52473079513, 52142.21786673279, 56956.43043569511, 62792.0, 64757.0, 65603.67198163978, 70543.64728176326, 10220.643547832684, 12742.171758835646, 12838.358082096045, 12989.025823063119, 13103.048729159951, 13773.38019789132, 14180.432782688576, 14421.168908415799, 14738.705225895637, 15158.696826063637, 13386.26375549354, 13679.726405472034, 13687.315634218448, 13739.725205496034, 14069.929650351683, 11332.546698131982, 13488.32558372097, 13632.454701811816, 13674.658133546742, 13716.3827627755, 12727.299998500172, 12839.807402889151, 12941.870581294066, 13231.470741170246, 13554.25451600132, 10074.395536267848, 10928.071113955402, 11086.074359153301, 11283.266587671775, 11647.242929209575, 9538.427694338361, 11006.174536909604, 11050.115990720884, 11229.326240425275, 11304.660860174208], "value": 7202.523660241659, "unit": "score"}], "name": "dromaeo_css", "value": 7050.459588865653, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 113.0, 115.0, 113.0, 115.0, 113.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 101.0, 172.0, 144.0, 144.0, 115.0, 113.0, 132.0, 140.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 182.0, 183.0, 181.0, 178.0, 183.0, 182.0, 183.0, 183.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 85.0, 61.0, 59.0, 59.0, 61.0, 75.0, 73.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 87.0, 96.0, 99.0, 103.0, 93.0, 67.0, 68.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 136.0, 88.0, 90.0, 87.0, 90.0, 86.0, 89.0, 85.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 103.0, 142.0, 93.0, 93.0, 94.0, 98.0, 94.0, 94.0, 95.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 55.0, 57.0, 55.0, 55.0, 54.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 76.0, 81.0, 73.0, 73.0, 74.0, 72.0, 72.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 110.0, 89.0, 89.0, 88.0, 89.0, 86.0, 88.0, 88.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 158.0, 164.0, 153.0, 149.0, 190.0, 158.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 175.0, 175.0, 179.0, 239.0, 166.0, 239.0, 192.0], "value": 188.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 70.0, 72.0, 83.0, 90.0, 87.0, 76.0, 70.0], "value": 75.7, "unit": "score"}], "name": "kraken", "value": 1498.2, "alertThreshold": 2.0}]} 05:31:14 INFO - Return code: 0 05:31:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:14 INFO - # TBPL SUCCESS # 05:31:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:14 INFO - 2016-11-27 05:31:14.981 screenresolution[1656:10287] starting screenresolution argv=screenresolution get 05:31:14 INFO - 2016-11-27 05:31:14.984 screenresolution[1656:10287] Display 0: 1600x1200x32@60 05:31:14 INFO - 2016-11-27 05:31:14.990 screenresolution[1657:10290] starting screenresolution argv=screenresolution list 05:31:14 INFO - Available Modes on Display 0 05:31:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:15 INFO - Intel Iris: 05:31:15 INFO - Chipset Model: Intel Iris 05:31:15 INFO - Type: GPU 05:31:15 INFO - Bus: Built-In 05:31:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:15 INFO - Vendor: Intel (0x8086) 05:31:15 INFO - Device ID: 0x0a2e 05:31:15 INFO - Revision ID: 0x0009 05:31:15 INFO - Displays: 05:31:15 INFO - Display: 05:31:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:15 INFO - Display Serial Number: 1600x1200 60 05:31:15 INFO - Main Display: Yes 05:31:15 INFO - Mirror: Off 05:31:15 INFO - Online: Yes 05:31:15 INFO - Rotation: Supported 05:31:15 INFO - Return code: 0 05:31:15 INFO - Running post-action listener: _resource_record_post_action 05:31:15 INFO - [mozharness: 2016-11-27 13:31:15.232816Z] Finished run-tests step (success) 05:31:15 INFO - Running post-run listener: _resource_record_post_run 05:31:15 INFO - Total resource usage - Wall time: 1217s; CPU: 54.0%; Read bytes: 31910912; Write bytes: 697044480; Read time: 317; Write time: 1942 05:31:15 INFO - TinderboxPrint: CPU usage
53.7% 05:31:15 INFO - TinderboxPrint: I/O read bytes / time
31,910,912 / 317 05:31:15 INFO - TinderboxPrint: I/O write bytes / time
697,044,480 / 1,942 05:31:15 INFO - TinderboxPrint: CPU idle
2,256.9 (46.3%) 05:31:15 INFO - TinderboxPrint: CPU system
973.6 (20.0%) 05:31:15 INFO - TinderboxPrint: CPU user
1,639.3 (33.7%) 05:31:15 INFO - TinderboxPrint: Swap in / out
411,025,408 / 0 05:31:15 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 378577408; Write bytes: 373917696; Read time: 28630; Write time: 675 05:31:15 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 29879296; Write bytes: 308680192; Read time: 295; Write time: 1227 05:31:15 INFO - Running post-run listener: _upload_blobber_files 05:31:15 INFO - Blob upload gear active. 05:31:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:15 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 05:31:15 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:15 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:17 INFO - (blobuploader) - INFO - Done attempting. 05:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:18 INFO - (blobuploader) - INFO - Done attempting. 05:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:21 INFO - (blobuploader) - INFO - Done attempting. 05:31:21 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:21 INFO - Return code: 0 05:31:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d8c8fa2d46ee66065fd8d2dcc9699bfb04acccb00c1b8c3115c39499f224f65b0a5341fed82ee9fc2a70bc07b47c8e36cd1d6500ae0f9d66a00c92520a58a74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3e5e2635e3c94f6e9361cfe2f279ed523b08bc148893d7023cdd89b2956da2323381f840187b6765ed180ca3768c83419cc1c843878d97eaeddca92bb875cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fe70e70a93ce738861446f468095ab1b8977213378db493ffea774ca79f2b22a8a40e105907975a47ad33ce2bf27e9440e53e3108932050030fb250a8f7f95"} 05:31:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:21 INFO - Contents: 05:31:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d8c8fa2d46ee66065fd8d2dcc9699bfb04acccb00c1b8c3115c39499f224f65b0a5341fed82ee9fc2a70bc07b47c8e36cd1d6500ae0f9d66a00c92520a58a74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3e5e2635e3c94f6e9361cfe2f279ed523b08bc148893d7023cdd89b2956da2323381f840187b6765ed180ca3768c83419cc1c843878d97eaeddca92bb875cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fe70e70a93ce738861446f468095ab1b8977213378db493ffea774ca79f2b22a8a40e105907975a47ad33ce2bf27e9440e53e3108932050030fb250a8f7f95"} 05:31:21 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:21 INFO - Copying logs to upload dir... 05:31:21 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.218872 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-27 05:31:21.648141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 05:31:21.651652) ========= 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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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/Firefox/sha512/7d8c8fa2d46ee66065fd8d2dcc9699bfb04acccb00c1b8c3115c39499f224f65b0a5341fed82ee9fc2a70bc07b47c8e36cd1d6500ae0f9d66a00c92520a58a74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3e5e2635e3c94f6e9361cfe2f279ed523b08bc148893d7023cdd89b2956da2323381f840187b6765ed180ca3768c83419cc1c843878d97eaeddca92bb875cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fe70e70a93ce738861446f468095ab1b8977213378db493ffea774ca79f2b22a8a40e105907975a47ad33ce2bf27e9440e53e3108932050030fb250a8f7f95"} build_url:https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/G_uw-UQ5R16ZJRYXFnqufA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d8c8fa2d46ee66065fd8d2dcc9699bfb04acccb00c1b8c3115c39499f224f65b0a5341fed82ee9fc2a70bc07b47c8e36cd1d6500ae0f9d66a00c92520a58a74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d3e5e2635e3c94f6e9361cfe2f279ed523b08bc148893d7023cdd89b2956da2323381f840187b6765ed180ca3768c83419cc1c843878d97eaeddca92bb875cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fe70e70a93ce738861446f468095ab1b8977213378db493ffea774ca79f2b22a8a40e105907975a47ad33ce2bf27e9440e53e3108932050030fb250a8f7f95"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 05:31:21.690274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:31:21.690608) ========= 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.mzBgAl9ufZ/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.ny6KOUAdRb/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.005129 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 05:31:21.738970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 05:31:21.739283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 05:31:21.739613) ========= ========= Total master_lag: 0.80 =========