builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0095 starttime: 1477972395.6 results: success (0) buildid: 20161031183902 builduid: e1aba3addb834af68cb55d7f0f3f494b revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.603542) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.604209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.604582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.635492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.635901) ========= 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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-10-31 20:53:15-- 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% 176M=0s 2016-10-31 20:53:15 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.750333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.753729) ========= 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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.025911 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:15.802486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 20:53:15.805529) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --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 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sv2Fx0otiR/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.GWMfytdD6b/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-10-31 20:53:15,883 truncating revision to first 12 chars 2016-10-31 20:53:15,883 Setting DEBUG logging. 2016-10-31 20:53:15,883 attempt 1/10 2016-10-31 20:53:15,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21153294d3a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 20:53:16,941 unpacking tar archive at: mozilla-central-21153294d3a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.308435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 20:53:17.135544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:17.135891) ========= script_repo_revision: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:17.136281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:17.136548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 20:53:17.161008) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-10-31 20:53:17.161404) ========= /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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:53:17 INFO - MultiFileLogger online at 20161031 20:53:17 in /builds/slave/test 20:53:17 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 20:53:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:53:17 INFO - {'append_to_log': False, 20:53:17 INFO - 'base_work_dir': '/builds/slave/test', 20:53:17 INFO - 'blob_upload_branch': 'Firefox', 20:53:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:53:17 INFO - 'branch': 'Firefox', 20:53:17 INFO - 'buildbot_json_path': 'buildprops.json', 20:53:17 INFO - 'config_files': ('talos/mac_config.py',), 20:53:17 INFO - 'default_actions': ('clobber', 20:53:17 INFO - 'read-buildbot-config', 20:53:17 INFO - 'download-and-extract', 20:53:17 INFO - 'populate-webroot', 20:53:17 INFO - 'create-virtualenv', 20:53:17 INFO - 'install', 20:53:17 INFO - 'run-tests'), 20:53:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:53:17 INFO - 'download_minidump_stackwalk': True, 20:53:17 INFO - 'download_symbols': 'ondemand', 20:53:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:53:17 INFO - 'tooltool.py': '/tools/tooltool.py', 20:53:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:53:17 INFO - '/tools/misc-python/virtualenv.py')}, 20:53:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:53:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:53:17 INFO - 'installer_path': 'installer.exe', 20:53:17 INFO - 'log_level': 'info', 20:53:17 INFO - 'log_name': 'talos', 20:53:17 INFO - 'log_to_console': True, 20:53:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:53:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:53:17 INFO - 'opt_config_files': (), 20:53:17 INFO - 'pip_index': False, 20:53:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:53:17 INFO - 'cmd': ('bash', 20:53:17 INFO - '-c', 20:53:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:53:17 INFO - 'enabled': True, 20:53:17 INFO - 'halt_on_failure': False, 20:53:17 INFO - 'name': 'check_screen_resolution'},), 20:53:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:53:17 INFO - 'cmd': ('bash', 20:53:17 INFO - '-c', 20:53:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:53:17 INFO - 'enabled': True, 20:53:17 INFO - 'halt_on_failure': False, 20:53:17 INFO - 'name': 'check_screen_resolution'},), 20:53:17 INFO - 'run_cmd_checks_enabled': True, 20:53:17 INFO - 'sps_profile': False, 20:53:17 INFO - 'sps_profile_interval': 0, 20:53:17 INFO - 'suite': 'dromaeojs', 20:53:17 INFO - 'system_bits': '32', 20:53:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:53:17 INFO - 'title': 't-yosemite-r7-0095', 20:53:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:53:17 INFO - 'use_talos_json': True, 20:53:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:53:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:53:17 INFO - 'work_dir': 'build'} 20:53:17 INFO - [mozharness: 2016-11-01 03:53:17.371550Z] Running clobber step. 20:53:17 INFO - Running pre-action listener: _resource_record_pre_action 20:53:17 INFO - Running main action method: clobber 20:53:17 INFO - rmtree: /builds/slave/test/build 20:53:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:53:19 INFO - Running post-action listener: _resource_record_post_action 20:53:19 INFO - [mozharness: 2016-11-01 03:53:19.687514Z] Finished clobber step (success) 20:53:19 INFO - [mozharness: 2016-11-01 03:53:19.687677Z] Running read-buildbot-config step. 20:53:19 INFO - Running pre-action listener: _resource_record_pre_action 20:53:19 INFO - Running main action method: read_buildbot_config 20:53:19 INFO - Using buildbot properties: 20:53:19 INFO - { 20:53:19 INFO - "project": "", 20:53:19 INFO - "product": "firefox", 20:53:19 INFO - "script_repo_revision": "production", 20:53:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 20:53:19 INFO - "repository": "", 20:53:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 20:53:19 INFO - "buildid": "20161031183902", 20:53:19 INFO - "pgo_build": "False", 20:53:19 INFO - "basedir": "/builds/slave/test", 20:53:19 INFO - "buildnumber": 17, 20:53:19 INFO - "slavename": "t-yosemite-r7-0095", 20:53:19 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 20:53:19 INFO - "platform": "yosemite_r7", 20:53:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:53:19 INFO - "branch": "mozilla-central", 20:53:19 INFO - "repo_path": "mozilla-central", 20:53:19 INFO - "revision": "21153294d3a0bf7ce8e5e6bb1a0e684745b88fda", 20:53:19 INFO - "stage_platform": "macosx64", 20:53:19 INFO - "builduid": "e1aba3addb834af68cb55d7f0f3f494b", 20:53:19 INFO - "slavebuilddir": "test" 20:53:19 INFO - } 20:53:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:53:19 INFO - Running post-action listener: _resource_record_post_action 20:53:19 INFO - [mozharness: 2016-11-01 03:53:19.691009Z] Finished read-buildbot-config step (success) 20:53:19 INFO - [mozharness: 2016-11-01 03:53:19.691166Z] Running download-and-extract step. 20:53:19 INFO - Running pre-action listener: _resource_record_pre_action 20:53:19 INFO - Running main action method: download_and_extract 20:53:19 INFO - mkdir: /builds/slave/test/build/tests 20:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:19 INFO - trying https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:53:19 INFO - Downloading https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 20:53:21 INFO - Downloaded 1199 bytes. 20:53:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:53:21 INFO - Using the following test package requirements: 20:53:21 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:53:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:53:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:53:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'jsshell-mac.zip'], 20:53:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:53:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:53:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:53:21 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:53:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:53:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:53:21 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:53:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:53:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:53:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:53:21 INFO - Fetch https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:53:21 INFO - Http code: 200 20:53:21 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 20:53:21 INFO - x-amz-cf-id: rwqae2s86Myj5GYYUqbVRVT-TG0jtbKIg1lW8kYrfrpZFLM5JVTpGQ== 20:53:21 INFO - x-amz-version-id: ZakPg9bg3gQxnA6hA_eXEqwtl5YNAiUp 20:53:21 INFO - Expected file size: 16404928 20:53:21 INFO - Obtained file size: 16404928 20:53:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:53:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:53:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:53:28 INFO - Fetch https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:53:36 INFO - Http code: 200 20:53:36 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 20:53:36 INFO - x-amz-cf-id: JUmJQdwli6vo_cCUCpk68VEfPJ3_1PoQIbrmPH9aA4OpecEgckWuTw== 20:53:36 INFO - x-amz-version-id: ZakPg9bg3gQxnA6hA_eXEqwtl5YNAiUp 20:53:36 INFO - Expected file size: 16404928 20:53:36 INFO - Obtained file size: 16404928 20:53:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:53:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:53:42 INFO - Fetch https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:53:43 INFO - Http code: 200 20:53:43 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 20:53:43 INFO - x-amz-cf-id: 8q7z5FR_9IuTtmTLYDg0PUCEaaA0sT3RutkD2h-EezKtFkcyvyf6BA== 20:53:43 INFO - x-amz-version-id: 1ojoslQHMT0maCU_DdhXThKK4nVW5Ncc 20:53:44 INFO - Expected file size: 14409038 20:53:44 INFO - Obtained file size: 14409038 20:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:44 INFO - trying https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:44 INFO - Downloading https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 20:53:47 INFO - Downloaded 112093123 bytes. 20:53:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:47 INFO - mkdir: /builds/slave/test/properties 20:53:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:53:47 INFO - Writing to file /builds/slave/test/properties/build_url 20:53:47 INFO - Contents: 20:53:47 INFO - build_url:https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:47 INFO - Running post-action listener: _resource_record_post_action 20:53:47 INFO - Running post-action listener: set_extra_try_arguments 20:53:47 INFO - [mozharness: 2016-11-01 03:53:47.870855Z] Finished download-and-extract step (success) 20:53:47 INFO - [mozharness: 2016-11-01 03:53:47.870947Z] Running populate-webroot step. 20:53:47 INFO - Running pre-action listener: _resource_record_pre_action 20:53:47 INFO - Running main action method: populate_webroot 20:53:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:53:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:53:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:53:47 INFO - '--tppagecycles', 20:53:47 INFO - '7'], 20:53:47 INFO - 'tests': ['tsvgm']}}, 20:53:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:53:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:53:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:53:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:53:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['damp', 'tps']}, 20:53:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'tests': ['damp', 'tps']}, 20:53:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['dromaeo_dom']}, 20:53:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:53:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['basic_compositor_video']}, 20:53:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:53:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['a11yr', 20:53:47 INFO - 'ts_paint', 20:53:47 INFO - 'tpaint', 20:53:47 INFO - 'sessionrestore', 20:53:47 INFO - 'sessionrestore_no_auto_restore', 20:53:47 INFO - 'tabpaint']}, 20:53:47 INFO - 'other-e10s': {'tests': ['a11yr', 20:53:47 INFO - 'ts_paint', 20:53:47 INFO - 'tpaint', 20:53:47 INFO - 'sessionrestore', 20:53:47 INFO - 'sessionrestore_no_auto_restore', 20:53:47 INFO - 'tabpaint']}, 20:53:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:53:47 INFO - 'ts_paint', 20:53:47 INFO - 'tpaint', 20:53:47 INFO - 'sessionrestore', 20:53:47 INFO - 'sessionrestore_no_auto_restore', 20:53:47 INFO - 'tabpaint']}, 20:53:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:53:47 INFO - 'ts_paint', 20:53:47 INFO - 'tpaint', 20:53:47 INFO - 'sessionrestore', 20:53:47 INFO - 'sessionrestore_no_auto_restore', 20:53:47 INFO - 'tabpaint']}, 20:53:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['a11yr', 20:53:47 INFO - 'ts_paint', 20:53:47 INFO - 'tpaint', 20:53:47 INFO - 'sessionrestore', 20:53:47 INFO - 'sessionrestore_no_auto_restore', 20:53:47 INFO - 'tabpaint']}, 20:53:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['a11yr', 20:53:47 INFO - 'ts_paint', 20:53:47 INFO - 'tpaint', 20:53:47 INFO - 'sessionrestore', 20:53:47 INFO - 'sessionrestore_no_auto_restore', 20:53:47 INFO - 'tabpaint']}, 20:53:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['tsvgx', 20:53:47 INFO - 'tsvgr_opacity', 20:53:47 INFO - 'tart', 20:53:47 INFO - 'tscrollx', 20:53:47 INFO - 'cart']}, 20:53:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:53:47 INFO - 'tsvgr_opacity', 20:53:47 INFO - 'tart', 20:53:47 INFO - 'tscrollx', 20:53:47 INFO - 'cart']}, 20:53:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'talos_options': ['--disable-e10s'], 20:53:47 INFO - 'tests': ['tp5o']}, 20:53:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'tests': ['tp5o']}, 20:53:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'talos_options': ['--disable-e10s', 20:53:47 INFO - '--xperf_path', 20:53:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:47 INFO - 'tests': ['tp5n']}, 20:53:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:47 INFO - 'talos_options': ['--xperf_path', 20:53:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:47 INFO - 'tests': ['tp5n']}}, 20:53:47 INFO - 'talos.zip': {'path': '', 20:53:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:53:47 INFO - Running post-action listener: _resource_record_post_action 20:53:47 INFO - [mozharness: 2016-11-01 03:53:47.889821Z] Finished populate-webroot step (success) 20:53:47 INFO - [mozharness: 2016-11-01 03:53:47.889950Z] Running create-virtualenv step. 20:53:47 INFO - Running pre-action listener: _resource_record_pre_action 20:53:47 INFO - Running main action method: create_virtualenv 20:53:47 INFO - Creating virtualenv /builds/slave/test/build/venv 20:53:47 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 20:53:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:53:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:53:48 INFO - Using real prefix '/tools/python27' 20:53:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:53:48 INFO - Installing distribute.............................................................................................................................................................................................done. 20:53:51 INFO - Installing pip.................done. 20:53:51 INFO - Return code: 0 20:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:53:51 INFO - Reading from file tmpfile_stdout 20:53:51 INFO - Output received: 20:53:51 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) 20:53:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:53: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')]} 20:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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')]} 20:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:51 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 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:53:51 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 20:53:51 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 20:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:51 INFO - 'HOME': '/Users/cltbld', 20:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:51 INFO - 'LOGNAME': 'cltbld', 20:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:51 INFO - 'MOZ_NO_REMOTE': '1', 20:53:51 INFO - 'NO_EM_RESTART': '1', 20:53:51 INFO - 'PAGER': '/bin/cat', 20:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:51 INFO - 'PWD': '/builds/slave/test', 20:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:51 INFO - 'SHELL': '/bin/bash', 20:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:53:51 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:51 INFO - 'USER': 'cltbld', 20:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:51 INFO - 'XPC_FLAGS': '0x0', 20:53:51 INFO - 'XPC_SERVICE_NAME': '0', 20:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:53:52 INFO - Cleaning up... 20:53:52 INFO - Return code: 0 20:53:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:52 INFO - 'HOME': '/Users/cltbld', 20:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:52 INFO - 'LOGNAME': 'cltbld', 20:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:52 INFO - 'MOZ_NO_REMOTE': '1', 20:53:52 INFO - 'NO_EM_RESTART': '1', 20:53:52 INFO - 'PAGER': '/bin/cat', 20:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:52 INFO - 'PWD': '/builds/slave/test', 20:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:52 INFO - 'SHELL': '/bin/bash', 20:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:53:52 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:52 INFO - 'USER': 'cltbld', 20:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:52 INFO - 'XPC_FLAGS': '0x0', 20:53:52 INFO - 'XPC_SERVICE_NAME': '0', 20:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:52 INFO - Downloading/unpacking psutil>=3.1.1 20:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:55 INFO - Installing collected packages: psutil 20:53:55 INFO - Running setup.py install for psutil 20:53:55 INFO - building 'psutil._psutil_osx' extension 20:53:55 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 20:53:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:53:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:53:56 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 20:53:56 INFO - building 'psutil._psutil_posix' extension 20:53:56 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 20:53:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:53:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:53:56 INFO - ^ 20:53:56 INFO - 1 warning generated. 20:53:56 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 20:53:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:56 INFO - Successfully installed psutil 20:53:56 INFO - Cleaning up... 20:53:57 INFO - Return code: 0 20:53:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:57 INFO - 'HOME': '/Users/cltbld', 20:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:57 INFO - 'LOGNAME': 'cltbld', 20:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:57 INFO - 'MOZ_NO_REMOTE': '1', 20:53:57 INFO - 'NO_EM_RESTART': '1', 20:53:57 INFO - 'PAGER': '/bin/cat', 20:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:57 INFO - 'PWD': '/builds/slave/test', 20:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:57 INFO - 'SHELL': '/bin/bash', 20:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:53:57 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:57 INFO - 'USER': 'cltbld', 20:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:57 INFO - 'XPC_FLAGS': '0x0', 20:53:57 INFO - 'XPC_SERVICE_NAME': '0', 20:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:53:57 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 20:53:57 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 20:53:57 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 20:53:57 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 20:53:57 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 20:53:57 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 20:53:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:53:59 INFO - Installing collected packages: mozsystemmonitor 20:53:59 INFO - Running setup.py install for mozsystemmonitor 20:54:00 INFO - Successfully installed mozsystemmonitor 20:54:00 INFO - Cleaning up... 20:54:00 INFO - Return code: 0 20:54:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:00 INFO - 'HOME': '/Users/cltbld', 20:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:00 INFO - 'LOGNAME': 'cltbld', 20:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:00 INFO - 'MOZ_NO_REMOTE': '1', 20:54:00 INFO - 'NO_EM_RESTART': '1', 20:54:00 INFO - 'PAGER': '/bin/cat', 20:54:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:00 INFO - 'PWD': '/builds/slave/test', 20:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:00 INFO - 'SHELL': '/bin/bash', 20:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:00 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:00 INFO - 'USER': 'cltbld', 20:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:00 INFO - 'XPC_FLAGS': '0x0', 20:54:00 INFO - 'XPC_SERVICE_NAME': '0', 20:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:00 INFO - Downloading/unpacking jsonschema==2.5.1 20:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:54:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:54:02 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 20:54:02 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 20:54:02 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 20:54:02 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 20:54:02 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 20:54:02 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 20:54:03 INFO - Downloading functools32-3.2.3-2.tar.gz 20:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:54:03 INFO - warning: no files found matching '*.txt' 20:54:03 INFO - no previously-included directories found matching 'build' 20:54:03 INFO - no previously-included directories found matching 'dist' 20:54:03 INFO - no previously-included directories found matching '.git*' 20:54:03 INFO - Installing collected packages: jsonschema, functools32 20:54:03 INFO - Running setup.py install for functools32 20:54:03 INFO - warning: no files found matching '*.txt' 20:54:03 INFO - no previously-included directories found matching 'build' 20:54:03 INFO - no previously-included directories found matching 'dist' 20:54:03 INFO - no previously-included directories found matching '.git*' 20:54:03 INFO - Successfully installed jsonschema functools32 20:54:03 INFO - Cleaning up... 20:54:03 INFO - Return code: 0 20:54:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:54:03 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')]} 20:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:03 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')]} 20:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:03 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 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:54:03 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 20:54:03 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 20:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:03 INFO - 'HOME': '/Users/cltbld', 20:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:03 INFO - 'LOGNAME': 'cltbld', 20:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:03 INFO - 'MOZ_NO_REMOTE': '1', 20:54:03 INFO - 'NO_EM_RESTART': '1', 20:54:03 INFO - 'PAGER': '/bin/cat', 20:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:03 INFO - 'PWD': '/builds/slave/test', 20:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:03 INFO - 'SHELL': '/bin/bash', 20:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:03 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:03 INFO - 'USER': 'cltbld', 20:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:03 INFO - 'XPC_FLAGS': '0x0', 20:54:03 INFO - 'XPC_SERVICE_NAME': '0', 20:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:54:03 INFO - Cleaning up... 20:54:03 INFO - Return code: 0 20:54:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:54:03 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')]} 20:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:03 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')]} 20:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:03 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 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:54:03 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 20:54:03 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 20:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:03 INFO - 'HOME': '/Users/cltbld', 20:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:03 INFO - 'LOGNAME': 'cltbld', 20:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:03 INFO - 'MOZ_NO_REMOTE': '1', 20:54:03 INFO - 'NO_EM_RESTART': '1', 20:54:03 INFO - 'PAGER': '/bin/cat', 20:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:03 INFO - 'PWD': '/builds/slave/test', 20:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:03 INFO - 'SHELL': '/bin/bash', 20:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:03 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:03 INFO - 'USER': 'cltbld', 20:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:03 INFO - 'XPC_FLAGS': '0x0', 20:54:03 INFO - 'XPC_SERVICE_NAME': '0', 20:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:04 INFO - Downloading/unpacking blobuploader==1.2.4 20:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:06 INFO - Downloading blobuploader-1.2.4.tar.gz 20:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:54:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:54:06 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 20:54:06 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 20:54:06 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 20:54:06 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 20:54:06 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 20:54:06 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 20:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:54:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:54:07 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 20:54:07 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 20:54:07 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 20:54:07 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 20:54:07 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 20:54:07 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 20:54:07 INFO - Downloading docopt-0.6.1.tar.gz 20:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:54:07 INFO - Installing collected packages: blobuploader, requests, docopt 20:54:07 INFO - Running setup.py install for blobuploader 20:54:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:54:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:54:08 INFO - Running setup.py install for requests 20:54:08 INFO - Running setup.py install for docopt 20:54:08 INFO - Successfully installed blobuploader requests docopt 20:54:08 INFO - Cleaning up... 20:54:08 INFO - Return code: 0 20:54:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:09 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')]} 20:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:09 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 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:54:09 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 20:54:09 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 20:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:09 INFO - 'HOME': '/Users/cltbld', 20:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:09 INFO - 'LOGNAME': 'cltbld', 20:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:09 INFO - 'MOZ_NO_REMOTE': '1', 20:54:09 INFO - 'NO_EM_RESTART': '1', 20:54:09 INFO - 'PAGER': '/bin/cat', 20:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:09 INFO - 'PWD': '/builds/slave/test', 20:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:09 INFO - 'SHELL': '/bin/bash', 20:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:09 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:09 INFO - 'USER': 'cltbld', 20:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:09 INFO - 'XPC_FLAGS': '0x0', 20:54:09 INFO - 'XPC_SERVICE_NAME': '0', 20:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:54:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-EhcoOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:54:09 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-wdQ8sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-0oAnSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-5dgl1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-JohWVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-w5LTFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-CmgHNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ffflsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-z0_LSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-7A_7Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:54:10 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-gmiyVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:54:11 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-bt8D9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:54:11 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-xwXr2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:54:11 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-PSPjBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:54:11 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-tEWoIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:54:11 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-uabX86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:54:11 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Brd41A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:54:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:54:11 INFO - Running setup.py install for manifestparser 20:54:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:54:11 INFO - Running setup.py install for mozcrash 20:54:11 INFO - Running setup.py install for mozdebug 20:54:12 INFO - Running setup.py install for mozdevice 20:54:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Running setup.py install for mozfile 20:54:12 INFO - Running setup.py install for mozhttpd 20:54:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Running setup.py install for mozinfo 20:54:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Running setup.py install for mozInstall 20:54:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:54:12 INFO - Running setup.py install for mozleak 20:54:12 INFO - Running setup.py install for mozlog 20:54:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:54:13 INFO - Running setup.py install for moznetwork 20:54:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:54:13 INFO - Running setup.py install for mozprocess 20:54:13 INFO - Running setup.py install for mozprofile 20:54:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:54:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:54:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:54:13 INFO - Running setup.py install for mozrunner 20:54:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:54:13 INFO - Running setup.py install for mozscreenshot 20:54:13 INFO - Running setup.py install for moztest 20:54:14 INFO - Running setup.py install for mozversion 20:54:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:54:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:54:14 INFO - Cleaning up... 20:54:14 INFO - Return code: 0 20:54:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:14 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 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:54:14 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 20:54:14 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 20:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:14 INFO - 'HOME': '/Users/cltbld', 20:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:14 INFO - 'LOGNAME': 'cltbld', 20:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:14 INFO - 'MOZ_NO_REMOTE': '1', 20:54:14 INFO - 'NO_EM_RESTART': '1', 20:54:14 INFO - 'PAGER': '/bin/cat', 20:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:14 INFO - 'PWD': '/builds/slave/test', 20:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:14 INFO - 'SHELL': '/bin/bash', 20:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:14 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:14 INFO - 'USER': 'cltbld', 20:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:14 INFO - 'XPC_FLAGS': '0x0', 20:54:14 INFO - 'XPC_SERVICE_NAME': '0', 20:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:54:14 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-DIkycm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:54:14 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)) 20:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:54:14 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-azgUWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Fur0aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ksEIRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-yn9dIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-amF_3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-8FrMVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:54:15 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)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-_dMrRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:54:15 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)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-3t2ohB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:54:15 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)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-xk2kgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:54:15 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)) 20:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:54:15 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-6JmEwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:54:16 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-v7zxeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:54:16 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-a9wPwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:54:16 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-00OwHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:54:16 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-7jhTCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:54:16 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-arWY3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:54:16 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)) 20:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:54:16 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-BQ3wBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:54:16 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)) 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:54:16 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)) 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:54:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:54:19 INFO - Downloading blessings-1.6.tar.gz 20:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:54:19 INFO - Installing collected packages: blessings 20:54:19 INFO - Running setup.py install for blessings 20:54:19 INFO - Successfully installed blessings 20:54:19 INFO - Cleaning up... 20:54:19 INFO - Return code: 0 20:54:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:54:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:54:20 INFO - Reading from file tmpfile_stdout 20:54:20 INFO - Current package versions: 20:54:20 INFO - blessings == 1.6 20:54:20 INFO - blobuploader == 1.2.4 20:54:20 INFO - docopt == 0.6.1 20:54:20 INFO - functools32 == 3.2.3-2 20:54:20 INFO - jsonschema == 2.5.1 20:54:20 INFO - manifestparser == 1.1 20:54:20 INFO - mozInstall == 1.12 20:54:20 INFO - mozcrash == 0.17 20:54:20 INFO - mozdebug == 0.1 20:54:20 INFO - mozdevice == 0.48 20:54:20 INFO - mozfile == 1.2 20:54:20 INFO - mozhttpd == 0.7 20:54:20 INFO - mozinfo == 0.9 20:54:20 INFO - mozleak == 0.1 20:54:20 INFO - mozlog == 3.4 20:54:20 INFO - moznetwork == 0.27 20:54:20 INFO - mozprocess == 0.23 20:54:20 INFO - mozprofile == 0.28 20:54:20 INFO - mozrunner == 6.12 20:54:20 INFO - mozscreenshot == 0.1 20:54:20 INFO - mozsystemmonitor == 0.3 20:54:20 INFO - moztest == 0.7 20:54:20 INFO - mozversion == 1.4 20:54:20 INFO - psutil == 3.1.1 20:54:20 INFO - requests == 1.2.3 20:54:20 INFO - wsgiref == 0.1.2 20:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:20 INFO - 'HOME': '/Users/cltbld', 20:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:20 INFO - 'LOGNAME': 'cltbld', 20:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:20 INFO - 'MOZ_NO_REMOTE': '1', 20:54:20 INFO - 'NO_EM_RESTART': '1', 20:54:20 INFO - 'PAGER': '/bin/cat', 20:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:20 INFO - 'PWD': '/builds/slave/test', 20:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:20 INFO - 'SHELL': '/bin/bash', 20:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:20 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:20 INFO - 'USER': 'cltbld', 20:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:20 INFO - 'XPC_FLAGS': '0x0', 20:54:20 INFO - 'XPC_SERVICE_NAME': '0', 20:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:54:20 INFO - Cleaning up... 20:54:20 INFO - Return code: 0 20:54:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:54:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d547490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe0c60230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, '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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 20:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:20 INFO - 'HOME': '/Users/cltbld', 20:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:20 INFO - 'LOGNAME': 'cltbld', 20:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:20 INFO - 'MOZ_NO_REMOTE': '1', 20:54:20 INFO - 'NO_EM_RESTART': '1', 20:54:20 INFO - 'PAGER': '/bin/cat', 20:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:20 INFO - 'PWD': '/builds/slave/test', 20:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:20 INFO - 'SHELL': '/bin/bash', 20:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:20 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:20 INFO - 'USER': 'cltbld', 20:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:20 INFO - 'XPC_FLAGS': '0x0', 20:54:20 INFO - 'XPC_SERVICE_NAME': '0', 20:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:54:20 INFO - Cleaning up... 20:54:20 INFO - Return code: 0 20:54:20 INFO - Running post-action listener: _resource_record_post_action 20:54:20 INFO - Running post-action listener: _start_resource_monitoring 20:54:20 INFO - Starting resource monitoring. 20:54:20 INFO - [mozharness: 2016-11-01 03:54:20.807223Z] Finished create-virtualenv step (success) 20:54:20 INFO - [mozharness: 2016-11-01 03:54:20.808178Z] Running install step. 20:54:20 INFO - Running pre-action listener: _resource_record_pre_action 20:54:20 INFO - Running main action method: install 20:54:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:54:21 INFO - Reading from file tmpfile_stdout 20:54:21 INFO - Detecting whether we're running mozinstall >=1.0... 20:54:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:54:21 INFO - Reading from file tmpfile_stdout 20:54:21 INFO - Output received: 20:54:21 INFO - Usage: mozinstall [options] installer 20:54:21 INFO - Options: 20:54:21 INFO - -h, --help show this help message and exit 20:54:21 INFO - -d DEST, --destination=DEST 20:54:21 INFO - Directory to install application into. [default: 20:54:21 INFO - "/builds/slave/test"] 20:54:21 INFO - --app=APP Application being installed. [default: firefox] 20:54:21 INFO - mkdir: /builds/slave/test/build/application 20:54:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:54:55 INFO - Reading from file tmpfile_stdout 20:54:55 INFO - Output received: 20:54:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:54:55 INFO - Running post-action listener: _resource_record_post_action 20:54:55 INFO - [mozharness: 2016-11-01 03:54:55.717579Z] Finished install step (success) 20:54:55 INFO - [mozharness: 2016-11-01 03:54:55.717728Z] Running run-tests step. 20:54:55 INFO - Running pre-action listener: _resource_record_pre_action 20:54:55 INFO - Running main action method: run_tests 20:54:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:54:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:54:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:54:55 INFO - 2016-10-31 20:54:55.732 screenresolution[1642:7504] starting screenresolution argv=screenresolution get 20:54:55 INFO - 2016-10-31 20:54:55.734 screenresolution[1642:7504] Display 0: 1600x1200x32@60 20:54:55 INFO - 2016-10-31 20:54:55.740 screenresolution[1643:7506] starting screenresolution argv=screenresolution list 20:54:55 INFO - Available Modes on Display 0 20:54:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:54:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:54:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:54:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:54:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:54:55 INFO - Intel Iris: 20:54:55 INFO - Chipset Model: Intel Iris 20:54:55 INFO - Type: GPU 20:54:55 INFO - Bus: Built-In 20:54:55 INFO - VRAM (Dynamic, Max): 1536 MB 20:54:55 INFO - Vendor: Intel (0x8086) 20:54:55 INFO - Device ID: 0x0a2e 20:54:55 INFO - Revision ID: 0x0009 20:54:55 INFO - Displays: 20:54:55 INFO - Display: 20:54:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:54:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:54:55 INFO - Display Serial Number: 1600x1200 60 20:54:55 INFO - Main Display: Yes 20:54:55 INFO - Mirror: Off 20:54:55 INFO - Online: Yes 20:54:55 INFO - Rotation: Supported 20:54:55 INFO - Return code: 0 20:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:54:55 INFO - Python 2.7.3 20:54:55 INFO - Return code: 0 20:54:55 INFO - grabbing minidump binary from tooltool 20:54:55 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')]} 20:54:55 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 0x10d35bd30>, '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 0x10d181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d353b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:54:55 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 20:54:55 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 20:54:55 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 20:54:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:54:56 INFO - Return code: 0 20:54:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:54:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:54:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:54:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:54:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:54:56 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 20:54:56 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0095 --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 20:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sv2Fx0otiR/Render', 20:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:56 INFO - 'HOME': '/Users/cltbld', 20:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:56 INFO - 'LOGNAME': 'cltbld', 20:54:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:54:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:56 INFO - 'MOZ_NO_REMOTE': '1', 20:54:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:54:56 INFO - 'NO_EM_RESTART': '1', 20:54:56 INFO - 'PAGER': '/bin/cat', 20:54:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:56 INFO - 'PWD': '/builds/slave/test', 20:54:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:56 INFO - 'SHELL': '/bin/bash', 20:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GWMfytdD6b/Listeners', 20:54:56 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 20:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:56 INFO - 'USER': 'cltbld', 20:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:56 INFO - 'XPC_FLAGS': '0x0', 20:54:56 INFO - 'XPC_SERVICE_NAME': '0', 20:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:56 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 20:54:56 INFO - mozversion application_buildid: 20161031183902 20:54:56 INFO - mozversion application_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 20:54:56 INFO - mozversion application_display_name: Nightly 20:54:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:54:56 INFO - mozversion application_name: Firefox 20:54:56 INFO - mozversion application_remotingname: firefox 20:54:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:54:56 INFO - mozversion application_vendor: Mozilla 20:54:56 INFO - mozversion application_version: 52.0a1 20:54:56 INFO - mozversion platform_buildid: 20161031183902 20:54:56 INFO - mozversion platform_changeset: 21153294d3a0bf7ce8e5e6bb1a0e684745b88fda 20:54:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:54:56 INFO - mozversion platform_version: 52.0a1 20:54:56 INFO - using testdate: 1477972496 20:54:56 INFO - actual date: 1477972496 20:54:56 INFO - starting webserver on 'localhost:49269' 20:54:56 INFO - SUITE-START | Running 2 tests 20:54:56 INFO - TEST-START | dromaeo_css 20:54:56 INFO - operating with platform_type : mac_ 20:54:56 INFO - Initialising browser for dromaeo_css test... 20:54:56 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpP8gtIM/profile http://localhost:49269/getInfo.html) 20:54:58 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 20:54:58 INFO - PROCESS | 1653 | colorDepth:24 20:54:58 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 20:54:58 INFO - PROCESS | 1653 | __metrics 20:54:59 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:54:59 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:54:59 INFO - TEST-INFO | 1653: exit 0 20:54:59 INFO - Browser initialized. 20:54:59 INFO - Running cycle 1/1 for dromaeo_css test... 20:54:59 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpP8gtIM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:55:11 INFO - PROCESS | 1656 | RSS: Main: 239476736 20:55:11 INFO - PROCESS | 1656 | 20:56:02 INFO - PROCESS | 1656 | 1477972562927 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] 20:58:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 20:58:18 INFO - PROCESS | 1656 | RSS: Main: 392859648 20:58:18 INFO - PROCESS | 1656 | 21:01:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 21:01:21 INFO - PROCESS | 1656 | RSS: Main: 374808576 21:01:21 INFO - PROCESS | 1656 | 21:04:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 21:04:24 INFO - PROCESS | 1656 | RSS: Main: 337530880 21:04:24 INFO - PROCESS | 1656 | 21:07:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 21:07:27 INFO - PROCESS | 1656 | RSS: Main: 358805504 21:07:27 INFO - PROCESS | 1656 | 21:10:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 21:10:31 INFO - PROCESS | 1656 | RSS: Main: 327294976 21:10:31 INFO - PROCESS | 1656 | 21:13:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 21:13:35 INFO - PROCESS | 1656 | RSS: Main: 379953152 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | __start_tp_report 21:13:35 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 21:13:35 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 21:13:35 INFO - PROCESS | 1656 | |i|pagename|runs| 21:13:35 INFO - PROCESS | 1656 | |0;dojo.html;2839.758620517256;3199.936001279973;3215.9196020099507;3252.6909943555356;3276.574045374101;5409.215663728767;5447.536959358455;5468.589855760824;5528.668279903209;5539.556835453164;5508.724563771805;5523.171524271362;5534.667919924807;5537;5545.195946587743;5021.347224860772;5055.368078990108;5059.620528460362;5095;5130.846074617767;5043.773030213631;5058.721770302632;5072.2391641253735;5108.157154069592;5131.589472842183;4539.54604539545;5096.4648711885275;5105.744712764365;5107.565856902168;5147.202183661539;4747.786349614275;5107.182850743863;5122.3853137623355;5127.641065125443;5170.6122040847085;3983.4821473208585;4117.91764164715;4878.463369029404;5023.673461225045;5076.44159142494;5345.064613692588;5413.756380962866;5423.755930983115;5429.56563474921;5454.181872719084;5799.536037117021;5904.822855314347;5923.526117910556;5925.911111333334;5926.259217597801;5800.651960882318;5862.9446699594055;5911.083782013795;5962;6033.913895498808;5607.355154157242;5613.270274864241;5613.270274864323;5621.887562248773;5641.041023026137;6165.599236049642;6207.875842483216;6215.875682486325;6222.191115155091;6224.37756224374;5750.763585828983;5786.594938354359;5805.535557155417;5826;5834.3290521589715;5879.323877754027;5915.526757859361;5929.673867937305;5935.821925342247;5971.790987315423;5871.970640146772;5890.145928840294;5903.881922361528;5922.911156332659;5923.851903702442;4900.681455705368;5852.970735146297;5912.497437717756;5918.911216331759;5921;4779.211430114062;4785.282207668877;4791;4791.377120974321;4792.897633544304;4172.749635021908;4258.339957306623;4365.476142862877;4380.430544029319;4386.385905973167;5624.521915637217;5634.7182640867795;5640.379558248589;5666.263385759825;5679.460451257124;6111.633302001894;6116.449519543174;6123.908141377883;6140.938590614126;6145.477634401126;5506.256655351476;5617.887642247214;5635.520980716685;5640.182173584807;5653.971730141405;5199.194124910645;5203.583713303003;5231.136862417735;5257.76340064698;5276.182191760283;6244.812655620339;6270.623762574169;6273.247210334789;6290.685465726787;6303.2436107665535;6031.155638210566;6096;6102.603330783485;6112.663803490851;6112.847178820565;6097.2988106366565;6121.204243448323;6141.385861413823;6154.569180157346;6263.874722505433;5847.298324201123;5878.177055212188;5917.940820591739;5927.555433342603;5975.671338076448;6026.969865150646;6030.75876964934;6043.033114701627;6044.879102417839;6066.059760737093;5682.744276507485;5720.3707592164;5828.0966450200285;5845.473907348359;5878.647281163144;4458.665600079942;5758.2514273144225;5823.650580965155;5844.503217226584;5847.8245652630485;5723.255976723;5732.684702341411;5739;5739.598228123991;5780.913286300624;4887.340209071872;5848.385919478564;5879.970600146972;5882.882342353215;5885.61743486672;4657.278121891112;5544.279243698455;5603.215549822947;5639.7744090237575;5654.067078932095 21:13:35 INFO - PROCESS | 1656 | |1;ext.html;472.4519557313517;497.858110438525;508.1869009584667;514.7143335448825;548.9980785067253;30334.848325758394;31071.2232194195;39111;40206.597934020654;40280;41391;41564.792176039155;41881;41884.162316753645;41895.79052104743;9298.256139508823;9478.526073696323;9481.715548533555;9482.525873706321;9515.524223788818;9304.81390372192;9411.247100231965;9420.963693993655;9422.528873556295;9449.81100377992;9395.76510587234;9453.574589143505;9464.81070378592;9467.337286389955;9472.194863436616;9363.906360936371;9400.388974716621;9415.058494150564;9415.576299066559;9421.246300296028;9239.861402078974;9315.021922698155;9328.580213890391;9336.57985390659;9357.906420935771;39741;40124.796256112364;40156.39765403492;40163;40187.19625607471;3288.704016638514;3309.7352211822995;3340.1816554943953;3364.0412482442384;3386.847591858372;30083.849580751958;30351.089467316015;30992;31567.52648710271;31633.20916977094;2623.698274698415;3139.6232452105664;3185.155933677577;3208.1017315151794;3326.1518312830317;472994;479573;479854.0109491802;480786;493583;57371.713141434026;57807.71096144492;57891.42108578861;57940;58008.709956449944;61061.69469152626;61205;61230.693846530485;61236.693816530635;61254.08118878131;15708.92145539265;15908.602284942737;15913.602159945862;15943.840561594236;15956.840431595536;12376.876231237753;12457.875421245672;12465.563705270271;12484.81272780909;12487.438065287084;13145.868541314465;15896.682066358608;16277.67444651124;16316.184190790413;16405.58986025359;6640.568363056386;6645.806883728358;6668.566543174678;6721.563098398687;6774.356436138658;774.9189880117204;782.4288269563251;962.3648392061206;971.2715463402449;1035.2297571153413;24424.75575244225;29223.56164657532;29422.970196043465;29769.553456698166;30964.380712385628;977;1014.1937159957852;1084.3764835219781;1101.3832253937821;1113.5991043224433;14737.778933316009;15150.242487875563;15272.31274592646;15335.923320383326;15848.60378490547;603821;604949;607386;607856;607979;55587.72206138943;55863;55885.720571397695;55924.720376397854;55955.44044559502;1210.2435977514053;1250.7123361626695;1319.7426501832242;1346.508524388591;1373.3819781098546;28194.718052819208;29041.7095829039;29101;30436.84781576078;30645.387092258476;48330.03339933252;48983;49015.26477102918;49108;49109.01781964269;421460;421505;422120;422307;422682;37852.05369865776;39085.2182956345;39216;39416.80291598524;39459.802700986314;45265.773671131436;45622.31566526438;46260;46435.767821160676;47162.76418617885;36619.63380366269;36736.448953266256;37037.814810925775;37783.62216377911;37875.431868522544;30358.69641303559;36171.63828361683;38541.80729096449;39059.41410878896;39101.60898391093;36964.81517592395;37564.436533452565;37826.62173378231;37981.050473738374;38095.42856857094;30186.094417167522;33798.83100584481;34087;34187.14532136716;34205.828970854986;23988.88005559961;24298.392540186636;24441.755582443948;24954.251372458857;25481.49037019212 21:13:35 INFO - PROCESS | 1656 | |2;jquery.html;309.50942755732166;349.33451774369837;367.10609665464597;367.6819551088308;397.1025482409753;14211.502597409106;14791.038582492143;15174.468893588726;19283.517912052204;20036.89797061161;19615.509612259702;19928.01439712056;19955.30156444521;20386.286479973205;20482.38552843417;5097.668651537657;5513.4210907854595;5785.797497087603;5928.97035514824;5930.525557955375;5608.887822243552;5760.510356619692;5856.092305692625;5907.320658124307;5909.172715819789;5847.766089356442;5859.472647461727;5864.2962844458725;5866.6480011199255;5885.293764748236;5554.666719996793;5741.799037033705;5813;5839.0949402842625;5845.152452894349;4942.975285123552;5094.261332106861;5100.209467532539;5105.489451054902;5106.719130447824;21088.156473741186;25006.249812505655;25455.49089018228;25639.359016024748;25925;2351.4356554426986;2561.6285638582303;2706.404590989979;2814.8177765338605;2885.8268503889835;12579.685507862285;14390.28048597566;15229.695406091927;15938.28277727505;16013;1548.442560678155;1641.8029836419705;1841.300305883769;1887.631911777204;1945.6984167454068;90972;97781.02218977861;117252.41373793076;118636.40681796623;119389.40305298504;7777.5722335270975;9120.850013243959;10280.766308042934;10328.990439636771;10938.671839844817;14205;14225.573232803032;14233.00368974162;14234.928825355806;14236;7720.498167619086;7933.444658873939;8273;8292.543910084883;8404;6599.868002639921;8129.634166462523;8140.430169888051;8307.044689860622;8309.127541608164;3662.6703596675893;4406.20688276107;4410.669199810027;4464.397306363664;4471.441069866267;1835.3484512997693;1869.9532511687316;1880.1163453176985;1882.4070417818343;1885;719.4208662027014;736.576468530597;768.7386288661882;784.4391260248835;793.9325157361574;19471;20806.79193208079;20880.686789698168;21222.893885530473;21367.8931605341;804.8148925746993;807.0799288810761;882.2280504558511;928.2620316848122;929.5816882402946;8795.868061979076;10939.28894621847;11294.887051129548;11318.377489238006;11379.317240965569;506089;510242;555691;569428;570150;98327.50836245772;133855;140288;144774;148336.58317084104;961.8893827209961;980.9852852207223;1012.9088382045651;1015.0661391519819;1016.6238491757949;19222.61554768925;19589.804101958798;19597.60804783868;19615;19630.209088318694;44645.77677111594;52918.677033074484;54917;54946.72526637341;56097.597560061324;75639;76879;79292;82820.58589707012;84340;6940.722371105099;7415.629218539159;7765.922340776746;7837.098733645704;7985.600719964094;8475.533845638549;11546.48040838181;12717.55488557896;12769.361531923552;13180.868191318348;10645.680629581126;10705.250632455653;10919.290246133976;11347.659570212907;11371.20401571882;9809.215262779104;10060.195184385379;10756.623518176826;10775.838362424727;10933.671989840317;11309.151813613847;11507.252028618113;11685;11711.590094346657;11762.059035276987;6909.79270621862;7113.0753002109395;7294.781156565312;7380;7596.240375962359;8885.600147993226;9378.717448892832;11155.665330040112;11160.944195278971;11237.550497980315 21:13:35 INFO - PROCESS | 1656 | |3;mootools.html;1252.2048499203006;1460.37204002279;1569.427159086933;1770.1326350088461;1806.6025474395628;7788.376929845613;8208.302294304976;8211.466254693449;8211.507309561423;8222.259996600305;7297.306755858185;7507.624618769067;7509.849803003936;7814.7264845730415;7972.681092756283;2223.566404551109;2259.898304576298;2263.321003698892;2264.705588273522;2265.4336415896028;2250.6173950428465;2288.336382449088;2292.0946226240626;2295.483516208848;2302.7121609798774;2246.3261021693506;2256.7291924969027;2270.3642979965634;2281.851679640818;2282.4065742906796;2241.495663475713;2262.558801033799;2263.8868056597103;2264.060414927803;2266.195500597289;2016.899155042242;2133.9146434142617;2254.177225312749;2267.013848975701;2281.832259353604;8092.757217283432;8095.473794203417;8177.182281771775;8205.753827385188;8207.95896020522;4903.289023091667;5078.339815823956;5090.720010399426;5096.235564665293;5097.954919241547;3247.480403135487;3443.9827800861085;3445.2764919366714;3510.3154884797473;3521.8767343142868;961.4759955824093;1011.8735158105237;1054.2830875004993;1056.434807378049;1060.5386656804314;10614.946925265402;10642.73393165177;10647.935206479367;10649.840252396298;10658;3624.2751449710163;3738.719596030309;4301.978490107592;4449.7330160190495;4472.306792447111;8142.715004974797;9128;9196.678116266032;9197.632094716137;9211;5071.746412679351;5072.644914855999;5073.923891141636;5077.238414237894;5079.6698214615935;4465.397171381822;4590.862274131781;4594.632429405639;4612.60792832613;4693.413323334583;3589.6948759355223;3608.4226523756597;3632.164602141522;3671.7980511072146;3716.7026637868908;1086.9673909782719;1158.808796548577;1200.8919197272287;1201.6395081475698;1207.849018872641;737.6836732659453;786.5045021636332;790.1308560583312;886.8182022685463;913.4336711238941;5487.5609951203805;5572.554195664337;5636.379998200195;5659.518940890071;5913.940860591425;770.3221165374434;836.656970642046;876.8903887014123;899.680613382253;979.1970584121095;3534.7525673203145;3718.8140592970785;3766.246750649881;3812.8856134316015;3852.845886164578;9348.20540254086;9794.265430092772;9834.213262938947;9840;9872.111509963994;8347.373946954003;9408.294377921684;9806.705798826046;9808.21534277256;9843.163331116792;7590.1650818409935;7737.303642672074;7739.690412383442;7741.148473667892;7791.948087008182;4819.7108173509705;5297.152455607084;5336.519713225828;5378.569714422759;5636.957162924872;9026.638934442548;9095.636174552943;9164.541772911462;9295.25637948976;9306.581203845979;8758.649654013769;8955.686550970684;9053.592588333673;9130.49782261982;9292.02433744447;6863.485238607024;7056.259092795388;7065.964670176616;7070.469714771516;7080.610566418896;7058.964705176441;7146.928530714834;7586.203448637813;7607.923920760722;7695.115061767969;6913.827154320981;6959.582425054513;6985.860282794417;7018.75434359795;7021.473389495911;6749.156355455568;6834.453243740588;6835.521513494206;6868.965655171892;6900.482463815133;6427.453666438405;6522.902156467751;6528.347165283623;6532.477401807749;6534.379233972765;4645.372874661877;4726.976365118152;4786.210275304675;4795.232762757942;4862.878428039327;4549.363089167586;4712.622990160848;4721.858344249678;4777.665563410528;4975.626827987843 21:13:35 INFO - PROCESS | 1656 | |4;prototype.html;275.3803941132452;281.86752226453575;296.33325018707905;302.8107432854466;303.0831734004636;4976.527229913152;5083.364579427572;5120.641555091145;5176.870578235541;5364.310242273681;4358.956410435895;4673.45775893955;5276;5315.39545622645;5319.787208511655;3357.7145942594907;3976.622220889011;4017.7790221537803;4025.81883815229;4026.8187931543152;3193.722510995597;3789.905252368699;3886.7084968627464;4023.3361495353233;4068.9186216275657;3989.9800500997453;4006.6394024537785;4014.116894283268;4015.678745700337;4018.0065850940946;3315.8342082896;3975.2447035063533;4023.476947996771;4030.355143177107;4031.971847178965;3231;3486.459598762196;3498.492718555821;3500.5799304083416;3501.299740052;4372.912541749179;4435.467743870724;4691.991221887277;5147.613928955343;5172.749853813565;3803.5055442792536;4205.453291072172;4565.6943243661735;4573.245414506602;4582.266837306015;5101.7194054327;5567.610267281292;5571.749271282762;5589.742307980712;5600.60795744294;3118.4230917280147;3740.7007439405056;3783.332750410954;3784.2620688965662;3793.7723736575895;4906.950930490721;5087.6929995503215;5820.82537523875;5835.328937172237;5876.706164691748;3369.309291595217;3808.2002779416634;3823.5602905665646;3838.481804956351;3856.845726170922;3350.1792060945227;3748.2690875279604;3766.982914613039;3904.7657140571655;3908.472356231929;3673.1918977824835;4178.331466965271;4277.786110694453;4407.338899165151;4583.4041574595085;4715.3869996900185;4973.701577905337;5409.538659909732;5661.46216109469;5695.373508914016;1133.4616057372682;1324.8873845723028;1343.2544937559553;1344.8184495093233;1348.2719331561043;825.0965193113531;833.6123702478377;856.7900864288289;888.8977767556813;901.7610333261691;4599.241125214369;5006.849794506171;5227.869303267449;5270.341207349082;5301.257823904656;4825.9034819303415;5642.71786410686;5691.971540142273;5716.941900915667;5729;4942.802287908516;5179.948200517946;5201.271821944931;5219.869503262373;5394.437642119961;2659.428222932079;2723.550614148683;2756.641636587271;3018.969810301869;3072.2319420144963;5136.5377116059735;5307.52232299095;5624.73443475223;5625.6905870176715;5684.459976302244;4949.455559888409;5278.392984806796;5341.878205576794;5861.706914654335;5973.313068997034;4991.650584459053;5932.292317301686;5956.493698035629;5960.731767070492;5972.910406343908;4906.828261010847;5417.891642167056;5448.727563621724;5753.626014309057;5822.94177058224;5640.294963129609;5667.716614169358;5684.658920464785;5692.6660069371355;5703.714814259353;4472.038511719996;4827.565519103297;5834.824955251349;5968.850778730392;6004.609700369462;3096.427160975227;3440.587129544471;3445.328161008579;3547.3082748863726;3817.770933743984;5478.342598888;5628.887422251614;5698.344690360662;5743.6840973745175;5765.682887441231;4634.9536504634525;5558.610897237155;5573.885222955344;5576.832695019156;5584.525315348078;4653.744044077608;5405.567554595702;5546.334439867242;5617.354004289559;5668.886622267614;4871.415430148405;5316.973415132899;5456.108262620817;5462.371827239918;5552.9449404613;4761.381020467317;5095.464976177448;5598.356189038313;5647.519960803378;5668.291463567054;4267.338562522814;4614.238650622744;4865.854024379133;5474.42518535564;5484.890302194013 21:13:35 INFO - PROCESS | 1656 | |5;yui.html;699.1575151941911;745.962701864907;753.7587971849009;773.6634563964673;792.8810678398241;14869.702605947889;15213.163276019815;15230.162341071236;15230.77153842692;15558.52194041567;13380.531681391129;13515.93242033791;13519.459221631123;13529.458821647147;13535.18788872666;588.8851673923565;634.3529599808193;666.3103687683249;666.3336663336663;805.9032916050068;797.3342259213564;819.6844214977247;820.1593366799019;821.4126899267023;826.6817275349003;856.0583358305876;876.4609764994515;876.9035406105323;877.6226222724226;878.0780180810156;871.2115535440437;871.9738407847743;872.2847265242503;873.6898401067593;874.0254616103063;503.66757939759583;520.9114450543417;521.9947800521984;644.6647743173523;644.7646608987733;12018.15872888898;12125.818112728317;13404;13744.587662370144;13801.102928309629;13365.198088114745;13645.658858528517;13716.65708357289;13730.038897277194;13763.036587438883;11117.388543630097;11263.718407039807;11361.829572556418;11457;11723;3658.506101676266;3663.8900832975055;3703.2408356286896;3736.8505259789576;3828.3874580067054;86540.13459865384;86871.56564217138;87843;88121;88972.55513722455;10547.894521054692;10654.520546575422;10726.647040101821;10887.455627218607;10926.726831829108;18454.446366609023;21029;21056.473588160112;21078.629889057163;21082.683759743617;6347.238331400262;7418.703251869865;7448.888266676005;7490.250974902466;7725.922740772633;4169.291220492463;4219.409282700424;4254.468191476066;4269.935950960738;4370.366296886934;3378;3421.674940880612;3486.738494612914;3487.773294735834;3503.702185314226;571.3657839797821;573.1259828761173;577.6014549960514;589.7611467355728;589.802416190581;564.7261078376984;576.6194311754306;592.9555283353766;638.4381744065192;666.8066260784318;8655.740327790176;8971.192592666692;9025.41334813235;9122.883931329365;9233.261339092856;540.783686525393;565.1861319699619;582.758155365527;589.4665327878276;648.8215740671353;4204.2850024912805;4268.850590229389;4427.180971520279;4441.555844415597;4446.755428451402;71610.64194679097;72895.27104728884;113439;114834.42582787032;116878;81270.18729812745;84344;106772;107196;109872;67936.29668621528;71932;76594.23405765982;78672.6066369676;82475;9360.391574547633;9556.187724043533;9596.472194029117;9599.47202903847;9613.134817866425;48311.75844120757;49533.009339812284;51084.168687347854;51842.48157518377;52599;67026.66486667536;68948;69276.61446771138;70653;70752;11800.822987655363;11992.580259690869;12050.75898482043;12160.148789584644;12665.176763510342;11736.530538778694;13777.655558610713;14273.64315892111;14289.999700020899;14522.346494407988;12575.434105465092;13210;13345.332733363488;13346.19922804635;13371.130876492996;12542.435590398272;13053.02102342309;13467.730645387233;13490.52783152585;13608.387622556811;10686.198535109743;10791.352518848895;11064.723381915517;11168.832467512831;11191.832122518332;10388.117010053928;10726.195535334726;10801.67594972152;10881.891181088404;11095.5561777528;9278.211352034883;10412.271141020055;10611.469426528796;11042.233242681132;11163.888361116286 21:13:35 INFO - PROCESS | 1656 | __end_tp_report 21:13:35 INFO - PROCESS | 1656 | __start_cc_report 21:13:35 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1631 21:13:35 INFO - PROCESS | 1656 | __end_cc_report 21:13:35 INFO - PROCESS | 1656 | __startTimestamp1477973615243__endTimestamp 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | ------- Summary: start ------- 21:13:35 INFO - PROCESS | 1656 | Number of tests: 6 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5507.45 Median:5679.46 stddev:652.62 (11.5%) stddev-sans-first:620.16 21:13:35 INFO - PROCESS | 1656 | Values: 2839.8 3199.9 3215.9 3252.7 3276.6 5409.2 5447.5 5468.6 5528.7 5539.6 5508.7 5523.2 5534.7 5537.0 5545.2 5021.3 5055.4 5059.6 5095.0 5130.8 5043.8 5058.7 5072.2 5108.2 5131.6 4539.5 5096.5 5105.7 5107.6 5147.2 4747.8 5107.2 5122.4 5127.6 5170.6 3983.5 4117.9 4878.5 5023.7 5076.4 5345.1 5413.8 5423.8 5429.6 5454.2 5799.5 5904.8 5923.5 5925.9 5926.3 5800.7 5862.9 5911.1 5962.0 6033.9 5607.4 5613.3 5613.3 5621.9 5641.0 6165.6 6207.9 6215.9 6222.2 6224.4 5750.8 5786.6 5805.5 5826.0 5834.3 5879.3 5915.5 5929.7 5935.8 5971.8 5872.0 5890.1 5903.9 5922.9 5923.9 4900.7 5853.0 5912.5 5918.9 5921.0 4779.2 4785.3 4791.0 4791.4 4792.9 4172.7 4258.3 4365.5 4380.4 4386.4 5624.5 5634.7 5640.4 5666.3 5679.5 6111.6 6116.4 6123.9 6140.9 6145.5 5506.3 5617.9 5635.5 5640.2 5654.0 5199.2 5203.6 5231.1 5257.8 5276.2 6244.8 6270.6 6273.2 6290.7 6303.2 6031.2 6096.0 6102.6 6112.7 6112.8 6097.3 6121.2 6141.4 6154.6 6263.9 5847.3 5878.2 5917.9 5927.6 5975.7 6027.0 6030.8 6043.0 6044.9 6066.1 5682.7 5720.4 5828.1 5845.5 5878.6 4458.7 5758.3 5823.7 5844.5 5847.8 5723.3 5732.7 5739.0 5739.6 5780.9 4887.3 5848.4 5880.0 5882.9 5885.6 4657.3 5544.3 5603.2 5639.8 5654.1 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:64401.57 Median:40159.70 stddev:135687.55 (337.9%) stddev-sans-first:135983.29 21:13:35 INFO - PROCESS | 1656 | Values: 472.5 497.9 508.2 514.7 549.0 30334.8 31071.2 39111.0 40206.6 40280.0 41391.0 41564.8 41881.0 41884.2 41895.8 9298.3 9478.5 9481.7 9482.5 9515.5 9304.8 9411.2 9421.0 9422.5 9449.8 9395.8 9453.6 9464.8 9467.3 9472.2 9363.9 9400.4 9415.1 9415.6 9421.2 9239.9 9315.0 9328.6 9336.6 9357.9 39741.0 40124.8 40156.4 40163.0 40187.2 3288.7 3309.7 3340.2 3364.0 3386.8 30083.8 30351.1 30992.0 31567.5 31633.2 2623.7 3139.6 3185.2 3208.1 3326.2 472994.0 479573.0 479854.0 480786.0 493583.0 57371.7 57807.7 57891.4 57940.0 58008.7 61061.7 61205.0 61230.7 61236.7 61254.1 15708.9 15908.6 15913.6 15943.8 15956.8 12376.9 12457.9 12465.6 12484.8 12487.4 13145.9 15896.7 16277.7 16316.2 16405.6 6640.6 6645.8 6668.6 6721.6 6774.4 774.9 782.4 962.4 971.3 1035.2 24424.8 29223.6 29423.0 29769.6 30964.4 977.0 1014.2 1084.4 1101.4 1113.6 14737.8 15150.2 15272.3 15335.9 15848.6 603821.0 604949.0 607386.0 607856.0 607979.0 55587.7 55863.0 55885.7 55924.7 55955.4 1210.2 1250.7 1319.7 1346.5 1373.4 28194.7 29041.7 29101.0 30436.8 30645.4 48330.0 48983.0 49015.3 49108.0 49109.0 421460.0 421505.0 422120.0 422307.0 422682.0 37852.1 39085.2 39216.0 39416.8 39459.8 45265.8 45622.3 46260.0 46435.8 47162.8 36619.6 36736.4 37037.8 37783.6 37875.4 30358.7 36171.6 38541.8 39059.4 39101.6 36964.8 37564.4 37826.6 37981.1 38095.4 30186.1 33798.8 34087.0 34187.1 34205.8 23988.9 24298.4 24441.8 24954.3 25481.5 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:33213.11 Median:2014.89 stddev:91266.69 (4529.6%) stddev-sans-first:91489.27 21:13:35 INFO - PROCESS | 1656 | Values: 309.5 349.3 367.1 367.7 397.1 14211.5 14791.0 15174.5 19283.5 20036.9 19615.5 19928.0 19955.3 20386.3 20482.4 5097.7 5513.4 5785.8 5929.0 5930.5 5608.9 5760.5 5856.1 5907.3 5909.2 5847.8 5859.5 5864.3 5866.6 5885.3 5554.7 5741.8 5813.0 5839.1 5845.2 4943.0 5094.3 5100.2 5105.5 5106.7 21088.2 25006.2 25455.5 25639.4 25925.0 2351.4 2561.6 2706.4 2814.8 2885.8 12579.7 14390.3 15229.7 15938.3 16013.0 1548.4 1641.8 1841.3 1887.6 1945.7 90972.0 97781.0 117252.4 118636.4 119389.4 7777.6 9120.9 10280.8 10329.0 10938.7 14205.0 14225.6 14233.0 14234.9 14236.0 7720.5 7933.4 8273.0 8292.5 8404.0 6599.9 8129.6 8140.4 8307.0 8309.1 3662.7 4406.2 4410.7 4464.4 4471.4 1835.3 1870.0 1880.1 1882.4 1885.0 719.4 736.6 768.7 784.4 793.9 19471.0 20806.8 20880.7 21222.9 21367.9 804.8 807.1 882.2 928.3 929.6 8795.9 10939.3 11294.9 11318.4 11379.3 506089.0 510242.0 555691.0 569428.0 570150.0 98327.5 133855.0 140288.0 144774.0 148336.6 961.9 981.0 1012.9 1015.1 1016.6 19222.6 19589.8 19597.6 19615.0 19630.2 44645.8 52918.7 54917.0 54946.7 56097.6 75639.0 76879.0 79292.0 82820.6 84340.0 6940.7 7415.6 7765.9 7837.1 7985.6 8475.5 11546.5 12717.6 12769.4 13180.9 10645.7 10705.3 10919.3 11347.7 11371.2 9809.2 10060.2 10756.6 10775.8 10933.7 11309.2 11507.3 11685.0 11711.6 11762.1 6909.8 7113.1 7294.8 7380.0 7596.2 8885.6 9378.7 11155.7 11160.9 11237.6 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5284.69 Median:5316.84 stddev:2881.41 (54.2%) stddev-sans-first:2873.55 21:13:35 INFO - PROCESS | 1656 | Values: 1252.2 1460.4 1569.4 1770.1 1806.6 7788.4 8208.3 8211.5 8211.5 8222.3 7297.3 7507.6 7509.8 7814.7 7972.7 2223.6 2259.9 2263.3 2264.7 2265.4 2250.6 2288.3 2292.1 2295.5 2302.7 2246.3 2256.7 2270.4 2281.9 2282.4 2241.5 2262.6 2263.9 2264.1 2266.2 2016.9 2133.9 2254.2 2267.0 2281.8 8092.8 8095.5 8177.2 8205.8 8208.0 4903.3 5078.3 5090.7 5096.2 5098.0 3247.5 3444.0 3445.3 3510.3 3521.9 961.5 1011.9 1054.3 1056.4 1060.5 10614.9 10642.7 10647.9 10649.8 10658.0 3624.3 3738.7 4302.0 4449.7 4472.3 8142.7 9128.0 9196.7 9197.6 9211.0 5071.7 5072.6 5073.9 5077.2 5079.7 4465.4 4590.9 4594.6 4612.6 4693.4 3589.7 3608.4 3632.2 3671.8 3716.7 1087.0 1158.8 1200.9 1201.6 1207.8 737.7 786.5 790.1 886.8 913.4 5487.6 5572.6 5636.4 5659.5 5913.9 770.3 836.7 876.9 899.7 979.2 3534.8 3718.8 3766.2 3812.9 3852.8 9348.2 9794.3 9834.2 9840.0 9872.1 8347.4 9408.3 9806.7 9808.2 9843.2 7590.2 7737.3 7739.7 7741.1 7791.9 4819.7 5297.2 5336.5 5378.6 5637.0 9026.6 9095.6 9164.5 9295.3 9306.6 8758.6 8955.7 9053.6 9130.5 9292.0 6863.5 7056.3 7066.0 7070.5 7080.6 7059.0 7146.9 7586.2 7607.9 7695.1 6913.8 6959.6 6985.9 7018.8 7021.5 6749.2 6834.5 6835.5 6869.0 6900.5 6427.5 6522.9 6528.3 6532.5 6534.4 4645.4 4727.0 4786.2 4795.2 4862.9 4549.4 4712.6 4721.9 4777.7 4975.6 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4438.11 Median:4961.58 stddev:1388.27 (28.0%) stddev-sans-first:1356.55 21:13:35 INFO - PROCESS | 1656 | Values: 275.4 281.9 296.3 302.8 303.1 4976.5 5083.4 5120.6 5176.9 5364.3 4359.0 4673.5 5276.0 5315.4 5319.8 3357.7 3976.6 4017.8 4025.8 4026.8 3193.7 3789.9 3886.7 4023.3 4068.9 3990.0 4006.6 4014.1 4015.7 4018.0 3315.8 3975.2 4023.5 4030.4 4032.0 3231.0 3486.5 3498.5 3500.6 3501.3 4372.9 4435.5 4692.0 5147.6 5172.7 3803.5 4205.5 4565.7 4573.2 4582.3 5101.7 5567.6 5571.7 5589.7 5600.6 3118.4 3740.7 3783.3 3784.3 3793.8 4907.0 5087.7 5820.8 5835.3 5876.7 3369.3 3808.2 3823.6 3838.5 3856.8 3350.2 3748.3 3767.0 3904.8 3908.5 3673.2 4178.3 4277.8 4407.3 4583.4 4715.4 4973.7 5409.5 5661.5 5695.4 1133.5 1324.9 1343.3 1344.8 1348.3 825.1 833.6 856.8 888.9 901.8 4599.2 5006.8 5227.9 5270.3 5301.3 4825.9 5642.7 5692.0 5716.9 5729.0 4942.8 5179.9 5201.3 5219.9 5394.4 2659.4 2723.6 2756.6 3019.0 3072.2 5136.5 5307.5 5624.7 5625.7 5684.5 4949.5 5278.4 5341.9 5861.7 5973.3 4991.7 5932.3 5956.5 5960.7 5972.9 4906.8 5417.9 5448.7 5753.6 5822.9 5640.3 5667.7 5684.7 5692.7 5703.7 4472.0 4827.6 5834.8 5968.9 6004.6 3096.4 3440.6 3445.3 3547.3 3817.8 5478.3 5628.9 5698.3 5743.7 5765.7 4635.0 5558.6 5573.9 5576.8 5584.5 4653.7 5405.6 5546.3 5617.4 5668.9 4871.4 5317.0 5456.1 5462.4 5552.9 4761.4 5095.5 5598.4 5647.5 5668.3 4267.3 4614.2 4865.9 5474.4 5484.9 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:19709.43 Median:4320.15 stddev:28629.21 (662.7%) stddev-sans-first:28673.94 21:13:35 INFO - PROCESS | 1656 | Values: 699.2 746.0 753.8 773.7 792.9 14869.7 15213.2 15230.2 15230.8 15558.5 13380.5 13515.9 13519.5 13529.5 13535.2 588.9 634.4 666.3 666.3 805.9 797.3 819.7 820.2 821.4 826.7 856.1 876.5 876.9 877.6 878.1 871.2 872.0 872.3 873.7 874.0 503.7 520.9 522.0 644.7 644.8 12018.2 12125.8 13404.0 13744.6 13801.1 13365.2 13645.7 13716.7 13730.0 13763.0 11117.4 11263.7 11361.8 11457.0 11723.0 3658.5 3663.9 3703.2 3736.9 3828.4 86540.1 86871.6 87843.0 88121.0 88972.6 10547.9 10654.5 10726.6 10887.5 10926.7 18454.4 21029.0 21056.5 21078.6 21082.7 6347.2 7418.7 7448.9 7490.3 7725.9 4169.3 4219.4 4254.5 4269.9 4370.4 3378.0 3421.7 3486.7 3487.8 3503.7 571.4 573.1 577.6 589.8 589.8 564.7 576.6 593.0 638.4 666.8 8655.7 8971.2 9025.4 9122.9 9233.3 540.8 565.2 582.8 589.5 648.8 4204.3 4268.9 4427.2 4441.6 4446.8 71610.6 72895.3 113439.0 114834.4 116878.0 81270.2 84344.0 106772.0 107196.0 109872.0 67936.3 71932.0 76594.2 78672.6 82475.0 9360.4 9556.2 9596.5 9599.5 9613.1 48311.8 49533.0 51084.2 51842.5 52599.0 67026.7 68948.0 69276.6 70653.0 70752.0 11800.8 11992.6 12050.8 12160.1 12665.2 11736.5 13777.7 14273.6 14290.0 14522.3 12575.4 13210.0 13345.3 13346.2 13371.1 12542.4 13053.0 13467.7 13490.5 13608.4 10686.2 10791.4 11064.7 11168.8 11191.8 10388.1 10726.2 10801.7 10881.9 11095.6 9278.2 10412.3 10611.5 11042.2 11163.9 21:13:35 INFO - PROCESS | 1656 | -------- Summary: end -------- 21:13:35 INFO - PROCESS | 1656 | 21:13:35 INFO - TEST-INFO | 1656: exit 0 21:13:35 INFO - TEST-OK | dromaeo_css | took 1119533ms 21:13:35 INFO - TEST-START | kraken 21:13:35 INFO - operating with platform_type : mac_ 21:13:35 INFO - Initialising browser for kraken test... 21:13:35 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpRmT6Md/profile http://localhost:49269/getInfo.html) 21:13:38 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 21:13:38 INFO - PROCESS | 1663 | colorDepth:24 21:13:38 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 21:13:38 INFO - PROCESS | 1663 | __metrics 21:13:38 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:13:38 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:13:38 INFO - TEST-INFO | 1663: exit 0 21:13:38 INFO - Browser initialized. 21:13:38 INFO - Running cycle 1/1 for kraken test... 21:13:38 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpRmT6Md/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:13:50 INFO - PROCESS | 1664 | RSS: Main: 240197632 21:13:50 INFO - PROCESS | 1664 | 21:13:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 21:13:54 INFO - PROCESS | 1664 | RSS: Main: 291090432 21:13:54 INFO - PROCESS | 1664 | 21:13:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 21:13:57 INFO - PROCESS | 1664 | RSS: Main: 289865728 21:13:57 INFO - PROCESS | 1664 | 21:14:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 21:14:02 INFO - PROCESS | 1664 | RSS: Main: 382218240 21:14:02 INFO - PROCESS | 1664 | 21:14:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 21:14:04 INFO - PROCESS | 1664 | RSS: Main: 285196288 21:14:04 INFO - PROCESS | 1664 | 21:14:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:14:07 INFO - PROCESS | 1664 | RSS: Main: 289783808 21:14:07 INFO - PROCESS | 1664 | 21:14:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 21:14:10 INFO - PROCESS | 1664 | RSS: Main: 325992448 21:14:10 INFO - PROCESS | 1664 | 21:14:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 21:14:14 INFO - PROCESS | 1664 | RSS: Main: 326410240 21:14:14 INFO - PROCESS | 1664 | 21:14:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 21:14:17 INFO - PROCESS | 1664 | RSS: Main: 325218304 21:14:17 INFO - PROCESS | 1664 | 21:14:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:14:19 INFO - PROCESS | 1664 | RSS: Main: 303722496 21:14:19 INFO - PROCESS | 1664 | 21:14:21 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:14:22 INFO - PROCESS | 1664 | RSS: Main: 304345088 21:14:22 INFO - PROCESS | 1664 | 21:14:24 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:14:25 INFO - PROCESS | 1664 | RSS: Main: 306405376 21:14:25 INFO - PROCESS | 1664 | 21:14:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:14:28 INFO - PROCESS | 1664 | RSS: Main: 324366336 21:14:28 INFO - PROCESS | 1664 | 21:14:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:14:32 INFO - PROCESS | 1664 | RSS: Main: 317911040 21:14:32 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 21:14:34 INFO - PROCESS | 1664 | RSS: Main: 362102784 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | __start_tp_report 21:14:34 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 21:14:34 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 21:14:34 INFO - PROCESS | 1664 | |i|pagename|runs| 21:14:34 INFO - PROCESS | 1664 | |0;ai-astar;113;114;114;113;113;113;113;113;112;113 21:14:34 INFO - PROCESS | 1664 | |1;audio-beat-detection;142;113;112;147;112;135;139;96;161;142 21:14:34 INFO - PROCESS | 1664 | |2;audio-dft;184;182;184;187;185;184;183;247;239;183 21:14:34 INFO - PROCESS | 1664 | |3;audio-fft;80;59;60;89;62;61;59;58;86;75 21:14:34 INFO - PROCESS | 1664 | |4;audio-oscillator;90;70;91;70;68;70;90;66;68;92 21:14:34 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;89;86;92;87;88;86;89;88;89;86 21:14:34 INFO - PROCESS | 1664 | |6;imaging-darkroom;96;97;98;98;97;96;118;167;98;97 21:14:34 INFO - PROCESS | 1664 | |7;imaging-desaturate;85;84;81;82;83;83;85;87;83;91 21:14:34 INFO - PROCESS | 1664 | |8;json-parse-financial;57;57;55;54;55;55;56;54;56;75 21:14:34 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;66;72;78;77;76;71;71;71;72;72 21:14:34 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;87;86;90;87;89;91;89;76;89;92 21:14:34 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;155;156;160;175;156;147;146;146;195;147 21:14:34 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;171;172;173;173;172;172;172;172;172;173 21:14:34 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;67;67;68;67;67;67;68;67;66;67 21:14:34 INFO - PROCESS | 1664 | __end_tp_report 21:14:34 INFO - PROCESS | 1664 | __start_cc_report 21:14:34 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2009 21:14:34 INFO - PROCESS | 1664 | __end_cc_report 21:14:34 INFO - PROCESS | 1664 | __startTimestamp1477973674431__endTimestamp 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | ------- Summary: start ------- 21:14:34 INFO - PROCESS | 1664 | Number of tests: 14 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:14:34 INFO - PROCESS | 1664 | Values: 113.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:142.00 stddev:20.38 (14.3%) stddev-sans-first:21.14 21:14:34 INFO - PROCESS | 1664 | Values: 142.0 113.0 112.0 147.0 112.0 135.0 139.0 96.0 161.0 142.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:195.80 Median:184.50 stddev:24.98 (13.5%) stddev-sans-first:26.13 21:14:34 INFO - PROCESS | 1664 | Values: 184.0 182.0 184.0 187.0 185.0 184.0 183.0 247.0 239.0 183.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:68.90 Median:68.50 stddev:12.30 (18.0%) stddev-sans-first:12.37 21:14:34 INFO - PROCESS | 1664 | Values: 80.0 59.0 60.0 89.0 62.0 61.0 59.0 58.0 86.0 75.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:80.00 stddev:11.48 (14.4%) stddev-sans-first:11.25 21:14:34 INFO - PROCESS | 1664 | Values: 90.0 70.0 91.0 70.0 68.0 70.0 90.0 66.0 68.0 92.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.50 stddev:1.89 (2.1%) stddev-sans-first:1.96 21:14:34 INFO - PROCESS | 1664 | Values: 89.0 86.0 92.0 87.0 88.0 86.0 89.0 88.0 89.0 86.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:97.00 stddev:22.36 (23.1%) stddev-sans-first:23.41 21:14:34 INFO - PROCESS | 1664 | Values: 96.0 97.0 98.0 98.0 97.0 96.0 118.0 167.0 98.0 97.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:2.88 (3.4%) stddev-sans-first:3.04 21:14:34 INFO - PROCESS | 1664 | Values: 85.0 84.0 81.0 82.0 83.0 83.0 85.0 87.0 83.0 91.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:6.28 (11.2%) stddev-sans-first:6.65 21:14:34 INFO - PROCESS | 1664 | Values: 57.0 57.0 55.0 54.0 55.0 55.0 56.0 54.0 56.0 75.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:72.00 stddev:3.53 (4.9%) stddev-sans-first:2.83 21:14:34 INFO - PROCESS | 1664 | Values: 66.0 72.0 78.0 77.0 76.0 71.0 71.0 71.0 72.0 72.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:89.00 stddev:4.48 (5.0%) stddev-sans-first:4.74 21:14:34 INFO - PROCESS | 1664 | Values: 87.0 86.0 90.0 87.0 89.0 91.0 89.0 76.0 89.0 92.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:158.30 Median:156.00 stddev:15.66 (10.0%) stddev-sans-first:16.57 21:14:34 INFO - PROCESS | 1664 | Values: 155.0 156.0 160.0 175.0 156.0 147.0 146.0 146.0 195.0 147.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 21:14:34 INFO - PROCESS | 1664 | Values: 171.0 172.0 173.0 173.0 172.0 172.0 172.0 172.0 172.0 173.0 21:14:34 INFO - PROCESS | 1664 | 21:14:34 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 21:14:34 INFO - PROCESS | 1664 | Values: 67.0 67.0 68.0 67.0 67.0 67.0 68.0 67.0 66.0 67.0 21:14:34 INFO - PROCESS | 1664 | -------- Summary: end -------- 21:14:34 INFO - PROCESS | 1664 | 21:14:35 INFO - TEST-INFO | 1664: exit 0 21:14:35 INFO - TEST-OK | kraken | took 59458ms 21:14:35 INFO - SUITE-END | took 1178s 21:14:35 INFO - Completed test suite (00:19:39) 21:14:35 INFO - javascript benchmark 21:14:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2839.758620517256, 3199.936001279973, 3215.9196020099507, 3252.6909943555356, 3276.574045374101, 5409.215663728767, 5447.536959358455, 5468.589855760824, 5528.668279903209, 5539.556835453164, 5508.724563771805, 5523.171524271362, 5534.667919924807, 5537.0, 5545.195946587743, 5021.347224860772, 5055.368078990108, 5059.620528460362, 5095.0, 5130.846074617767, 5043.773030213631, 5058.721770302632, 5072.2391641253735, 5108.157154069592, 5131.589472842183, 4539.54604539545, 5096.4648711885275, 5105.744712764365, 5107.565856902168, 5147.202183661539, 4747.786349614275, 5107.182850743863, 5122.3853137623355, 5127.641065125443, 5170.6122040847085, 3983.4821473208585, 4117.91764164715, 4878.463369029404, 5023.673461225045, 5076.44159142494, 5345.064613692588, 5413.756380962866, 5423.755930983115, 5429.56563474921, 5454.181872719084, 5799.536037117021, 5904.822855314347, 5923.526117910556, 5925.911111333334, 5926.259217597801, 5800.651960882318, 5862.9446699594055, 5911.083782013795, 5962.0, 6033.913895498808, 5607.355154157242, 5613.270274864241, 5613.270274864323, 5621.887562248773, 5641.041023026137, 6165.599236049642, 6207.875842483216, 6215.875682486325, 6222.191115155091, 6224.37756224374, 5750.763585828983, 5786.594938354359, 5805.535557155417, 5826.0, 5834.3290521589715, 5879.323877754027, 5915.526757859361, 5929.673867937305, 5935.821925342247, 5971.790987315423, 5871.970640146772, 5890.145928840294, 5903.881922361528, 5922.911156332659, 5923.851903702442, 4900.681455705368, 5852.970735146297, 5912.497437717756, 5918.911216331759, 5921.0, 4779.211430114062, 4785.282207668877, 4791.0, 4791.377120974321, 4792.897633544304, 4172.749635021908, 4258.339957306623, 4365.476142862877, 4380.430544029319, 4386.385905973167, 5624.521915637217, 5634.7182640867795, 5640.379558248589, 5666.263385759825, 5679.460451257124, 6111.633302001894, 6116.449519543174, 6123.908141377883, 6140.938590614126, 6145.477634401126, 5506.256655351476, 5617.887642247214, 5635.520980716685, 5640.182173584807, 5653.971730141405, 5199.194124910645, 5203.583713303003, 5231.136862417735, 5257.76340064698, 5276.182191760283, 6244.812655620339, 6270.623762574169, 6273.247210334789, 6290.685465726787, 6303.2436107665535, 6031.155638210566, 6096.0, 6102.603330783485, 6112.663803490851, 6112.847178820565, 6097.2988106366565, 6121.204243448323, 6141.385861413823, 6154.569180157346, 6263.874722505433, 5847.298324201123, 5878.177055212188, 5917.940820591739, 5927.555433342603, 5975.671338076448, 6026.969865150646, 6030.75876964934, 6043.033114701627, 6044.879102417839, 6066.059760737093, 5682.744276507485, 5720.3707592164, 5828.0966450200285, 5845.473907348359, 5878.647281163144, 4458.665600079942, 5758.2514273144225, 5823.650580965155, 5844.503217226584, 5847.8245652630485, 5723.255976723, 5732.684702341411, 5739.0, 5739.598228123991, 5780.913286300624, 4887.340209071872, 5848.385919478564, 5879.970600146972, 5882.882342353215, 5885.61743486672, 4657.278121891112, 5544.279243698455, 5603.215549822947, 5639.7744090237575, 5654.067078932095], "value": 5465.243379312253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.4519557313517, 497.858110438525, 508.1869009584667, 514.7143335448825, 548.9980785067253, 30334.848325758394, 31071.2232194195, 39111.0, 40206.597934020654, 40280.0, 41391.0, 41564.792176039155, 41881.0, 41884.162316753645, 41895.79052104743, 9298.256139508823, 9478.526073696323, 9481.715548533555, 9482.525873706321, 9515.524223788818, 9304.81390372192, 9411.247100231965, 9420.963693993655, 9422.528873556295, 9449.81100377992, 9395.76510587234, 9453.574589143505, 9464.81070378592, 9467.337286389955, 9472.194863436616, 9363.906360936371, 9400.388974716621, 9415.058494150564, 9415.576299066559, 9421.246300296028, 9239.861402078974, 9315.021922698155, 9328.580213890391, 9336.57985390659, 9357.906420935771, 39741.0, 40124.796256112364, 40156.39765403492, 40163.0, 40187.19625607471, 3288.704016638514, 3309.7352211822995, 3340.1816554943953, 3364.0412482442384, 3386.847591858372, 30083.849580751958, 30351.089467316015, 30992.0, 31567.52648710271, 31633.20916977094, 2623.698274698415, 3139.6232452105664, 3185.155933677577, 3208.1017315151794, 3326.1518312830317, 472994.0, 479573.0, 479854.0109491802, 480786.0, 493583.0, 57371.713141434026, 57807.71096144492, 57891.42108578861, 57940.0, 58008.709956449944, 61061.69469152626, 61205.0, 61230.693846530485, 61236.693816530635, 61254.08118878131, 15708.92145539265, 15908.602284942737, 15913.602159945862, 15943.840561594236, 15956.840431595536, 12376.876231237753, 12457.875421245672, 12465.563705270271, 12484.81272780909, 12487.438065287084, 13145.868541314465, 15896.682066358608, 16277.67444651124, 16316.184190790413, 16405.58986025359, 6640.568363056386, 6645.806883728358, 6668.566543174678, 6721.563098398687, 6774.356436138658, 774.9189880117204, 782.4288269563251, 962.3648392061206, 971.2715463402449, 1035.2297571153413, 24424.75575244225, 29223.56164657532, 29422.970196043465, 29769.553456698166, 30964.380712385628, 977.0, 1014.1937159957852, 1084.3764835219781, 1101.3832253937821, 1113.5991043224433, 14737.778933316009, 15150.242487875563, 15272.31274592646, 15335.923320383326, 15848.60378490547, 603821.0, 604949.0, 607386.0, 607856.0, 607979.0, 55587.72206138943, 55863.0, 55885.720571397695, 55924.720376397854, 55955.44044559502, 1210.2435977514053, 1250.7123361626695, 1319.7426501832242, 1346.508524388591, 1373.3819781098546, 28194.718052819208, 29041.7095829039, 29101.0, 30436.84781576078, 30645.387092258476, 48330.03339933252, 48983.0, 49015.26477102918, 49108.0, 49109.01781964269, 421460.0, 421505.0, 422120.0, 422307.0, 422682.0, 37852.05369865776, 39085.2182956345, 39216.0, 39416.80291598524, 39459.802700986314, 45265.773671131436, 45622.31566526438, 46260.0, 46435.767821160676, 47162.76418617885, 36619.63380366269, 36736.448953266256, 37037.814810925775, 37783.62216377911, 37875.431868522544, 30358.69641303559, 36171.63828361683, 38541.80729096449, 39059.41410878896, 39101.60898391093, 36964.81517592395, 37564.436533452565, 37826.62173378231, 37981.050473738374, 38095.42856857094, 30186.094417167522, 33798.83100584481, 34087.0, 34187.14532136716, 34205.828970854986, 23988.88005559961, 24298.392540186636, 24441.755582443948, 24954.251372458857, 25481.49037019212], "value": 19374.09239397911, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.50942755732166, 349.33451774369837, 367.10609665464597, 367.6819551088308, 397.1025482409753, 14211.502597409106, 14791.038582492143, 15174.468893588726, 19283.517912052204, 20036.89797061161, 19615.509612259702, 19928.01439712056, 19955.30156444521, 20386.286479973205, 20482.38552843417, 5097.668651537657, 5513.4210907854595, 5785.797497087603, 5928.97035514824, 5930.525557955375, 5608.887822243552, 5760.510356619692, 5856.092305692625, 5907.320658124307, 5909.172715819789, 5847.766089356442, 5859.472647461727, 5864.2962844458725, 5866.6480011199255, 5885.293764748236, 5554.666719996793, 5741.799037033705, 5813.0, 5839.0949402842625, 5845.152452894349, 4942.975285123552, 5094.261332106861, 5100.209467532539, 5105.489451054902, 5106.719130447824, 21088.156473741186, 25006.249812505655, 25455.49089018228, 25639.359016024748, 25925.0, 2351.4356554426986, 2561.6285638582303, 2706.404590989979, 2814.8177765338605, 2885.8268503889835, 12579.685507862285, 14390.28048597566, 15229.695406091927, 15938.28277727505, 16013.0, 1548.442560678155, 1641.8029836419705, 1841.300305883769, 1887.631911777204, 1945.6984167454068, 90972.0, 97781.02218977861, 117252.41373793076, 118636.40681796623, 119389.40305298504, 7777.5722335270975, 9120.850013243959, 10280.766308042934, 10328.990439636771, 10938.671839844817, 14205.0, 14225.573232803032, 14233.00368974162, 14234.928825355806, 14236.0, 7720.498167619086, 7933.444658873939, 8273.0, 8292.543910084883, 8404.0, 6599.868002639921, 8129.634166462523, 8140.430169888051, 8307.044689860622, 8309.127541608164, 3662.6703596675893, 4406.20688276107, 4410.669199810027, 4464.397306363664, 4471.441069866267, 1835.3484512997693, 1869.9532511687316, 1880.1163453176985, 1882.4070417818343, 1885.0, 719.4208662027014, 736.576468530597, 768.7386288661882, 784.4391260248835, 793.9325157361574, 19471.0, 20806.79193208079, 20880.686789698168, 21222.893885530473, 21367.8931605341, 804.8148925746993, 807.0799288810761, 882.2280504558511, 928.2620316848122, 929.5816882402946, 8795.868061979076, 10939.28894621847, 11294.887051129548, 11318.377489238006, 11379.317240965569, 506089.0, 510242.0, 555691.0, 569428.0, 570150.0, 98327.50836245772, 133855.0, 140288.0, 144774.0, 148336.58317084104, 961.8893827209961, 980.9852852207223, 1012.9088382045651, 1015.0661391519819, 1016.6238491757949, 19222.61554768925, 19589.804101958798, 19597.60804783868, 19615.0, 19630.209088318694, 44645.77677111594, 52918.677033074484, 54917.0, 54946.72526637341, 56097.597560061324, 75639.0, 76879.0, 79292.0, 82820.58589707012, 84340.0, 6940.722371105099, 7415.629218539159, 7765.922340776746, 7837.098733645704, 7985.600719964094, 8475.533845638549, 11546.48040838181, 12717.55488557896, 12769.361531923552, 13180.868191318348, 10645.680629581126, 10705.250632455653, 10919.290246133976, 11347.659570212907, 11371.20401571882, 9809.215262779104, 10060.195184385379, 10756.623518176826, 10775.838362424727, 10933.671989840317, 11309.151813613847, 11507.252028618113, 11685.0, 11711.590094346657, 11762.059035276987, 6909.79270621862, 7113.0753002109395, 7294.781156565312, 7380.0, 7596.240375962359, 8885.600147993226, 9378.717448892832, 11155.665330040112, 11160.944195278971, 11237.550497980315], "value": 9289.933230303302, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.2048499203006, 1460.37204002279, 1569.427159086933, 1770.1326350088461, 1806.6025474395628, 7788.376929845613, 8208.302294304976, 8211.466254693449, 8211.507309561423, 8222.259996600305, 7297.306755858185, 7507.624618769067, 7509.849803003936, 7814.7264845730415, 7972.681092756283, 2223.566404551109, 2259.898304576298, 2263.321003698892, 2264.705588273522, 2265.4336415896028, 2250.6173950428465, 2288.336382449088, 2292.0946226240626, 2295.483516208848, 2302.7121609798774, 2246.3261021693506, 2256.7291924969027, 2270.3642979965634, 2281.851679640818, 2282.4065742906796, 2241.495663475713, 2262.558801033799, 2263.8868056597103, 2264.060414927803, 2266.195500597289, 2016.899155042242, 2133.9146434142617, 2254.177225312749, 2267.013848975701, 2281.832259353604, 8092.757217283432, 8095.473794203417, 8177.182281771775, 8205.753827385188, 8207.95896020522, 4903.289023091667, 5078.339815823956, 5090.720010399426, 5096.235564665293, 5097.954919241547, 3247.480403135487, 3443.9827800861085, 3445.2764919366714, 3510.3154884797473, 3521.8767343142868, 961.4759955824093, 1011.8735158105237, 1054.2830875004993, 1056.434807378049, 1060.5386656804314, 10614.946925265402, 10642.73393165177, 10647.935206479367, 10649.840252396298, 10658.0, 3624.2751449710163, 3738.719596030309, 4301.978490107592, 4449.7330160190495, 4472.306792447111, 8142.715004974797, 9128.0, 9196.678116266032, 9197.632094716137, 9211.0, 5071.746412679351, 5072.644914855999, 5073.923891141636, 5077.238414237894, 5079.6698214615935, 4465.397171381822, 4590.862274131781, 4594.632429405639, 4612.60792832613, 4693.413323334583, 3589.6948759355223, 3608.4226523756597, 3632.164602141522, 3671.7980511072146, 3716.7026637868908, 1086.9673909782719, 1158.808796548577, 1200.8919197272287, 1201.6395081475698, 1207.849018872641, 737.6836732659453, 786.5045021636332, 790.1308560583312, 886.8182022685463, 913.4336711238941, 5487.5609951203805, 5572.554195664337, 5636.379998200195, 5659.518940890071, 5913.940860591425, 770.3221165374434, 836.656970642046, 876.8903887014123, 899.680613382253, 979.1970584121095, 3534.7525673203145, 3718.8140592970785, 3766.246750649881, 3812.8856134316015, 3852.845886164578, 9348.20540254086, 9794.265430092772, 9834.213262938947, 9840.0, 9872.111509963994, 8347.373946954003, 9408.294377921684, 9806.705798826046, 9808.21534277256, 9843.163331116792, 7590.1650818409935, 7737.303642672074, 7739.690412383442, 7741.148473667892, 7791.948087008182, 4819.7108173509705, 5297.152455607084, 5336.519713225828, 5378.569714422759, 5636.957162924872, 9026.638934442548, 9095.636174552943, 9164.541772911462, 9295.25637948976, 9306.581203845979, 8758.649654013769, 8955.686550970684, 9053.592588333673, 9130.49782261982, 9292.02433744447, 6863.485238607024, 7056.259092795388, 7065.964670176616, 7070.469714771516, 7080.610566418896, 7058.964705176441, 7146.928530714834, 7586.203448637813, 7607.923920760722, 7695.115061767969, 6913.827154320981, 6959.582425054513, 6985.860282794417, 7018.75434359795, 7021.473389495911, 6749.156355455568, 6834.453243740588, 6835.521513494206, 6868.965655171892, 6900.482463815133, 6427.453666438405, 6522.902156467751, 6528.347165283623, 6532.477401807749, 6534.379233972765, 4645.372874661877, 4726.976365118152, 4786.210275304675, 4795.232762757942, 4862.878428039327, 4549.363089167586, 4712.622990160848, 4721.858344249678, 4777.665563410528, 4975.626827987843], "value": 4283.8933104352445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.3803941132452, 281.86752226453575, 296.33325018707905, 302.8107432854466, 303.0831734004636, 4976.527229913152, 5083.364579427572, 5120.641555091145, 5176.870578235541, 5364.310242273681, 4358.956410435895, 4673.45775893955, 5276.0, 5315.39545622645, 5319.787208511655, 3357.7145942594907, 3976.622220889011, 4017.7790221537803, 4025.81883815229, 4026.8187931543152, 3193.722510995597, 3789.905252368699, 3886.7084968627464, 4023.3361495353233, 4068.9186216275657, 3989.9800500997453, 4006.6394024537785, 4014.116894283268, 4015.678745700337, 4018.0065850940946, 3315.8342082896, 3975.2447035063533, 4023.476947996771, 4030.355143177107, 4031.971847178965, 3231.0, 3486.459598762196, 3498.492718555821, 3500.5799304083416, 3501.299740052, 4372.912541749179, 4435.467743870724, 4691.991221887277, 5147.613928955343, 5172.749853813565, 3803.5055442792536, 4205.453291072172, 4565.6943243661735, 4573.245414506602, 4582.266837306015, 5101.7194054327, 5567.610267281292, 5571.749271282762, 5589.742307980712, 5600.60795744294, 3118.4230917280147, 3740.7007439405056, 3783.332750410954, 3784.2620688965662, 3793.7723736575895, 4906.950930490721, 5087.6929995503215, 5820.82537523875, 5835.328937172237, 5876.706164691748, 3369.309291595217, 3808.2002779416634, 3823.5602905665646, 3838.481804956351, 3856.845726170922, 3350.1792060945227, 3748.2690875279604, 3766.982914613039, 3904.7657140571655, 3908.472356231929, 3673.1918977824835, 4178.331466965271, 4277.786110694453, 4407.338899165151, 4583.4041574595085, 4715.3869996900185, 4973.701577905337, 5409.538659909732, 5661.46216109469, 5695.373508914016, 1133.4616057372682, 1324.8873845723028, 1343.2544937559553, 1344.8184495093233, 1348.2719331561043, 825.0965193113531, 833.6123702478377, 856.7900864288289, 888.8977767556813, 901.7610333261691, 4599.241125214369, 5006.849794506171, 5227.869303267449, 5270.341207349082, 5301.257823904656, 4825.9034819303415, 5642.71786410686, 5691.971540142273, 5716.941900915667, 5729.0, 4942.802287908516, 5179.948200517946, 5201.271821944931, 5219.869503262373, 5394.437642119961, 2659.428222932079, 2723.550614148683, 2756.641636587271, 3018.969810301869, 3072.2319420144963, 5136.5377116059735, 5307.52232299095, 5624.73443475223, 5625.6905870176715, 5684.459976302244, 4949.455559888409, 5278.392984806796, 5341.878205576794, 5861.706914654335, 5973.313068997034, 4991.650584459053, 5932.292317301686, 5956.493698035629, 5960.731767070492, 5972.910406343908, 4906.828261010847, 5417.891642167056, 5448.727563621724, 5753.626014309057, 5822.94177058224, 5640.294963129609, 5667.716614169358, 5684.658920464785, 5692.6660069371355, 5703.714814259353, 4472.038511719996, 4827.565519103297, 5834.824955251349, 5968.850778730392, 6004.609700369462, 3096.427160975227, 3440.587129544471, 3445.328161008579, 3547.3082748863726, 3817.770933743984, 5478.342598888, 5628.887422251614, 5698.344690360662, 5743.6840973745175, 5765.682887441231, 4634.9536504634525, 5558.610897237155, 5573.885222955344, 5576.832695019156, 5584.525315348078, 4653.744044077608, 5405.567554595702, 5546.334439867242, 5617.354004289559, 5668.886622267614, 4871.415430148405, 5316.973415132899, 5456.108262620817, 5462.371827239918, 5552.9449404613, 4761.381020467317, 5095.464976177448, 5598.356189038313, 5647.519960803378, 5668.291463567054, 4267.338562522814, 4614.238650622744, 4865.854024379133, 5474.42518535564, 5484.890302194013], "value": 3996.1922644769006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.1575151941911, 745.962701864907, 753.7587971849009, 773.6634563964673, 792.8810678398241, 14869.702605947889, 15213.163276019815, 15230.162341071236, 15230.77153842692, 15558.52194041567, 13380.531681391129, 13515.93242033791, 13519.459221631123, 13529.458821647147, 13535.18788872666, 588.8851673923565, 634.3529599808193, 666.3103687683249, 666.3336663336663, 805.9032916050068, 797.3342259213564, 819.6844214977247, 820.1593366799019, 821.4126899267023, 826.6817275349003, 856.0583358305876, 876.4609764994515, 876.9035406105323, 877.6226222724226, 878.0780180810156, 871.2115535440437, 871.9738407847743, 872.2847265242503, 873.6898401067593, 874.0254616103063, 503.66757939759583, 520.9114450543417, 521.9947800521984, 644.6647743173523, 644.7646608987733, 12018.15872888898, 12125.818112728317, 13404.0, 13744.587662370144, 13801.102928309629, 13365.198088114745, 13645.658858528517, 13716.65708357289, 13730.038897277194, 13763.036587438883, 11117.388543630097, 11263.718407039807, 11361.829572556418, 11457.0, 11723.0, 3658.506101676266, 3663.8900832975055, 3703.2408356286896, 3736.8505259789576, 3828.3874580067054, 86540.13459865384, 86871.56564217138, 87843.0, 88121.0, 88972.55513722455, 10547.894521054692, 10654.520546575422, 10726.647040101821, 10887.455627218607, 10926.726831829108, 18454.446366609023, 21029.0, 21056.473588160112, 21078.629889057163, 21082.683759743617, 6347.238331400262, 7418.703251869865, 7448.888266676005, 7490.250974902466, 7725.922740772633, 4169.291220492463, 4219.409282700424, 4254.468191476066, 4269.935950960738, 4370.366296886934, 3378.0, 3421.674940880612, 3486.738494612914, 3487.773294735834, 3503.702185314226, 571.3657839797821, 573.1259828761173, 577.6014549960514, 589.7611467355728, 589.802416190581, 564.7261078376984, 576.6194311754306, 592.9555283353766, 638.4381744065192, 666.8066260784318, 8655.740327790176, 8971.192592666692, 9025.41334813235, 9122.883931329365, 9233.261339092856, 540.783686525393, 565.1861319699619, 582.758155365527, 589.4665327878276, 648.8215740671353, 4204.2850024912805, 4268.850590229389, 4427.180971520279, 4441.555844415597, 4446.755428451402, 71610.64194679097, 72895.27104728884, 113439.0, 114834.42582787032, 116878.0, 81270.18729812745, 84344.0, 106772.0, 107196.0, 109872.0, 67936.29668621528, 71932.0, 76594.23405765982, 78672.6066369676, 82475.0, 9360.391574547633, 9556.187724043533, 9596.472194029117, 9599.47202903847, 9613.134817866425, 48311.75844120757, 49533.009339812284, 51084.168687347854, 51842.48157518377, 52599.0, 67026.66486667536, 68948.0, 69276.61446771138, 70653.0, 70752.0, 11800.822987655363, 11992.580259690869, 12050.75898482043, 12160.148789584644, 12665.176763510342, 11736.530538778694, 13777.655558610713, 14273.64315892111, 14289.999700020899, 14522.346494407988, 12575.434105465092, 13210.0, 13345.332733363488, 13346.19922804635, 13371.130876492996, 12542.435590398272, 13053.02102342309, 13467.730645387233, 13490.52783152585, 13608.387622556811, 10686.198535109743, 10791.352518848895, 11064.723381915517, 11168.832467512831, 11191.832122518332, 10388.117010053928, 10726.195535334726, 10801.67594972152, 10881.891181088404, 11095.5561777528, 9278.211352034883, 10412.271141020055, 10611.469426528796, 11042.233242681132, 11163.888361116286], "value": 7085.536300788021, "unit": "score"}], "name": "dromaeo_css", "value": 7016.571703290425, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 112.0, 147.0, 112.0, 135.0, 139.0, 96.0, 161.0, 142.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 187.0, 185.0, 184.0, 183.0, 247.0, 239.0, 183.0], "value": 195.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 89.0, 62.0, 61.0, 59.0, 58.0, 86.0, 75.0], "value": 68.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 91.0, 70.0, 68.0, 70.0, 90.0, 66.0, 68.0, 92.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 92.0, 87.0, 88.0, 86.0, 89.0, 88.0, 89.0, 86.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 98.0, 98.0, 97.0, 96.0, 118.0, 167.0, 98.0, 97.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 81.0, 82.0, 83.0, 83.0, 85.0, 87.0, 83.0, 91.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 54.0, 55.0, 55.0, 56.0, 54.0, 56.0, 75.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 78.0, 77.0, 76.0, 71.0, 71.0, 71.0, 72.0, 72.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 90.0, 87.0, 89.0, 91.0, 89.0, 76.0, 89.0, 92.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 160.0, 175.0, 156.0, 147.0, 146.0, 146.0, 195.0, 147.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 173.0, 173.0, 172.0, 172.0, 172.0, 172.0, 172.0, 173.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1479.0, "alertThreshold": 2.0}]} 21:14:35 INFO - Return code: 0 21:14:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:14:35 INFO - # TBPL SUCCESS # 21:14:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:14:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:14:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:14:35 INFO - 2016-10-31 21:14:35.772 screenresolution[1668:9748] starting screenresolution argv=screenresolution get 21:14:35 INFO - 2016-10-31 21:14:35.775 screenresolution[1668:9748] Display 0: 1600x1200x32@60 21:14:35 INFO - 2016-10-31 21:14:35.781 screenresolution[1669:9752] starting screenresolution argv=screenresolution list 21:14:35 INFO - Available Modes on Display 0 21:14:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:14:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:14:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:14:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:14:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:14:36 INFO - Intel Iris: 21:14:36 INFO - Chipset Model: Intel Iris 21:14:36 INFO - Type: GPU 21:14:36 INFO - Bus: Built-In 21:14:36 INFO - VRAM (Dynamic, Max): 1536 MB 21:14:36 INFO - Vendor: Intel (0x8086) 21:14:36 INFO - Device ID: 0x0a2e 21:14:36 INFO - Revision ID: 0x0009 21:14:36 INFO - Displays: 21:14:36 INFO - Display: 21:14:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:14:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:14:36 INFO - Display Serial Number: 1600x1200 60 21:14:36 INFO - Main Display: Yes 21:14:36 INFO - Mirror: Off 21:14:36 INFO - Online: Yes 21:14:36 INFO - Rotation: Supported 21:14:36 INFO - Return code: 0 21:14:36 INFO - Running post-action listener: _resource_record_post_action 21:14:36 INFO - [mozharness: 2016-11-01 04:14:36.016301Z] Finished run-tests step (success) 21:14:36 INFO - Running post-run listener: _resource_record_post_run 21:14:36 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 44897792; Write bytes: 711123968; Read time: 431; Write time: 2058 21:14:36 INFO - TinderboxPrint: CPU usage
53.5% 21:14:36 INFO - TinderboxPrint: I/O read bytes / time
44,897,792 / 431 21:14:36 INFO - TinderboxPrint: I/O write bytes / time
711,123,968 / 2,058 21:14:36 INFO - TinderboxPrint: CPU idle
2,258.6 (46.5%) 21:14:36 INFO - TinderboxPrint: CPU system
977.0 (20.1%) 21:14:36 INFO - TinderboxPrint: CPU user
1,622.1 (33.4%) 21:14:36 INFO - TinderboxPrint: Swap in / out
459,304,960 / 0 21:14:36 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392724992; Write bytes: 383647232; Read time: 29168; Write time: 754 21:14:36 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 38698496; Write bytes: 299460096; Read time: 349; Write time: 1247 21:14:36 INFO - Running post-run listener: _upload_blobber_files 21:14:36 INFO - Blob upload gear active. 21:14:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:14:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:14:36 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'] 21:14:36 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 21:14:36 INFO - (blobuploader) - INFO - Open directory for files ... 21:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:14:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:14:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:14:38 INFO - (blobuploader) - INFO - Done attempting. 21:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:14:39 INFO - (blobuploader) - INFO - Done attempting. 21:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:14:41 INFO - (blobuploader) - INFO - Done attempting. 21:14:41 INFO - (blobuploader) - INFO - Iteration through files over. 21:14:41 INFO - Return code: 0 21:14:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:14:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:14:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d4c032d63a253c78c42891578e41d0331f194b7d52a9d6cc32be4129df7bee163aba6a3b7e9a224991f89b2cd01b0a4a0e585c91fde58999ff04e640839f82a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cba957b32a90e607092c6706416f4fa7ec52dc9e42d07eb9b7ba05338ee87a2ee22ec0c3b959efae007980fa5a57e7234c0389fb96d8fb8cdf466298a2ad51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97661256075a84aaa05e9a7287a592abfa2e7e4c2bf9565f8b303a239bca37f444749dd217925f623060494d6f0fb4f86c6afc01a129103799b707ddf9f11f3f"} 21:14:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:14:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:14:41 INFO - Contents: 21:14:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d4c032d63a253c78c42891578e41d0331f194b7d52a9d6cc32be4129df7bee163aba6a3b7e9a224991f89b2cd01b0a4a0e585c91fde58999ff04e640839f82a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cba957b32a90e607092c6706416f4fa7ec52dc9e42d07eb9b7ba05338ee87a2ee22ec0c3b959efae007980fa5a57e7234c0389fb96d8fb8cdf466298a2ad51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97661256075a84aaa05e9a7287a592abfa2e7e4c2bf9565f8b303a239bca37f444749dd217925f623060494d6f0fb4f86c6afc01a129103799b707ddf9f11f3f"} 21:14:41 INFO - Running post-run listener: copy_logs_to_upload_dir 21:14:41 INFO - Copying logs to upload dir... 21:14:41 INFO - mkdir: /builds/slave/test/build/upload/logs 21:14:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.568378 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-10-31 21:14:41.784400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:41.789095) ========= 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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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/1d4c032d63a253c78c42891578e41d0331f194b7d52a9d6cc32be4129df7bee163aba6a3b7e9a224991f89b2cd01b0a4a0e585c91fde58999ff04e640839f82a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cba957b32a90e607092c6706416f4fa7ec52dc9e42d07eb9b7ba05338ee87a2ee22ec0c3b959efae007980fa5a57e7234c0389fb96d8fb8cdf466298a2ad51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97661256075a84aaa05e9a7287a592abfa2e7e4c2bf9565f8b303a239bca37f444749dd217925f623060494d6f0fb4f86c6afc01a129103799b707ddf9f11f3f"} build_url:https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011051 build_url: 'https://queue.taskcluster.net/v1/task/UqOK6BALRsSW6PEqBmLQlg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d4c032d63a253c78c42891578e41d0331f194b7d52a9d6cc32be4129df7bee163aba6a3b7e9a224991f89b2cd01b0a4a0e585c91fde58999ff04e640839f82a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06cba957b32a90e607092c6706416f4fa7ec52dc9e42d07eb9b7ba05338ee87a2ee22ec0c3b959efae007980fa5a57e7234c0389fb96d8fb8cdf466298a2ad51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97661256075a84aaa05e9a7287a592abfa2e7e4c2bf9565f8b303a239bca37f444749dd217925f623060494d6f0fb4f86c6afc01a129103799b707ddf9f11f3f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:41.824940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:41.825230) ========= 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.Sv2Fx0otiR/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.GWMfytdD6b/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:14:41.873037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:14:41.873317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:14:41.873612) ========= ========= Total master_lag: 0.19 =========