builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0389 starttime: 1479217093.57 results: success (0) buildid: 20161115030213 builduid: 87bd85f2902d49c9bc9ff18c96ca46ff revision: 5e76768327660437bf3486554ad318e4b70276e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.567944) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.568394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.568670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.590811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.591190) ========= 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.vJtMKzMxFH/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.Iock0vozty/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-15 05:38:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 71.7M=0s 2016-11-15 05:38:13 (71.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084716 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.698366) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.698681) ========= 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.vJtMKzMxFH/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.Iock0vozty/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.024514 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:13.747770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 05:38:13.748146) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e76768327660437bf3486554ad318e4b70276e1 --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 5e76768327660437bf3486554ad318e4b70276e1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vJtMKzMxFH/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.Iock0vozty/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-15 05:38:13,846 truncating revision to first 12 chars 2016-11-15 05:38:13,846 Setting DEBUG logging. 2016-11-15 05:38:13,846 attempt 1/10 2016-11-15 05:38:13,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e7676832766?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 05:38:15,523 unpacking tar archive at: mozilla-central-5e7676832766/testing/mozharness/ program finished with exit code 0 elapsedTime=1.943198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 05:38:15.713509) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:15.713846) ========= script_repo_revision: 5e76768327660437bf3486554ad318e4b70276e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:15.714227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:15.714501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 05:38:15.733263) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-15 05:38:15.733888) ========= /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.vJtMKzMxFH/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.Iock0vozty/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:38:15 INFO - MultiFileLogger online at 20161115 05:38:15 in /builds/slave/test 05:38:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:38:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:15 INFO - {'append_to_log': False, 05:38:15 INFO - 'base_work_dir': '/builds/slave/test', 05:38:15 INFO - 'blob_upload_branch': 'Firefox', 05:38:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:15 INFO - 'branch': 'Firefox', 05:38:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:15 INFO - 'config_files': ('talos/mac_config.py',), 05:38:15 INFO - 'default_actions': ('clobber', 05:38:15 INFO - 'read-buildbot-config', 05:38:15 INFO - 'download-and-extract', 05:38:15 INFO - 'populate-webroot', 05:38:15 INFO - 'create-virtualenv', 05:38:15 INFO - 'install', 05:38:15 INFO - 'run-tests'), 05:38:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:15 INFO - 'download_minidump_stackwalk': True, 05:38:15 INFO - 'download_symbols': 'ondemand', 05:38:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:15 INFO - 'installer_path': 'installer.exe', 05:38:15 INFO - 'log_level': 'info', 05:38:15 INFO - 'log_name': 'talos', 05:38:15 INFO - 'log_to_console': True, 05:38:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:38:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:38:15 INFO - 'opt_config_files': (), 05:38:15 INFO - 'pip_index': False, 05:38:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:15 INFO - 'cmd': ('bash', 05:38:15 INFO - '-c', 05:38:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:15 INFO - 'enabled': True, 05:38:15 INFO - 'halt_on_failure': False, 05:38:15 INFO - 'name': 'check_screen_resolution'},), 05:38:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:15 INFO - 'cmd': ('bash', 05:38:15 INFO - '-c', 05:38:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:15 INFO - 'enabled': True, 05:38:15 INFO - 'halt_on_failure': False, 05:38:15 INFO - 'name': 'check_screen_resolution'},), 05:38:15 INFO - 'run_cmd_checks_enabled': True, 05:38:15 INFO - 'sps_profile': False, 05:38:15 INFO - 'sps_profile_interval': 0, 05:38:15 INFO - 'suite': 'dromaeojs', 05:38:15 INFO - 'system_bits': '32', 05:38:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:15 INFO - 'title': 't-yosemite-r7-0389', 05:38:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:15 INFO - 'use_talos_json': True, 05:38:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:15 INFO - 'work_dir': 'build'} 05:38:15 INFO - [mozharness: 2016-11-15 13:38:15.938343Z] Running clobber step. 05:38:15 INFO - Running pre-action listener: _resource_record_pre_action 05:38:15 INFO - Running main action method: clobber 05:38:15 INFO - rmtree: /builds/slave/test/build 05:38:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:18 INFO - Running post-action listener: _resource_record_post_action 05:38:18 INFO - [mozharness: 2016-11-15 13:38:18.356122Z] Finished clobber step (success) 05:38:18 INFO - [mozharness: 2016-11-15 13:38:18.356249Z] Running read-buildbot-config step. 05:38:18 INFO - Running pre-action listener: _resource_record_pre_action 05:38:18 INFO - Running main action method: read_buildbot_config 05:38:18 INFO - Using buildbot properties: 05:38:18 INFO - { 05:38:18 INFO - "project": "", 05:38:18 INFO - "product": "firefox", 05:38:18 INFO - "script_repo_revision": "production", 05:38:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:38:18 INFO - "repository": "", 05:38:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:38:18 INFO - "buildid": "20161115030213", 05:38:18 INFO - "stage_platform": "macosx64", 05:38:18 INFO - "basedir": "/builds/slave/test", 05:38:18 INFO - "nightly_build": "True", 05:38:18 INFO - "buildnumber": 14, 05:38:18 INFO - "slavename": "t-yosemite-r7-0389", 05:38:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:38:18 INFO - "platform": "yosemite_r7", 05:38:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:38:18 INFO - "branch": "mozilla-central", 05:38:18 INFO - "repo_path": "mozilla-central", 05:38:18 INFO - "revision": "5e76768327660437bf3486554ad318e4b70276e1", 05:38:18 INFO - "pgo_build": "False", 05:38:18 INFO - "builduid": "87bd85f2902d49c9bc9ff18c96ca46ff", 05:38:18 INFO - "slavebuilddir": "test" 05:38:18 INFO - } 05:38:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:38:18 INFO - Running post-action listener: _resource_record_post_action 05:38:18 INFO - [mozharness: 2016-11-15 13:38:18.359496Z] Finished read-buildbot-config step (success) 05:38:18 INFO - [mozharness: 2016-11-15 13:38:18.359630Z] Running download-and-extract step. 05:38:18 INFO - Running pre-action listener: _resource_record_pre_action 05:38:18 INFO - Running main action method: download_and_extract 05:38:18 INFO - mkdir: /builds/slave/test/build/tests 05:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:18 INFO - trying https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:38:18 INFO - Downloading https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:38:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 05:38:19 INFO - Downloaded 1199 bytes. 05:38:19 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:38:19 INFO - Using the following test package requirements: 05:38:19 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:38:19 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:38:19 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:38:19 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'jsshell-mac.zip'], 05:38:19 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:38:19 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:38:19 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:38:19 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:38:19 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:38:19 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:38:19 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:38:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:38:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:38:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:38:19 INFO - Fetch https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:38:20 INFO - Http code: 200 05:38:20 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 05:38:20 INFO - x-amz-cf-id: 8z49TeJMQ1U8wSgN-REEgTuR3teeaLdqzN5OLQ7TeAoE0f5ZKvSQLA== 05:38:20 INFO - x-amz-version-id: 2_YIYuEGLHMCacrG2eSn5dxSiOqi3kdq 05:38:20 INFO - Expected file size: 16328817 05:38:20 INFO - Obtained file size: 16328817 05:38:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:38:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:38:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:38:27 INFO - Fetch https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:38:27 INFO - Http code: 200 05:38:27 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 05:38:27 INFO - x-amz-cf-id: shKC6Ku1fYAEIPNbdPE2cP92MB8W2ngM8nQv_9mUBzs0_ARvCSbgfw== 05:38:27 INFO - x-amz-version-id: 2_YIYuEGLHMCacrG2eSn5dxSiOqi3kdq 05:38:28 INFO - Expected file size: 16328817 05:38:28 INFO - Obtained file size: 16328817 05:38:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:38:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:38:34 INFO - Fetch https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:38:35 INFO - Http code: 200 05:38:35 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 05:38:35 INFO - x-amz-cf-id: Ezsu_c36EQZWytLfKRwL7m11VANA6rCvoKEMyfNLr900ZaJRIlDmsg== 05:38:35 INFO - x-amz-version-id: m1QRVeFwC3g9AUKO_gd0_k.QQ43V02Yb 05:38:35 INFO - Expected file size: 14409038 05:38:35 INFO - Obtained file size: 14409038 05:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:36 INFO - trying https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:38:36 INFO - Downloading https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:38:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 05:38:38 INFO - Downloaded 111089126 bytes. 05:38:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:38:38 INFO - mkdir: /builds/slave/test/properties 05:38:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:38:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:38:38 INFO - Contents: 05:38:38 INFO - build_url:https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:38:39 INFO - Running post-action listener: _resource_record_post_action 05:38:39 INFO - Running post-action listener: set_extra_try_arguments 05:38:39 INFO - [mozharness: 2016-11-15 13:38:39.709724Z] Finished download-and-extract step (success) 05:38:39 INFO - [mozharness: 2016-11-15 13:38:39.709845Z] Running populate-webroot step. 05:38:39 INFO - Running pre-action listener: _resource_record_pre_action 05:38:39 INFO - Running main action method: populate_webroot 05:38:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:38:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:38:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:38:39 INFO - '--tppagecycles', 05:38:39 INFO - '7'], 05:38:39 INFO - 'tests': ['tsvgm']}}, 05:38:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:38:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:38:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:38:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:38:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['damp', 'tps']}, 05:38:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'tests': ['damp', 'tps']}, 05:38:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['dromaeo_dom']}, 05:38:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:38:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['basic_compositor_video']}, 05:38:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:38:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['a11yr', 05:38:39 INFO - 'ts_paint', 05:38:39 INFO - 'tpaint', 05:38:39 INFO - 'sessionrestore', 05:38:39 INFO - 'sessionrestore_no_auto_restore', 05:38:39 INFO - 'tabpaint']}, 05:38:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:38:39 INFO - 'ts_paint', 05:38:39 INFO - 'tpaint', 05:38:39 INFO - 'sessionrestore', 05:38:39 INFO - 'sessionrestore_no_auto_restore', 05:38:39 INFO - 'tabpaint']}, 05:38:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:38:39 INFO - 'ts_paint', 05:38:39 INFO - 'tpaint', 05:38:39 INFO - 'sessionrestore', 05:38:39 INFO - 'sessionrestore_no_auto_restore', 05:38:39 INFO - 'tabpaint']}, 05:38:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:38:39 INFO - 'ts_paint', 05:38:39 INFO - 'tpaint', 05:38:39 INFO - 'sessionrestore', 05:38:39 INFO - 'sessionrestore_no_auto_restore', 05:38:39 INFO - 'tabpaint']}, 05:38:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['a11yr', 05:38:39 INFO - 'ts_paint', 05:38:39 INFO - 'tpaint', 05:38:39 INFO - 'sessionrestore', 05:38:39 INFO - 'sessionrestore_no_auto_restore', 05:38:39 INFO - 'tabpaint']}, 05:38:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['a11yr', 05:38:39 INFO - 'ts_paint', 05:38:39 INFO - 'tpaint', 05:38:39 INFO - 'sessionrestore', 05:38:39 INFO - 'sessionrestore_no_auto_restore', 05:38:39 INFO - 'tabpaint']}, 05:38:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['tsvgx', 05:38:39 INFO - 'tsvgr_opacity', 05:38:39 INFO - 'tart', 05:38:39 INFO - 'tscrollx', 05:38:39 INFO - 'cart']}, 05:38:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:38:39 INFO - 'tsvgr_opacity', 05:38:39 INFO - 'tart', 05:38:39 INFO - 'tscrollx', 05:38:39 INFO - 'cart']}, 05:38:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'talos_options': ['--disable-e10s'], 05:38:39 INFO - 'tests': ['tp5o']}, 05:38:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'tests': ['tp5o']}, 05:38:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'talos_options': ['--disable-e10s', 05:38:39 INFO - '--xperf_path', 05:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:39 INFO - 'tests': ['tp5n']}, 05:38:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:39 INFO - 'talos_options': ['--xperf_path', 05:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:39 INFO - 'tests': ['tp5n']}}, 05:38:39 INFO - 'talos.zip': {'path': '', 05:38:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:38:39 INFO - Running post-action listener: _resource_record_post_action 05:38:39 INFO - [mozharness: 2016-11-15 13:38:39.728467Z] Finished populate-webroot step (success) 05:38:39 INFO - [mozharness: 2016-11-15 13:38:39.728599Z] Running create-virtualenv step. 05:38:39 INFO - Running pre-action listener: _resource_record_pre_action 05:38:39 INFO - Running main action method: create_virtualenv 05:38:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:38:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:38:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:38:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:38:39 INFO - Using real prefix '/tools/python27' 05:38:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:38:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:38:43 INFO - Installing pip.................done. 05:38:43 INFO - Return code: 0 05:38:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:38:43 INFO - Reading from file tmpfile_stdout 05:38:43 INFO - Output received: 05:38:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:38:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:43 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:43 INFO - 'HOME': '/Users/cltbld', 05:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:43 INFO - 'LOGNAME': 'cltbld', 05:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:43 INFO - 'MOZ_NO_REMOTE': '1', 05:38:43 INFO - 'NO_EM_RESTART': '1', 05:38:43 INFO - 'PAGER': '/bin/cat', 05:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:43 INFO - 'PWD': '/builds/slave/test', 05:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:43 INFO - 'SHELL': '/bin/bash', 05:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:38:43 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:43 INFO - 'USER': 'cltbld', 05:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:43 INFO - 'XPC_FLAGS': '0x0', 05:38:43 INFO - 'XPC_SERVICE_NAME': '0', 05:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:38:43 INFO - Cleaning up... 05:38:43 INFO - Return code: 0 05:38:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:43 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:43 INFO - 'HOME': '/Users/cltbld', 05:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:43 INFO - 'LOGNAME': 'cltbld', 05:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:43 INFO - 'MOZ_NO_REMOTE': '1', 05:38:43 INFO - 'NO_EM_RESTART': '1', 05:38:43 INFO - 'PAGER': '/bin/cat', 05:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:43 INFO - 'PWD': '/builds/slave/test', 05:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:43 INFO - 'SHELL': '/bin/bash', 05:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:38:43 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:43 INFO - 'USER': 'cltbld', 05:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:43 INFO - 'XPC_FLAGS': '0x0', 05:38:43 INFO - 'XPC_SERVICE_NAME': '0', 05:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:44 INFO - Downloading/unpacking psutil>=3.1.1 05:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:38:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:47 INFO - Installing collected packages: psutil 05:38:47 INFO - Running setup.py install for psutil 05:38:47 INFO - building 'psutil._psutil_osx' extension 05:38:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:38:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:38:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:38:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:38:48 INFO - building 'psutil._psutil_posix' extension 05:38:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:38:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:38:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:38:48 INFO - ^ 05:38:48 INFO - 1 warning generated. 05:38:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:38:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:48 INFO - Successfully installed psutil 05:38:48 INFO - Cleaning up... 05:38:48 INFO - Return code: 0 05:38:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:48 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:48 INFO - 'HOME': '/Users/cltbld', 05:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:48 INFO - 'LOGNAME': 'cltbld', 05:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:48 INFO - 'MOZ_NO_REMOTE': '1', 05:38:48 INFO - 'NO_EM_RESTART': '1', 05:38:48 INFO - 'PAGER': '/bin/cat', 05:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:48 INFO - 'PWD': '/builds/slave/test', 05:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:48 INFO - 'SHELL': '/bin/bash', 05:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:38:48 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:48 INFO - 'USER': 'cltbld', 05:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:48 INFO - 'XPC_FLAGS': '0x0', 05:38:48 INFO - 'XPC_SERVICE_NAME': '0', 05:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:38:51 INFO - Installing collected packages: mozsystemmonitor 05:38:51 INFO - Running setup.py install for mozsystemmonitor 05:38:51 INFO - Successfully installed mozsystemmonitor 05:38:51 INFO - Cleaning up... 05:38:51 INFO - Return code: 0 05:38:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', '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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:38: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 jsonschema==2.5.1 05:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:51 INFO - 'HOME': '/Users/cltbld', 05:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:51 INFO - 'LOGNAME': 'cltbld', 05:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:51 INFO - 'MOZ_NO_REMOTE': '1', 05:38:51 INFO - 'NO_EM_RESTART': '1', 05:38:51 INFO - 'PAGER': '/bin/cat', 05:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:51 INFO - 'PWD': '/builds/slave/test', 05:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:51 INFO - 'SHELL': '/bin/bash', 05:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:38:51 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:51 INFO - 'USER': 'cltbld', 05:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:51 INFO - 'XPC_FLAGS': '0x0', 05:38:51 INFO - 'XPC_SERVICE_NAME': '0', 05:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:52 INFO - Downloading/unpacking jsonschema==2.5.1 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:55 INFO - warning: no files found matching '*.txt' 05:38:55 INFO - no previously-included directories found matching 'build' 05:38:55 INFO - no previously-included directories found matching 'dist' 05:38:55 INFO - no previously-included directories found matching '.git*' 05:38:55 INFO - Installing collected packages: jsonschema, functools32 05:38:55 INFO - Running setup.py install for functools32 05:38:55 INFO - warning: no files found matching '*.txt' 05:38:55 INFO - no previously-included directories found matching 'build' 05:38:55 INFO - no previously-included directories found matching 'dist' 05:38:55 INFO - no previously-included directories found matching '.git*' 05:38:55 INFO - Successfully installed jsonschema functools32 05:38:55 INFO - Cleaning up... 05:38:55 INFO - Return code: 0 05:38:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:55 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:55 INFO - 'HOME': '/Users/cltbld', 05:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:55 INFO - 'LOGNAME': 'cltbld', 05:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:55 INFO - 'MOZ_NO_REMOTE': '1', 05:38:55 INFO - 'NO_EM_RESTART': '1', 05:38:55 INFO - 'PAGER': '/bin/cat', 05:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:55 INFO - 'PWD': '/builds/slave/test', 05:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:55 INFO - 'SHELL': '/bin/bash', 05:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:38:55 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:55 INFO - 'USER': 'cltbld', 05:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:55 INFO - 'XPC_FLAGS': '0x0', 05:38:55 INFO - 'XPC_SERVICE_NAME': '0', 05:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:38:55 INFO - Cleaning up... 05:38:55 INFO - Return code: 0 05:38:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:55 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:55 INFO - 'HOME': '/Users/cltbld', 05:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:55 INFO - 'LOGNAME': 'cltbld', 05:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:55 INFO - 'MOZ_NO_REMOTE': '1', 05:38:55 INFO - 'NO_EM_RESTART': '1', 05:38:55 INFO - 'PAGER': '/bin/cat', 05:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:55 INFO - 'PWD': '/builds/slave/test', 05:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:55 INFO - 'SHELL': '/bin/bash', 05:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:38:55 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:55 INFO - 'USER': 'cltbld', 05:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:55 INFO - 'XPC_FLAGS': '0x0', 05:38:55 INFO - 'XPC_SERVICE_NAME': '0', 05:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:59 INFO - Downloading docopt-0.6.1.tar.gz 05:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:59 INFO - Running setup.py install for blobuploader 05:38:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:59 INFO - Running setup.py install for requests 05:39:00 INFO - Running setup.py install for docopt 05:39:00 INFO - Successfully installed blobuploader requests docopt 05:39:00 INFO - Cleaning up... 05:39:00 INFO - Return code: 0 05:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:00 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:00 INFO - 'HOME': '/Users/cltbld', 05:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:00 INFO - 'LOGNAME': 'cltbld', 05:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:00 INFO - 'MOZ_NO_REMOTE': '1', 05:39:00 INFO - 'NO_EM_RESTART': '1', 05:39:00 INFO - 'PAGER': '/bin/cat', 05:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:00 INFO - 'PWD': '/builds/slave/test', 05:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:00 INFO - 'SHELL': '/bin/bash', 05:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:39:00 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:00 INFO - 'USER': 'cltbld', 05:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:00 INFO - 'XPC_FLAGS': '0x0', 05:39:00 INFO - 'XPC_SERVICE_NAME': '0', 05:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:00 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-WI_ELg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:00 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-1cEHJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-UGsmIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-zv4pQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-HKpNdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ZT4rGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-YOSlF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-QtlCE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-HBNzb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-8pKTYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Q6tN6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:01 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-YGT3TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-lZtm2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-NVZSHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Mggu6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-W1l5xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:02 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-09brYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:02 INFO - Running setup.py install for manifestparser 05:39:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:02 INFO - Running setup.py install for mozcrash 05:39:02 INFO - Running setup.py install for mozdebug 05:39:03 INFO - Running setup.py install for mozdevice 05:39:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Running setup.py install for mozfile 05:39:03 INFO - Running setup.py install for mozhttpd 05:39:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Running setup.py install for mozinfo 05:39:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Running setup.py install for mozInstall 05:39:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Running setup.py install for mozleak 05:39:03 INFO - Running setup.py install for mozlog 05:39:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for moznetwork 05:39:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozprocess 05:39:04 INFO - Running setup.py install for mozprofile 05:39:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozrunner 05:39:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozscreenshot 05:39:04 INFO - Running setup.py install for moztest 05:39:05 INFO - Running setup.py install for mozversion 05:39:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:05 INFO - Cleaning up... 05:39:05 INFO - Return code: 0 05:39:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:05 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:39:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:05 INFO - 'HOME': '/Users/cltbld', 05:39:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:05 INFO - 'LOGNAME': 'cltbld', 05:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:05 INFO - 'MOZ_NO_REMOTE': '1', 05:39:05 INFO - 'NO_EM_RESTART': '1', 05:39:05 INFO - 'PAGER': '/bin/cat', 05:39:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:05 INFO - 'PWD': '/builds/slave/test', 05:39:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:05 INFO - 'SHELL': '/bin/bash', 05:39:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:39:05 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:39:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:05 INFO - 'USER': 'cltbld', 05:39:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:05 INFO - 'XPC_FLAGS': '0x0', 05:39:05 INFO - 'XPC_SERVICE_NAME': '0', 05:39:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:05 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ijJOVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:05 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-lt29C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:05 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-0TKGfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:05 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-HGbDQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:05 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)) 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:05 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-7gv1HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-8IJWjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-4EKCVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Wnl7Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-xskhPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-DvKSxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-pAEbNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-v0vBZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-EBPHYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-1tyrVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:06 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Yas9VV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:07 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-j5FrYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:07 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-mUsi_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:39:07 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)) 05:39:07 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)) 05:39:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:09 INFO - Downloading blessings-1.6.tar.gz 05:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:09 INFO - Installing collected packages: blessings 05:39:09 INFO - Running setup.py install for blessings 05:39:10 INFO - Successfully installed blessings 05:39:10 INFO - Cleaning up... 05:39:10 INFO - Return code: 0 05:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:10 INFO - Reading from file tmpfile_stdout 05:39:10 INFO - Current package versions: 05:39:10 INFO - blessings == 1.6 05:39:10 INFO - blobuploader == 1.2.4 05:39:10 INFO - docopt == 0.6.1 05:39:10 INFO - functools32 == 3.2.3-2 05:39:10 INFO - jsonschema == 2.5.1 05:39:10 INFO - manifestparser == 1.1 05:39:10 INFO - mozInstall == 1.12 05:39:10 INFO - mozcrash == 1.0 05:39:10 INFO - mozdebug == 0.1 05:39:10 INFO - mozdevice == 0.48 05:39:10 INFO - mozfile == 1.2 05:39:10 INFO - mozhttpd == 0.7 05:39:10 INFO - mozinfo == 0.9 05:39:10 INFO - mozleak == 0.1 05:39:10 INFO - mozlog == 3.4 05:39:10 INFO - moznetwork == 0.27 05:39:10 INFO - mozprocess == 0.23 05:39:10 INFO - mozprofile == 0.28 05:39:10 INFO - mozrunner == 6.13 05:39:10 INFO - mozscreenshot == 0.1 05:39:10 INFO - mozsystemmonitor == 0.3 05:39:10 INFO - moztest == 0.7 05:39:10 INFO - mozversion == 1.4 05:39:10 INFO - psutil == 3.1.1 05:39:10 INFO - requests == 1.2.3 05:39:10 INFO - wsgiref == 0.1.2 05:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:11 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:11 INFO - 'HOME': '/Users/cltbld', 05:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:11 INFO - 'LOGNAME': 'cltbld', 05:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:11 INFO - 'MOZ_NO_REMOTE': '1', 05:39:11 INFO - 'NO_EM_RESTART': '1', 05:39:11 INFO - 'PAGER': '/bin/cat', 05:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:11 INFO - 'PWD': '/builds/slave/test', 05:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:11 INFO - 'SHELL': '/bin/bash', 05:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:39:11 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:11 INFO - 'USER': 'cltbld', 05:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:11 INFO - 'XPC_FLAGS': '0x0', 05:39:11 INFO - 'XPC_SERVICE_NAME': '0', 05:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:39:11 INFO - Cleaning up... 05:39:11 INFO - Return code: 0 05:39:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:11 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 0x110535490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104ab570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcab948ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, '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.vJtMKzMxFH/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.Iock0vozty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:11 INFO - 'HOME': '/Users/cltbld', 05:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:11 INFO - 'LOGNAME': 'cltbld', 05:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:11 INFO - 'MOZ_NO_REMOTE': '1', 05:39:11 INFO - 'NO_EM_RESTART': '1', 05:39:11 INFO - 'PAGER': '/bin/cat', 05:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:11 INFO - 'PWD': '/builds/slave/test', 05:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:11 INFO - 'SHELL': '/bin/bash', 05:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:39:11 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:11 INFO - 'USER': 'cltbld', 05:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:11 INFO - 'XPC_FLAGS': '0x0', 05:39:11 INFO - 'XPC_SERVICE_NAME': '0', 05:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:39:12 INFO - Cleaning up... 05:39:12 INFO - Return code: 0 05:39:12 INFO - Running post-action listener: _resource_record_post_action 05:39:12 INFO - Running post-action listener: _start_resource_monitoring 05:39:12 INFO - Starting resource monitoring. 05:39:12 INFO - [mozharness: 2016-11-15 13:39:12.132673Z] Finished create-virtualenv step (success) 05:39:12 INFO - [mozharness: 2016-11-15 13:39:12.133687Z] Running install step. 05:39:12 INFO - Running pre-action listener: _resource_record_pre_action 05:39:12 INFO - Running main action method: install 05:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:12 INFO - Reading from file tmpfile_stdout 05:39:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:12 INFO - Reading from file tmpfile_stdout 05:39:12 INFO - Output received: 05:39:12 INFO - Usage: mozinstall [options] installer 05:39:12 INFO - Options: 05:39:12 INFO - -h, --help show this help message and exit 05:39:12 INFO - -d DEST, --destination=DEST 05:39:12 INFO - Directory to install application into. [default: 05:39:12 INFO - "/builds/slave/test"] 05:39:12 INFO - --app=APP Application being installed. [default: firefox] 05:39:12 INFO - mkdir: /builds/slave/test/build/application 05:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:39:46 INFO - Reading from file tmpfile_stdout 05:39:46 INFO - Output received: 05:39:46 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:39:46 INFO - Running post-action listener: _resource_record_post_action 05:39:46 INFO - [mozharness: 2016-11-15 13:39:46.461810Z] Finished install step (success) 05:39:46 INFO - [mozharness: 2016-11-15 13:39:46.461965Z] Running run-tests step. 05:39:46 INFO - Running pre-action listener: _resource_record_pre_action 05:39:46 INFO - Running main action method: run_tests 05:39:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:39:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:39:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:39:46 INFO - 2016-11-15 05:39:46.476 screenresolution[1624:7465] starting screenresolution argv=screenresolution get 05:39:46 INFO - 2016-11-15 05:39:46.479 screenresolution[1624:7465] Display 0: 1600x1200x32@60 05:39:46 INFO - 2016-11-15 05:39:46.484 screenresolution[1625:7468] starting screenresolution argv=screenresolution list 05:39:46 INFO - Available Modes on Display 0 05:39:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:39:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:39:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:39:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:39:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:39:46 INFO - Intel Iris: 05:39:46 INFO - Chipset Model: Intel Iris 05:39:46 INFO - Type: GPU 05:39:46 INFO - Bus: Built-In 05:39:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:39:46 INFO - Vendor: Intel (0x8086) 05:39:46 INFO - Device ID: 0x0a2e 05:39:46 INFO - Revision ID: 0x0009 05:39:46 INFO - Displays: 05:39:46 INFO - Display: 05:39:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:39:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:39:46 INFO - Display Serial Number: 1600x1200 60 05:39:46 INFO - Main Display: Yes 05:39:46 INFO - Mirror: Off 05:39:46 INFO - Online: Yes 05:39:46 INFO - Rotation: Supported 05:39:46 INFO - Return code: 0 05:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:39:46 INFO - Python 2.7.3 05:39:46 INFO - Return code: 0 05:39:46 INFO - grabbing minidump binary from tooltool 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:46 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 0x110349d30>, '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 0x11016fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110341b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:39:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:39:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:39:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:39:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:46 INFO - Return code: 0 05:39:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:39:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:39:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:39:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:39:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0389 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vJtMKzMxFH/Render', 05:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:46 INFO - 'HOME': '/Users/cltbld', 05:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:46 INFO - 'LOGNAME': 'cltbld', 05:39:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:46 INFO - 'MOZ_NO_REMOTE': '1', 05:39:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:46 INFO - 'NO_EM_RESTART': '1', 05:39:46 INFO - 'PAGER': '/bin/cat', 05:39:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:46 INFO - 'PWD': '/builds/slave/test', 05:39:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:46 INFO - 'SHELL': '/bin/bash', 05:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iock0vozty/Listeners', 05:39:46 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 05:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:46 INFO - 'USER': 'cltbld', 05:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:46 INFO - 'XPC_FLAGS': '0x0', 05:39:46 INFO - 'XPC_SERVICE_NAME': '0', 05:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:39:47 INFO - mozversion application_buildid: 20161115030213 05:39:47 INFO - mozversion application_changeset: 5e76768327660437bf3486554ad318e4b70276e1 05:39:47 INFO - mozversion application_display_name: Nightly 05:39:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:47 INFO - mozversion application_name: Firefox 05:39:47 INFO - mozversion application_remotingname: firefox 05:39:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:39:47 INFO - mozversion application_vendor: Mozilla 05:39:47 INFO - mozversion application_version: 53.0a1 05:39:47 INFO - mozversion platform_buildid: 20161115030213 05:39:47 INFO - mozversion platform_changeset: 5e76768327660437bf3486554ad318e4b70276e1 05:39:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:39:47 INFO - mozversion platform_version: 53.0a1 05:39:47 INFO - using testdate: 1479217187 05:39:47 INFO - actual date: 1479217187 05:39:47 INFO - starting webserver on 'localhost:49246' 05:39:47 INFO - SUITE-START | Running 2 tests 05:39:47 INFO - TEST-START | dromaeo_css 05:39:47 INFO - operating with platform_type : mac_ 05:39:47 INFO - Initialising browser for dromaeo_css test... 05:39:47 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpuu68OS/profile http://localhost:49246/getInfo.html) 05:39:49 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 05:39:49 INFO - PROCESS | 1635 | colorDepth:24 05:39:49 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 05:39:49 INFO - PROCESS | 1635 | __metrics 05:39:49 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:39:49 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:39:50 INFO - TEST-INFO | 1635: exit 0 05:39:50 INFO - Browser initialized. 05:39:50 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:50 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpuu68OS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:02 INFO - PROCESS | 1637 | RSS: Main: 238235648 05:40:02 INFO - PROCESS | 1637 | 05:40:53 INFO - PROCESS | 1637 | 1479217253873 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:43:06 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 05:43:08 INFO - PROCESS | 1637 | RSS: Main: 410284032 05:43:08 INFO - PROCESS | 1637 | 05:46:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 05:46:12 INFO - PROCESS | 1637 | RSS: Main: 377417728 05:46:12 INFO - PROCESS | 1637 | 05:49:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 05:49:15 INFO - PROCESS | 1637 | RSS: Main: 355577856 05:49:15 INFO - PROCESS | 1637 | 05:52:17 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 05:52:18 INFO - PROCESS | 1637 | RSS: Main: 352174080 05:52:18 INFO - PROCESS | 1637 | 05:55:21 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 05:55:22 INFO - PROCESS | 1637 | RSS: Main: 329179136 05:55:22 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 05:58:25 INFO - PROCESS | 1637 | RSS: Main: 553852928 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | __start_tp_report 05:58:25 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 05:58:25 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 05:58:25 INFO - PROCESS | 1637 | |i|pagename|runs| 05:58:25 INFO - PROCESS | 1637 | |0;dojo.html;2790.693023767386;3332.3668502984415;3347.2636020075574;3358.143673363292;3415.5389022481972;5568.081266591008;5621.128725047614;5702.857428564283;5714.628549144302;5734.627249228803;5705.315362156537;5714.3999880012625;5726.971365143168;5734.598578099534;5750.281214848144;5172.04317201318;5205.0370681423865;5206.531412172903;5233.633645644806;5244.737763111829;5218.008578370116;5318.946810531903;5320.707361095138;5328.9874923764555;5337.306150200468;5219.608529360295;5244.816431424901;5252.71110088945;5274.789008439658;5281.498257665516;4681.74250416227;5288.021715982517;5305.257263983045;5329.440408757102;5330.253764472977;5000.774965126578;5015.548600625962;5066.873328166788;5222.216667499867;5230.97384513075;4671;5658.830235092953;5695.800646977377;5740.856478588027;5745.741441635137;6275.435210831047;6295.559310848243;6297.4017468340435;6301.6219026858535;6306.9684651576445;4998.600111991032;5139.820106296262;5479.972600137014;6140.657627863787;6334.968325158391;5762.711864406805;5819.388964158745;5826.359100498942;5838.32859221195;5912;6235.625862448177;6284.465820405226;6288.339724328971;6296.905546416808;6313.40022697843;6015.849603759941;6143.784967526115;6177.783777567854;6196.349383314687;6198.690065496708;6166.1983942087245;6190.380961903864;6193.907091393633;6262.812115636538;6336.398042185985;6264.5301602380005;6275.96862015687;6276.403741644536;6284.874302513924;6285.528585356116;6207.472364849038;6288.402601752826;6296.748130074746;6300.558960872695;6300.810975670645;4851.223804191312;4912.901741965212;4919.409670839451;4927.310176575283;4985.55130038291;4396.252637051709;4461.977690111528;4473.083017981306;4495.505494395614;4516.435445569304;5807;5841.912371314434;5854.385289544536;5857.4435428634215;5869.148973398833;6101.913673707429;6135.938640613536;6193.969030154911;6328.462080723098;6337.461315788118;5749.655020698771;5818.418158184232;5830.533557315404;5882.794102206402;5927.555433342516;5432.674039557639;5433.0763770159165;5435.456454354533;5436;5451.591130665137;6213.5339849510565;6336.58812177207;6347.396997285436;6353.4599559038;6367.745290188341;6140.657627863787;6205.906911396242;6229.283632382334;6267.1539342188225;6281.528885333527;6382.457491113308;6393.776217832354;6396.136521569715;6398.744050238124;6405.327440618668;6212.47193988516;6232.626042437469;6242.843928901813;6252.3122456530655;6256.311805701278;6137.959273351923;6197.03945888388;6205.22434695663;6210.099535567408;6315.5894866833505;5893.145493903446;6156.445919867234;6161;6169.259688837368;6184.659843708459;5962;6122.510199183966;6123.571350005457;6124.326324104434;6132.528193233681;5053.545180933586;5811.302643682785;5879.5002424794375;6010.429009244115;6015.0676645120075;6058.939410605837;6073.544484163794;6131.96934015327;6132.724027418688;6162.383761623802;5793.826185214451;6011.398860113954;6025.698715064317;6035.426634469718;6062.939370606237 05:58:25 INFO - PROCESS | 1637 | |1;ext.html;474.035338086993;475.8501072162269;515.0934355534259;517.4230732733004;556.457453982367;29523.261918452023;33001.83499082501;37840.81079594602;39119.41320880189;40719;39937.80031099848;40279;40371.798141009254;40469.79765101178;40491.59508404915;9204.815903681922;9359.859602105973;9374.437533747998;9377.156055954963;9400.294977876687;9241.353105282633;9325.906740932573;9349.719508414724;9357.625694972226;9362.204212641933;9227.123423274777;9334.953325233364;9360.063993600654;9385.671501497449;9392.24862011041;8637.179467950535;9320.440773553608;9331.440113593206;9347.439153650803;9352.251819854395;9182.586783594754;9187.219086377667;9251.259899208047;9255.861162082574;9261.861072083924;38552.22895542073;38873.611263887564;38903.41644875329;39001;39007.60992390068;3251.4147453458368;3253.3330667213163;3268.6077670679433;3525.2420729543273;3892.2410130024655;28993.56509652357;29115.41769164605;29144.70855291441;29988.250293742614;30322.696773032207;3054.8472576371314;3060.1431599152274;3091.6444608870042;3132.076037568923;3166.0818362674795;478014;483547;484810;485514;485655;53327.466725333026;53627;53664.73167634137;53704.46295537073;53705.73147134239;32898.342033159206;33765.66234337625;52806.73596632069;52818.207726884124;53000;14260.073095248776;14759.262036898112;14774.63063423423;14795;14883.883708721889;11100.500477478532;11103.389313587668;11141.554337826396;11189.944050279697;11195.048420884154;15058.171800551076;17709.02600356967;17942.282308707505;17943.910280448516;17944.83358581688;6583.473322134218;7847.293743562993;7857.428514297049;7881.054273487218;7925.445218834626;707.952230698569;896.408370475483;932.5057719408725;963.3593660215878;1014.7919676466307;28394.580270986782;28461;28834.27914302159;28959;29026.564601530994;1011.4639241202175;1032.5301987595626;1047.1936608811172;1056.8309070548828;1210.2133613151523;14310.928445357707;14837.777433338508;14865.182414967281;14983;15037.624059398384;172288;182676;182816;182958.08520957577;183041;54142;54604;54613.72693136509;54642.45357546453;54680.90638187214;1215.6231568213882;1258.710496585772;1335.899807514421;1339.0760375341179;1370.8903287736957;23568.764312356656;28073.43853122967;28749.85000600036;29209.707902920698;30083.69916300809;46277.07445851131;46555.30167047429;46815.06369872652;46871.29693054675;46981.82545436391;526787;528960;530975;531347;531816;22267;22850.31449056531;24506.264812055666;24655.506889861743;25314.493710125327;44318.892027698275;44534.77732611316;44646.55353446424;44648.55351446444;44841;35048.824755876056;35831.46252806262;36909.26181476409;37256.81371593125;37444.06389840276;35147.218275166575;35177;36246.27507449783;36940;37569.2486150281;36047;36077.81961090178;36589.634103659686;36656.81671591625;36956.630433696395;26785.598216027163;31000.534991974688;32919.67080329262;32937.34125317432;33040.50439243365;24110.39724006914;24479.51040979206;24590.508189835746;24933.625995609716;25285.494290113726 05:58:25 INFO - PROCESS | 1637 | |2;jquery.html;348.35901940429613;352.58042928914574;371.7843650682606;381.1728549048564;403.0387525751083;14302.713945721092;14796.556103316905;15404.306806193734;19466.513337166543;20174.092165852537;19062.142203600837;19311.613767724637;20028;20255.59488810223;20266.088026038862;5171.09505836479;5468.1954954865;5470.124780035195;5485;5489.286392768954;4496.280595104784;5366.624336296461;5954.791582294621;6002.2197114375285;6023.3976602339635;5969.492593129589;5974.701264936757;5975.193348897908;5977.551683623724;5984.251968503937;5676.829695109132;5888.263967004124;5911.142884281755;5916.792912248094;5936.7328470218945;5057.544820966131;5165.302684137669;5225.790968361261;5235.240890070956;5238.711870847102;11627.534898604046;12838.935805320914;12985.610431687064;13187.406566704522;13213.603591892259;1823.6261566378994;1999.6800511918168;2064.112431654388;2068.4621998280404;2562.6412302277695;9673.806523869554;10217;10276.332038417553;10465;12118.272903625722;1755.9824401756075;1761.6036391811867;1799.9910000450045;1842.774554920976;1847.7320788485729;117154;121558.17662735067;125184.12223816558;125655.11517327247;126829.73170268271;11061.336319820837;11485.827712584318;11549;11601.245919015237;11763.529458821551;14669.853301466848;14693;14705.823534117246;14707.779383309258;14726.558203253919;7812.726554570677;8068.9596552016865;8116.918830811735;8193.549354785424;8227.876581851277;7078;7149.96425017882;7457.291557302047;7727.265909738566;7874.370050395954;4451.888702782457;4460.397846290709;4476.493163828201;4492.528284530077;4548.226801443762;1722.801877784071;1840.613471171069;1901.3250296144945;1903.1245627011729;1908.360699165795;696.2271878215178;741.210610699614;809.4212637963884;810.8135128920263;919.9770005749909;15941.202939852961;16548.503544893672;20453;20620.175192992414;21748.782512174676;867.6312567158932;870.2428886868465;887.3625282884063;945.5886689290181;995.4176806568094;9312.255019598417;9616.95191524038;11093.611723589636;11183.496742646601;11305.095592352593;537472;557027;561748;562493;562765;86650.70023949645;118238.40880795714;120933;133139.33430332787;141306.88039679412;963;986.6596024371723;1009.4801177393648;1012.0688966151158;1013.1185868294631;18372.35696750607;19247.326343577908;19555.946625604676;19600;19647.508812279237;47852;52520;52924.47075529196;54758.726206368716;55227.44772552384;81671;81671.59164204141;82390;82815;83118;5435.755391007335;7823.530588164728;8117.025956885212;8138.430309878252;8170.42807003504;12313.32276724753;12766.29785361814;12966.02754793413;13021.088523803623;13296.667583310107;11012.843651416486;11037.11703063769;11173.329600224013;11302.830457543309;11456.312621242752;10730.356178629307;10923.289986150874;11015.647904750842;11282.379469128948;11291.266067705574;10107.292489525662;10188.847167292348;10435.426051566934;11543.422828858691;11664.94167529157;7831.216878312123;7854.015474119798;7968.561729104955;8271.421000529905;8289.792755181168;8279.834403312021;9854;10982.06652434552;11377.43112844371;11397.202195846212 05:58:25 INFO - PROCESS | 1637 | |3;mootools.html;1390.6175801654545;1449.0943160524669;1594.4897632757522;1750.221151587544;1798.3346161920092;7365.963170184142;8077.555734434603;8525.147485251471;8533.146685331463;8535.189157030089;7440.181580026207;7667.8849817252785;7719.961400193005;8029.558374289411;8318.500889946607;2196.9011394487247;2231.984447076576;2233.7542870284256;2238.5858616155983;2242.416971587391;2313.571989181998;2351.271105957159;2359.7876191142796;2369.751176126499;2371.2174982255815;2258.3450799268194;2263.649134384173;2283.178055899883;2288.6109361408517;2324.1168356024687;2275.5562665280277;2306.054517647765;2308.2728940383727;2309.5034567568055;2311.3759284992957;2318.5131122464304;2352.882355882199;2355.316958082154;2356.0340260493117;2357.4342157882156;8316.625751841182;8337.333013358917;8403.873941890877;8452.492850428995;8455.281301089415;5057.190849464068;5215.921761173586;5220.164773636238;5226.81706140287;5238.68567885928;3215.778004358352;3273.558069660613;3497.0208341664375;3535.6641119093647;3537.823108844573;1032.7573020340214;1057.9788404231872;1070.8072546941548;1075.0324707762998;1078.487718333793;10520.316179448388;10880.075193608553;10886.72783180419;10951.616693415692;11121.610743623934;4280.636145927631;4370.694051416434;4476.798544065525;4503.549645035536;4505.05393867285;8699.260562852229;8706.608202630898;8707.216350528483;8719.34604904622;8724.825503490021;5116.181410974301;5116.565091967224;5125.615578831528;5126.461721519261;5128.9230661540105;3891.727579069438;4227.8097485613225;4766.833160839354;4831.227003679464;4834.8791280218275;3306.8015919044933;3371.763976521669;3571.4642803579673;3613.5663720353728;3659.3779057560278;1132.7904337697553;1137.9317240965568;1138.1407037686495;1141.868685101224;1149.3965668024186;834.7662654456641;841.6296829395046;871.7254064969515;897.1073781587362;933.4725879877983;5474.91787623186;5675.57433192504;5798.88402231953;5799;5870.207521984477;863.2877875752404;875.872998415239;888.6356593796512;905.9365844390829;912.1289168843738;3654.8903532894055;3751.7373783835415;3790.886273411802;3828.425736139601;3865.246276976019;9993.250506212064;10239.232057595711;10285.845712314322;10349.223808214414;10361.63734269312;8728.825423491495;10295.742606434898;10304.587816487257;10306.845397319046;10319.948400258101;7786.649600767979;7941.126476087626;7943.324817390587;7947.245011723877;7971.043474782947;5276.182191760283;5500.669959802264;5556.416576259596;5590.748416321194;5596.720163991866;9305.348625596143;9535.809283814424;9538.952305238707;9552.092551207625;9553.379030363005;6931.549449285781;9481.905180948102;9491.477968711788;9524.95237523808;9661.806763864543;6551.001944407001;6758.966205168943;6789.558678685869;7041.5775053496955;7218.530795498275;7603.771886843404;7716.996790417435;7896.486728362638;7961.601919903866;7985.081715602548;6991.44068474531;7120.964395177991;7136.964315178391;7201.6399180041835;7248.057752492142;6769.593824370553;6783.118194634666;6984.650767461708;7035.472339574655;7042.471814613822;6379.808605741835;6546.345365463416;6650.900236496554;6742.426893713893;6746.359095885883;4821.95178048215;4857.587105096107;4930.309756634146;4931.186354251652;4997.675151115166;4212.304969679968;4746.359241502491;4920;4961.42943561495;5026.978282855856 05:58:25 INFO - PROCESS | 1637 | |4;prototype.html;267.98392096474214;297.5804116196163;298.9432007918497;306.68564721160806;309.0450507930494;4811.3504676868615;5050.8484745457645;5173.680711418588;5211.827338848757;5242.475752424755;3883.728139030269;4682.742449165295;5006.899862002758;5089.46560611136;5161.632167475613;3195.8402079896027;3624.5106910567133;3934.9606503935024;3999.340108882031;4005.838306890998;3969.24584328978;3970.7419017763896;3996.3605823068315;3997.9800100999455;4005.6595189408936;3299.3668134273566;3304.5208444775494;3682.5638001179564;3693.409054551272;4001.9799901000456;3336.382769187696;3761.066368232769;3951.209758048402;3973.9006524836823;3987.980060099681;3416.641252668484;3422.6309476209467;3438.6905178534053;3439.226174110805;3442.7417943654327;4155.252054630166;4666.879948812295;5069.363930756023;5094.61790365724;5124.948750512484;3965.8413663453425;3981.3629819228786;4067.1662309226535;4514.8194072237075;4554.339620755005;5295.602829787781;5385.748894827512;5483.287172667568;5507.394186639466;5515.628279839708;3758.924821503582;3764.0615083232155;3766.8116594170183;3775.320442320381;3791.545014598266;5306.52241298285;5388.922215556904;5638.520725738317;5642.60189419491;5681.545476361923;3194.354907222782;3224.5654530829543;3447.2760720248525;3812.561555421162;3831.6743076838225;3284.5730055092686;3713.535808023997;3837.3860182370686;3851.422286657024;3884.902877428087;3773.2830762155104;4344.500382455994;4465.151621191963;4469.608759313816;4526.547345265447;4421.248387774086;4898.853034408973;5497.972510137423;5516.11114164513;5576.498115169654;1085.3976043295888;1174.236746115015;1252.2298786246392;1253.229264002632;1253.846461255647;724.9891251631229;801.0707579208091;823.4112609484248;828.5774255129927;867.5381981361301;3993.800309984489;4286.663768246313;4305.827766889352;4603.723776573416;4853.466118727008;5230.869228269247;5293.761780719799;5296.629235953446;5342.412334643186;5454.118329176428;3927;4147.294959856831;4488.304312831517;4571.794269257892;4863.465018847924;2207.3708992936936;2347.955159953838;2448.559259333337;2464.383904023994;2823.9858800705865;4691.413573303337;5432.70120143388;5456.536194423439;5468.234447177399;5562.4425160955;4428.446444194476;4491.595756381876;4900.387451568554;5017.795729025008;5313.681179129265;4745.857624271277;4957.90084198314;5363.069295053778;5478.5211390767945;5544.615815199503;4288.421063156434;4473.776311184492;4615.538446155358;4687.460941991714;4890.339804126397;5162.6902385856965;5171.3018742469285;5638.379778224474;5656.406077361818;5724.942750572441;5477.424870388551;5930.584859059824;5972.790952316648;6008.429199226067;6013.849653758691;3553.0406790167026;3560.5935655416483;3865.424482353755;3876.4960555127655;3910.3743401055694;4481.350204220435;4776;5150.896982060262;5401.297831281908;5599.860003499782;4915.926261106158;5187.58499320061;5510.944890551204;5522.530584900329;5618.297712785902;4658.53414658545;5133.947540754062;5171.974140129275;5434.673919564839;5595.63628364155;4290.3993440917675;5088.542031217208;5380;5436.293281873332;5454.890902182014;5359.275303663916;5388.11416004411;5430.538404235526;5581.860453488695;5582.944170558405;4586.706646676662;4785.243583786711;5496.120620700669;5518.392976772632;5522.337319521683 05:58:25 INFO - PROCESS | 1637 | |5;yui.html;704.2183176673891;720.4812534974816;724.1021133794097;725.2095216214327;737.5943231222826;12641.747165056693;13410.731785364287;13422.731545369112;13429.127106738055;13429.731405371898;12440.688982775435;12565.05762067844;12593.118481706262;13242.867571324285;13811.37848796804;801.0227522422636;823.3372135430976;824.1017291152642;826.1738261738262;828.4821986258588;818.0837462042521;819.0744458761591;820.5281962871343;821.1296026212204;825.3026192867047;866.7963028688254;867.037588277012;868.6395146014428;868.9702702297798;871.8256348730248;864.788126908905;865.9826803463895;866.5060915278294;866.8526350520426;867.397158974513;642.5502148496072;644.3749562923956;644.9290578036412;646.5635695905293;647.3591144766694;13437.664058398619;13440.462381504729;13442.19346839183;13451.529196478174;13469.259190744506;11915.761684766343;12106.878931210664;12109.333986630732;12169.20900141488;12310.692232694255;10113.595456181743;10142.645007424779;10282.588696452207;10484.423356715377;10556.894431055667;3408.5739282589675;3445.260143627477;3469;3559.056849934769;3570.9285814283567;86560;90682;91118.54440727754;91540;92700;9051.411658242194;9158.267338612895;9311.348205625542;9317.44095354281;9391.060893910555;17784.46646600604;18807.623847522973;18814.717779233324;18860.717089243673;18866.905665471586;6962.756303529352;6968.512204145763;7016.5790052597;7024.964875175694;7201.243869393743;3879.9030024249055;3892.143728379752;3895.2599006188734;3947.1908258806875;4066.5933406659096;3148.511980643004;3212.5020621803656;3243.367543329028;3246.0910944935454;3249.415105281072;536.9838904832861;596.2755252368306;601.035338282051;618.0482057631198;619.1115748900343;566.963147395418;567.2087438023933;575.1085816983658;591.5740666719955;671.4024518178825;7978.162292959272;8290.626921788535;8313.667453301921;8586.48481091124;8586.699465518677;578.9334226563999;616.0389791924612;627.4321738826369;631.4159402552621;659.1200747002805;3527.7530572859655;3946.7631942082994;4091.4067460218102;4142.834286628561;4191.872111703962;73405.26594733984;73549.6322518384;73979.89030164552;89517;98384;64406.71186576242;69832.6508367455;74212;89569.55215223882;90395;82276.58861705654;82315.58842205751;84322.57838710767;84654;86112.56943715242;9126.406783559047;9571;9576.856347154659;9585.856212156683;9749.658761943298;36519;43364.78317608518;53153.202701960276;53191.734041329546;54335;70130.64934675497;73290.26709732834;74070;74169.14577135615;75784;10119.433662931557;10983.39591322485;11684.70044758137;11836.467358968695;12444.937775311066;13033.218006919615;13166.341682915625;13305.201687898758;13694.63376263907;14072.78890816659;12301.44643491027;12357.352137855618;12392.938035310126;12515.120312703091;12521.311327877054;11803.940980295043;12107.213031152947;12629.11596188258;12689.746205076031;12831.10182287231;12241.755164896831;12405.689857753629;12544;12644.557440489538;12706.30115343665;10495.10791582724;10657.360558366523;10819.621313253998;10824.954284836478;11385.259958102697;8259.504429733995;8865;10771.291215655716;11052;11065.557377705123 05:58:25 INFO - PROCESS | 1637 | __end_tp_report 05:58:25 INFO - PROCESS | 1637 | __start_cc_report 05:58:25 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,2009 05:58:25 INFO - PROCESS | 1637 | __end_cc_report 05:58:25 INFO - PROCESS | 1637 | __startTimestamp1479218305841__endTimestamp 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | ------- Summary: start ------- 05:58:25 INFO - PROCESS | 1637 | Number of tests: 6 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5738.22 Median:5927.56 stddev:668.33 (11.3%) stddev-sans-first:629.11 05:58:25 INFO - PROCESS | 1637 | Values: 2790.7 3332.4 3347.3 3358.1 3415.5 5568.1 5621.1 5702.9 5714.6 5734.6 5705.3 5714.4 5727.0 5734.6 5750.3 5172.0 5205.0 5206.5 5233.6 5244.7 5218.0 5318.9 5320.7 5329.0 5337.3 5219.6 5244.8 5252.7 5274.8 5281.5 4681.7 5288.0 5305.3 5329.4 5330.3 5000.8 5015.5 5066.9 5222.2 5231.0 4671.0 5658.8 5695.8 5740.9 5745.7 6275.4 6295.6 6297.4 6301.6 6307.0 4998.6 5139.8 5480.0 6140.7 6335.0 5762.7 5819.4 5826.4 5838.3 5912.0 6235.6 6284.5 6288.3 6296.9 6313.4 6015.8 6143.8 6177.8 6196.3 6198.7 6166.2 6190.4 6193.9 6262.8 6336.4 6264.5 6276.0 6276.4 6284.9 6285.5 6207.5 6288.4 6296.7 6300.6 6300.8 4851.2 4912.9 4919.4 4927.3 4985.6 4396.3 4462.0 4473.1 4495.5 4516.4 5807.0 5841.9 5854.4 5857.4 5869.1 6101.9 6135.9 6194.0 6328.5 6337.5 5749.7 5818.4 5830.5 5882.8 5927.6 5432.7 5433.1 5435.5 5436.0 5451.6 6213.5 6336.6 6347.4 6353.5 6367.7 6140.7 6205.9 6229.3 6267.2 6281.5 6382.5 6393.8 6396.1 6398.7 6405.3 6212.5 6232.6 6242.8 6252.3 6256.3 6138.0 6197.0 6205.2 6210.1 6315.6 5893.1 6156.4 6161.0 6169.3 6184.7 5962.0 6122.5 6123.6 6124.3 6132.5 5053.5 5811.3 5879.5 6010.4 6015.1 6058.9 6073.5 6132.0 6132.7 6162.4 5793.8 6011.4 6025.7 6035.4 6062.9 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:54211.27 Median:37106.72 stddev:114354.51 (308.2%) stddev-sans-first:114604.12 05:58:25 INFO - PROCESS | 1637 | Values: 474.0 475.9 515.1 517.4 556.5 29523.3 33001.8 37840.8 39119.4 40719.0 39937.8 40279.0 40371.8 40469.8 40491.6 9204.8 9359.9 9374.4 9377.2 9400.3 9241.4 9325.9 9349.7 9357.6 9362.2 9227.1 9335.0 9360.1 9385.7 9392.2 8637.2 9320.4 9331.4 9347.4 9352.3 9182.6 9187.2 9251.3 9255.9 9261.9 38552.2 38873.6 38903.4 39001.0 39007.6 3251.4 3253.3 3268.6 3525.2 3892.2 28993.6 29115.4 29144.7 29988.3 30322.7 3054.8 3060.1 3091.6 3132.1 3166.1 478014.0 483547.0 484810.0 485514.0 485655.0 53327.5 53627.0 53664.7 53704.5 53705.7 32898.3 33765.7 52806.7 52818.2 53000.0 14260.1 14759.3 14774.6 14795.0 14883.9 11100.5 11103.4 11141.6 11189.9 11195.0 15058.2 17709.0 17942.3 17943.9 17944.8 6583.5 7847.3 7857.4 7881.1 7925.4 708.0 896.4 932.5 963.4 1014.8 28394.6 28461.0 28834.3 28959.0 29026.6 1011.5 1032.5 1047.2 1056.8 1210.2 14310.9 14837.8 14865.2 14983.0 15037.6 172288.0 182676.0 182816.0 182958.1 183041.0 54142.0 54604.0 54613.7 54642.5 54680.9 1215.6 1258.7 1335.9 1339.1 1370.9 23568.8 28073.4 28749.9 29209.7 30083.7 46277.1 46555.3 46815.1 46871.3 46981.8 526787.0 528960.0 530975.0 531347.0 531816.0 22267.0 22850.3 24506.3 24655.5 25314.5 44318.9 44534.8 44646.6 44648.6 44841.0 35048.8 35831.5 36909.3 37256.8 37444.1 35147.2 35177.0 36246.3 36940.0 37569.2 36047.0 36077.8 36589.6 36656.8 36956.6 26785.6 31000.5 32919.7 32937.3 33040.5 24110.4 24479.5 24590.5 24933.6 25285.5 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:33287.16 Median:12155.71 stddev:93419.74 (768.5%) stddev-sans-first:93649.07 05:58:25 INFO - PROCESS | 1637 | Values: 348.4 352.6 371.8 381.2 403.0 14302.7 14796.6 15404.3 19466.5 20174.1 19062.1 19311.6 20028.0 20255.6 20266.1 5171.1 5468.2 5470.1 5485.0 5489.3 4496.3 5366.6 5954.8 6002.2 6023.4 5969.5 5974.7 5975.2 5977.6 5984.3 5676.8 5888.3 5911.1 5916.8 5936.7 5057.5 5165.3 5225.8 5235.2 5238.7 11627.5 12838.9 12985.6 13187.4 13213.6 1823.6 1999.7 2064.1 2068.5 2562.6 9673.8 10217.0 10276.3 10465.0 12118.3 1756.0 1761.6 1800.0 1842.8 1847.7 117154.0 121558.2 125184.1 125655.1 126829.7 11061.3 11485.8 11549.0 11601.2 11763.5 14669.9 14693.0 14705.8 14707.8 14726.6 7812.7 8069.0 8116.9 8193.5 8227.9 7078.0 7150.0 7457.3 7727.3 7874.4 4451.9 4460.4 4476.5 4492.5 4548.2 1722.8 1840.6 1901.3 1903.1 1908.4 696.2 741.2 809.4 810.8 920.0 15941.2 16548.5 20453.0 20620.2 21748.8 867.6 870.2 887.4 945.6 995.4 9312.3 9617.0 11093.6 11183.5 11305.1 537472.0 557027.0 561748.0 562493.0 562765.0 86650.7 118238.4 120933.0 133139.3 141306.9 963.0 986.7 1009.5 1012.1 1013.1 18372.4 19247.3 19555.9 19600.0 19647.5 47852.0 52520.0 52924.5 54758.7 55227.4 81671.0 81671.6 82390.0 82815.0 83118.0 5435.8 7823.5 8117.0 8138.4 8170.4 12313.3 12766.3 12966.0 13021.1 13296.7 11012.8 11037.1 11173.3 11302.8 11456.3 10730.4 10923.3 11015.6 11282.4 11291.3 10107.3 10188.8 10435.4 11543.4 11664.9 7831.2 7854.0 7968.6 8271.4 8289.8 8279.8 9854.0 10982.1 11377.4 11397.2 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5389.07 Median:5121.09 stddev:2964.81 (57.9%) stddev-sans-first:2957.90 05:58:25 INFO - PROCESS | 1637 | Values: 1390.6 1449.1 1594.5 1750.2 1798.3 7366.0 8077.6 8525.1 8533.1 8535.2 7440.2 7667.9 7720.0 8029.6 8318.5 2196.9 2232.0 2233.8 2238.6 2242.4 2313.6 2351.3 2359.8 2369.8 2371.2 2258.3 2263.6 2283.2 2288.6 2324.1 2275.6 2306.1 2308.3 2309.5 2311.4 2318.5 2352.9 2355.3 2356.0 2357.4 8316.6 8337.3 8403.9 8452.5 8455.3 5057.2 5215.9 5220.2 5226.8 5238.7 3215.8 3273.6 3497.0 3535.7 3537.8 1032.8 1058.0 1070.8 1075.0 1078.5 10520.3 10880.1 10886.7 10951.6 11121.6 4280.6 4370.7 4476.8 4503.5 4505.1 8699.3 8706.6 8707.2 8719.3 8724.8 5116.2 5116.6 5125.6 5126.5 5128.9 3891.7 4227.8 4766.8 4831.2 4834.9 3306.8 3371.8 3571.5 3613.6 3659.4 1132.8 1137.9 1138.1 1141.9 1149.4 834.8 841.6 871.7 897.1 933.5 5474.9 5675.6 5798.9 5799.0 5870.2 863.3 875.9 888.6 905.9 912.1 3654.9 3751.7 3790.9 3828.4 3865.2 9993.3 10239.2 10285.8 10349.2 10361.6 8728.8 10295.7 10304.6 10306.8 10319.9 7786.6 7941.1 7943.3 7947.2 7971.0 5276.2 5500.7 5556.4 5590.7 5596.7 9305.3 9535.8 9539.0 9552.1 9553.4 6931.5 9481.9 9491.5 9525.0 9661.8 6551.0 6759.0 6789.6 7041.6 7218.5 7603.8 7717.0 7896.5 7961.6 7985.1 6991.4 7121.0 7137.0 7201.6 7248.1 6769.6 6783.1 6984.7 7035.5 7042.5 6379.8 6546.3 6650.9 6742.4 6746.4 4822.0 4857.6 4930.3 4931.2 4997.7 4212.3 4746.4 4920.0 4961.4 5027.0 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4286.25 Median:4674.81 stddev:1341.93 (28.7%) stddev-sans-first:1311.37 05:58:25 INFO - PROCESS | 1637 | Values: 268.0 297.6 298.9 306.7 309.0 4811.4 5050.8 5173.7 5211.8 5242.5 3883.7 4682.7 5006.9 5089.5 5161.6 3195.8 3624.5 3935.0 3999.3 4005.8 3969.2 3970.7 3996.4 3998.0 4005.7 3299.4 3304.5 3682.6 3693.4 4002.0 3336.4 3761.1 3951.2 3973.9 3988.0 3416.6 3422.6 3438.7 3439.2 3442.7 4155.3 4666.9 5069.4 5094.6 5124.9 3965.8 3981.4 4067.2 4514.8 4554.3 5295.6 5385.7 5483.3 5507.4 5515.6 3758.9 3764.1 3766.8 3775.3 3791.5 5306.5 5388.9 5638.5 5642.6 5681.5 3194.4 3224.6 3447.3 3812.6 3831.7 3284.6 3713.5 3837.4 3851.4 3884.9 3773.3 4344.5 4465.2 4469.6 4526.5 4421.2 4898.9 5498.0 5516.1 5576.5 1085.4 1174.2 1252.2 1253.2 1253.8 725.0 801.1 823.4 828.6 867.5 3993.8 4286.7 4305.8 4603.7 4853.5 5230.9 5293.8 5296.6 5342.4 5454.1 3927.0 4147.3 4488.3 4571.8 4863.5 2207.4 2348.0 2448.6 2464.4 2824.0 4691.4 5432.7 5456.5 5468.2 5562.4 4428.4 4491.6 4900.4 5017.8 5313.7 4745.9 4957.9 5363.1 5478.5 5544.6 4288.4 4473.8 4615.5 4687.5 4890.3 5162.7 5171.3 5638.4 5656.4 5724.9 5477.4 5930.6 5972.8 6008.4 6013.8 3553.0 3560.6 3865.4 3876.5 3910.4 4481.4 4776.0 5150.9 5401.3 5599.9 4915.9 5187.6 5510.9 5522.5 5618.3 4658.5 5133.9 5172.0 5434.7 5595.6 4290.4 5088.5 5380.0 5436.3 5454.9 5359.3 5388.1 5430.5 5581.9 5582.9 4586.7 4785.2 5496.1 5518.4 5522.3 05:58:25 INFO - PROCESS | 1637 | 05:58:25 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:18738.91 Median:571.16 stddev:26838.03 (4698.9%) stddev-sans-first:26879.15 05:58:25 INFO - PROCESS | 1637 | Values: 704.2 720.5 724.1 725.2 737.6 12641.7 13410.7 13422.7 13429.1 13429.7 12440.7 12565.1 12593.1 13242.9 13811.4 801.0 823.3 824.1 826.2 828.5 818.1 819.1 820.5 821.1 825.3 866.8 867.0 868.6 869.0 871.8 864.8 866.0 866.5 866.9 867.4 642.6 644.4 644.9 646.6 647.4 13437.7 13440.5 13442.2 13451.5 13469.3 11915.8 12106.9 12109.3 12169.2 12310.7 10113.6 10142.6 10282.6 10484.4 10556.9 3408.6 3445.3 3469.0 3559.1 3570.9 86560.0 90682.0 91118.5 91540.0 92700.0 9051.4 9158.3 9311.3 9317.4 9391.1 17784.5 18807.6 18814.7 18860.7 18866.9 6962.8 6968.5 7016.6 7025.0 7201.2 3879.9 3892.1 3895.3 3947.2 4066.6 3148.5 3212.5 3243.4 3246.1 3249.4 537.0 596.3 601.0 618.0 619.1 567.0 567.2 575.1 591.6 671.4 7978.2 8290.6 8313.7 8586.5 8586.7 578.9 616.0 627.4 631.4 659.1 3527.8 3946.8 4091.4 4142.8 4191.9 73405.3 73549.6 73979.9 89517.0 98384.0 64406.7 69832.7 74212.0 89569.6 90395.0 82276.6 82315.6 84322.6 84654.0 86112.6 9126.4 9571.0 9576.9 9585.9 9749.7 36519.0 43364.8 53153.2 53191.7 54335.0 70130.6 73290.3 74070.0 74169.1 75784.0 10119.4 10983.4 11684.7 11836.5 12444.9 13033.2 13166.3 13305.2 13694.6 14072.8 12301.4 12357.4 12392.9 12515.1 12521.3 11803.9 12107.2 12629.1 12689.7 12831.1 12241.8 12405.7 12544.0 12644.6 12706.3 10495.1 10657.4 10819.6 10825.0 11385.3 8259.5 8865.0 10771.3 11052.0 11065.6 05:58:25 INFO - PROCESS | 1637 | -------- Summary: end -------- 05:58:25 INFO - PROCESS | 1637 | 05:58:26 INFO - TEST-INFO | 1637: exit 0 05:58:26 INFO - TEST-OK | dromaeo_css | took 1119407ms 05:58:26 INFO - TEST-START | kraken 05:58:26 INFO - operating with platform_type : mac_ 05:58:26 INFO - Initialising browser for kraken test... 05:58:26 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpm_ujBB/profile http://localhost:49246/getInfo.html) 05:58:28 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 05:58:28 INFO - PROCESS | 1647 | colorDepth:24 05:58:28 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 05:58:28 INFO - PROCESS | 1647 | __metrics 05:58:28 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:58:28 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:29 INFO - TEST-INFO | 1647: exit 0 05:58:29 INFO - Browser initialized. 05:58:29 INFO - Running cycle 1/1 for kraken test... 05:58:29 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpm_ujBB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:41 INFO - PROCESS | 1649 | RSS: Main: 231108608 05:58:41 INFO - PROCESS | 1649 | 05:58:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 05:58:45 INFO - PROCESS | 1649 | RSS: Main: 288751616 05:58:45 INFO - PROCESS | 1649 | 05:58:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 05:58:48 INFO - PROCESS | 1649 | RSS: Main: 290570240 05:58:48 INFO - PROCESS | 1649 | 05:58:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 05:58:52 INFO - PROCESS | 1649 | RSS: Main: 381394944 05:58:52 INFO - PROCESS | 1649 | 05:58:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 05:58:55 INFO - PROCESS | 1649 | RSS: Main: 283021312 05:58:55 INFO - PROCESS | 1649 | 05:58:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:57 INFO - PROCESS | 1649 | RSS: Main: 288026624 05:58:57 INFO - PROCESS | 1649 | 05:59:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:01 INFO - PROCESS | 1649 | RSS: Main: 328372224 05:59:01 INFO - PROCESS | 1649 | 05:59:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:04 INFO - PROCESS | 1649 | RSS: Main: 330727424 05:59:04 INFO - PROCESS | 1649 | 05:59:07 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 05:59:08 INFO - PROCESS | 1649 | RSS: Main: 328097792 05:59:08 INFO - PROCESS | 1649 | 05:59:09 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:10 INFO - PROCESS | 1649 | RSS: Main: 302649344 05:59:10 INFO - PROCESS | 1649 | 05:59:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:12 INFO - PROCESS | 1649 | RSS: Main: 305037312 05:59:12 INFO - PROCESS | 1649 | 05:59:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:15 INFO - PROCESS | 1649 | RSS: Main: 311672832 05:59:15 INFO - PROCESS | 1649 | 05:59:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:19 INFO - PROCESS | 1649 | RSS: Main: 327430144 05:59:19 INFO - PROCESS | 1649 | 05:59:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:23 INFO - PROCESS | 1649 | RSS: Main: 321318912 05:59:23 INFO - PROCESS | 1649 | 05:59:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 05:59:24 INFO - PROCESS | 1649 | RSS: Main: 365187072 05:59:24 INFO - PROCESS | 1649 | 05:59:24 INFO - PROCESS | 1649 | __start_tp_report 05:59:24 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 05:59:24 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 05:59:24 INFO - PROCESS | 1649 | |i|pagename|runs| 05:59:24 INFO - PROCESS | 1649 | |0;ai-astar;104;115;114;112;113;115;113;113;114;114 05:59:24 INFO - PROCESS | 1649 | |1;audio-beat-detection;160;110;113;171;141;100;131;142;173;115 05:59:24 INFO - PROCESS | 1649 | |2;audio-dft;183;183;183;181;184;183;182;179;181;181 05:59:24 INFO - PROCESS | 1649 | |3;audio-fft;83;59;59;88;60;59;59;59;83;58 05:59:24 INFO - PROCESS | 1649 | |4;audio-oscillator;89;72;92;72;69;69;90;67;70;97 05:59:24 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;86;89;87;89;85;91;86;89;85 05:59:24 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;94;94;94;93;93;94;94;94;93 05:59:25 INFO - PROCESS | 1649 | |7;imaging-desaturate;82;83;79;81;82;84;82;84;80;83 05:59:25 INFO - PROCESS | 1649 | |8;json-parse-financial;55;55;55;54;55;54;56;54;54;54 05:59:25 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;64;73;75;72;73;72;69;73;70;71 05:59:25 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;87;84;85;90;86;90;87;83;92;88 05:59:25 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;150;160;155;143;148;146;151;151;209;155 05:59:25 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;215;239;177;171;175;175;173;173;174;172 05:59:25 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;64;64;66;68;68;68;68;70;61;57 05:59:25 INFO - PROCESS | 1649 | __end_tp_report 05:59:25 INFO - PROCESS | 1649 | __start_cc_report 05:59:25 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2031 05:59:25 INFO - PROCESS | 1649 | __end_cc_report 05:59:25 INFO - PROCESS | 1649 | __startTimestamp1479218364994__endTimestamp 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | ------- Summary: start ------- 05:59:25 INFO - PROCESS | 1649 | Number of tests: 14 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.20 (2.8%) stddev-sans-first:1.00 05:59:25 INFO - PROCESS | 1649 | Values: 104.0 115.0 114.0 112.0 113.0 115.0 113.0 113.0 114.0 114.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:141.50 stddev:26.24 (18.5%) stddev-sans-first:26.30 05:59:25 INFO - PROCESS | 1649 | Values: 160.0 110.0 113.0 171.0 141.0 100.0 131.0 142.0 173.0 115.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:182.00 Median:183.00 stddev:1.49 (0.8%) stddev-sans-first:1.54 05:59:25 INFO - PROCESS | 1649 | Values: 183.0 183.0 183.0 181.0 184.0 183.0 182.0 179.0 181.0 181.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:66.70 Median:59.50 stddev:12.48 (21.0%) stddev-sans-first:11.76 05:59:25 INFO - PROCESS | 1649 | Values: 83.0 59.0 59.0 88.0 60.0 59.0 59.0 59.0 83.0 58.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:80.50 stddev:11.72 (14.6%) stddev-sans-first:11.82 05:59:25 INFO - PROCESS | 1649 | Values: 89.0 72.0 92.0 72.0 69.0 69.0 90.0 67.0 70.0 97.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:89.00 stddev:2.07 (2.3%) stddev-sans-first:2.13 05:59:25 INFO - PROCESS | 1649 | Values: 89.0 86.0 89.0 87.0 89.0 85.0 91.0 86.0 89.0 85.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:59:25 INFO - PROCESS | 1649 | Values: 94.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 93.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:82.00 Median:82.50 stddev:1.63 (2.0%) stddev-sans-first:1.73 05:59:25 INFO - PROCESS | 1649 | Values: 82.0 83.0 79.0 81.0 82.0 84.0 82.0 84.0 80.0 83.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 05:59:25 INFO - PROCESS | 1649 | Values: 55.0 55.0 55.0 54.0 55.0 54.0 56.0 54.0 54.0 54.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.50 stddev:3.05 (4.2%) stddev-sans-first:1.80 05:59:25 INFO - PROCESS | 1649 | Values: 64.0 73.0 75.0 72.0 73.0 72.0 69.0 73.0 70.0 71.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.50 stddev:2.86 (3.3%) stddev-sans-first:3.03 05:59:25 INFO - PROCESS | 1649 | Values: 87.0 84.0 85.0 90.0 86.0 90.0 87.0 83.0 92.0 88.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:153.00 stddev:18.97 (12.4%) stddev-sans-first:19.96 05:59:25 INFO - PROCESS | 1649 | Values: 150.0 160.0 155.0 143.0 148.0 146.0 151.0 151.0 209.0 155.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:175.00 stddev:23.21 (13.3%) stddev-sans-first:21.82 05:59:25 INFO - PROCESS | 1649 | Values: 215.0 239.0 177.0 171.0 175.0 175.0 173.0 173.0 174.0 172.0 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:68.00 stddev:3.98 (5.8%) stddev-sans-first:4.19 05:59:25 INFO - PROCESS | 1649 | Values: 64.0 64.0 66.0 68.0 68.0 68.0 68.0 70.0 61.0 57.0 05:59:25 INFO - PROCESS | 1649 | -------- Summary: end -------- 05:59:25 INFO - PROCESS | 1649 | 05:59:25 INFO - TEST-INFO | 1649: exit 0 05:59:26 INFO - TEST-OK | kraken | took 59549ms 05:59:26 INFO - SUITE-END | took 1178s 05:59:26 INFO - Completed test suite (00:19:39) 05:59:26 INFO - javascript benchmark 05:59:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2790.693023767386, 3332.3668502984415, 3347.2636020075574, 3358.143673363292, 3415.5389022481972, 5568.081266591008, 5621.128725047614, 5702.857428564283, 5714.628549144302, 5734.627249228803, 5705.315362156537, 5714.3999880012625, 5726.971365143168, 5734.598578099534, 5750.281214848144, 5172.04317201318, 5205.0370681423865, 5206.531412172903, 5233.633645644806, 5244.737763111829, 5218.008578370116, 5318.946810531903, 5320.707361095138, 5328.9874923764555, 5337.306150200468, 5219.608529360295, 5244.816431424901, 5252.71110088945, 5274.789008439658, 5281.498257665516, 4681.74250416227, 5288.021715982517, 5305.257263983045, 5329.440408757102, 5330.253764472977, 5000.774965126578, 5015.548600625962, 5066.873328166788, 5222.216667499867, 5230.97384513075, 4671.0, 5658.830235092953, 5695.800646977377, 5740.856478588027, 5745.741441635137, 6275.435210831047, 6295.559310848243, 6297.4017468340435, 6301.6219026858535, 6306.9684651576445, 4998.600111991032, 5139.820106296262, 5479.972600137014, 6140.657627863787, 6334.968325158391, 5762.711864406805, 5819.388964158745, 5826.359100498942, 5838.32859221195, 5912.0, 6235.625862448177, 6284.465820405226, 6288.339724328971, 6296.905546416808, 6313.40022697843, 6015.849603759941, 6143.784967526115, 6177.783777567854, 6196.349383314687, 6198.690065496708, 6166.1983942087245, 6190.380961903864, 6193.907091393633, 6262.812115636538, 6336.398042185985, 6264.5301602380005, 6275.96862015687, 6276.403741644536, 6284.874302513924, 6285.528585356116, 6207.472364849038, 6288.402601752826, 6296.748130074746, 6300.558960872695, 6300.810975670645, 4851.223804191312, 4912.901741965212, 4919.409670839451, 4927.310176575283, 4985.55130038291, 4396.252637051709, 4461.977690111528, 4473.083017981306, 4495.505494395614, 4516.435445569304, 5807.0, 5841.912371314434, 5854.385289544536, 5857.4435428634215, 5869.148973398833, 6101.913673707429, 6135.938640613536, 6193.969030154911, 6328.462080723098, 6337.461315788118, 5749.655020698771, 5818.418158184232, 5830.533557315404, 5882.794102206402, 5927.555433342516, 5432.674039557639, 5433.0763770159165, 5435.456454354533, 5436.0, 5451.591130665137, 6213.5339849510565, 6336.58812177207, 6347.396997285436, 6353.4599559038, 6367.745290188341, 6140.657627863787, 6205.906911396242, 6229.283632382334, 6267.1539342188225, 6281.528885333527, 6382.457491113308, 6393.776217832354, 6396.136521569715, 6398.744050238124, 6405.327440618668, 6212.47193988516, 6232.626042437469, 6242.843928901813, 6252.3122456530655, 6256.311805701278, 6137.959273351923, 6197.03945888388, 6205.22434695663, 6210.099535567408, 6315.5894866833505, 5893.145493903446, 6156.445919867234, 6161.0, 6169.259688837368, 6184.659843708459, 5962.0, 6122.510199183966, 6123.571350005457, 6124.326324104434, 6132.528193233681, 5053.545180933586, 5811.302643682785, 5879.5002424794375, 6010.429009244115, 6015.0676645120075, 6058.939410605837, 6073.544484163794, 6131.96934015327, 6132.724027418688, 6162.383761623802, 5793.826185214451, 6011.398860113954, 6025.698715064317, 6035.426634469718, 6062.939370606237], "value": 5694.0355068363315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.035338086993, 475.8501072162269, 515.0934355534259, 517.4230732733004, 556.457453982367, 29523.261918452023, 33001.83499082501, 37840.81079594602, 39119.41320880189, 40719.0, 39937.80031099848, 40279.0, 40371.798141009254, 40469.79765101178, 40491.59508404915, 9204.815903681922, 9359.859602105973, 9374.437533747998, 9377.156055954963, 9400.294977876687, 9241.353105282633, 9325.906740932573, 9349.719508414724, 9357.625694972226, 9362.204212641933, 9227.123423274777, 9334.953325233364, 9360.063993600654, 9385.671501497449, 9392.24862011041, 8637.179467950535, 9320.440773553608, 9331.440113593206, 9347.439153650803, 9352.251819854395, 9182.586783594754, 9187.219086377667, 9251.259899208047, 9255.861162082574, 9261.861072083924, 38552.22895542073, 38873.611263887564, 38903.41644875329, 39001.0, 39007.60992390068, 3251.4147453458368, 3253.3330667213163, 3268.6077670679433, 3525.2420729543273, 3892.2410130024655, 28993.56509652357, 29115.41769164605, 29144.70855291441, 29988.250293742614, 30322.696773032207, 3054.8472576371314, 3060.1431599152274, 3091.6444608870042, 3132.076037568923, 3166.0818362674795, 478014.0, 483547.0, 484810.0, 485514.0, 485655.0, 53327.466725333026, 53627.0, 53664.73167634137, 53704.46295537073, 53705.73147134239, 32898.342033159206, 33765.66234337625, 52806.73596632069, 52818.207726884124, 53000.0, 14260.073095248776, 14759.262036898112, 14774.63063423423, 14795.0, 14883.883708721889, 11100.500477478532, 11103.389313587668, 11141.554337826396, 11189.944050279697, 11195.048420884154, 15058.171800551076, 17709.02600356967, 17942.282308707505, 17943.910280448516, 17944.83358581688, 6583.473322134218, 7847.293743562993, 7857.428514297049, 7881.054273487218, 7925.445218834626, 707.952230698569, 896.408370475483, 932.5057719408725, 963.3593660215878, 1014.7919676466307, 28394.580270986782, 28461.0, 28834.27914302159, 28959.0, 29026.564601530994, 1011.4639241202175, 1032.5301987595626, 1047.1936608811172, 1056.8309070548828, 1210.2133613151523, 14310.928445357707, 14837.777433338508, 14865.182414967281, 14983.0, 15037.624059398384, 172288.0, 182676.0, 182816.0, 182958.08520957577, 183041.0, 54142.0, 54604.0, 54613.72693136509, 54642.45357546453, 54680.90638187214, 1215.6231568213882, 1258.710496585772, 1335.899807514421, 1339.0760375341179, 1370.8903287736957, 23568.764312356656, 28073.43853122967, 28749.85000600036, 29209.707902920698, 30083.69916300809, 46277.07445851131, 46555.30167047429, 46815.06369872652, 46871.29693054675, 46981.82545436391, 526787.0, 528960.0, 530975.0, 531347.0, 531816.0, 22267.0, 22850.31449056531, 24506.264812055666, 24655.506889861743, 25314.493710125327, 44318.892027698275, 44534.77732611316, 44646.55353446424, 44648.55351446444, 44841.0, 35048.824755876056, 35831.46252806262, 36909.26181476409, 37256.81371593125, 37444.06389840276, 35147.218275166575, 35177.0, 36246.27507449783, 36940.0, 37569.2486150281, 36047.0, 36077.81961090178, 36589.634103659686, 36656.81671591625, 36956.630433696395, 26785.598216027163, 31000.534991974688, 32919.67080329262, 32937.34125317432, 33040.50439243365, 24110.39724006914, 24479.51040979206, 24590.508189835746, 24933.625995609716, 25285.494290113726], "value": 18199.14922866283, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.35901940429613, 352.58042928914574, 371.7843650682606, 381.1728549048564, 403.0387525751083, 14302.713945721092, 14796.556103316905, 15404.306806193734, 19466.513337166543, 20174.092165852537, 19062.142203600837, 19311.613767724637, 20028.0, 20255.59488810223, 20266.088026038862, 5171.09505836479, 5468.1954954865, 5470.124780035195, 5485.0, 5489.286392768954, 4496.280595104784, 5366.624336296461, 5954.791582294621, 6002.2197114375285, 6023.3976602339635, 5969.492593129589, 5974.701264936757, 5975.193348897908, 5977.551683623724, 5984.251968503937, 5676.829695109132, 5888.263967004124, 5911.142884281755, 5916.792912248094, 5936.7328470218945, 5057.544820966131, 5165.302684137669, 5225.790968361261, 5235.240890070956, 5238.711870847102, 11627.534898604046, 12838.935805320914, 12985.610431687064, 13187.406566704522, 13213.603591892259, 1823.6261566378994, 1999.6800511918168, 2064.112431654388, 2068.4621998280404, 2562.6412302277695, 9673.806523869554, 10217.0, 10276.332038417553, 10465.0, 12118.272903625722, 1755.9824401756075, 1761.6036391811867, 1799.9910000450045, 1842.774554920976, 1847.7320788485729, 117154.0, 121558.17662735067, 125184.12223816558, 125655.11517327247, 126829.73170268271, 11061.336319820837, 11485.827712584318, 11549.0, 11601.245919015237, 11763.529458821551, 14669.853301466848, 14693.0, 14705.823534117246, 14707.779383309258, 14726.558203253919, 7812.726554570677, 8068.9596552016865, 8116.918830811735, 8193.549354785424, 8227.876581851277, 7078.0, 7149.96425017882, 7457.291557302047, 7727.265909738566, 7874.370050395954, 4451.888702782457, 4460.397846290709, 4476.493163828201, 4492.528284530077, 4548.226801443762, 1722.801877784071, 1840.613471171069, 1901.3250296144945, 1903.1245627011729, 1908.360699165795, 696.2271878215178, 741.210610699614, 809.4212637963884, 810.8135128920263, 919.9770005749909, 15941.202939852961, 16548.503544893672, 20453.0, 20620.175192992414, 21748.782512174676, 867.6312567158932, 870.2428886868465, 887.3625282884063, 945.5886689290181, 995.4176806568094, 9312.255019598417, 9616.95191524038, 11093.611723589636, 11183.496742646601, 11305.095592352593, 537472.0, 557027.0, 561748.0, 562493.0, 562765.0, 86650.70023949645, 118238.40880795714, 120933.0, 133139.33430332787, 141306.88039679412, 963.0, 986.6596024371723, 1009.4801177393648, 1012.0688966151158, 1013.1185868294631, 18372.35696750607, 19247.326343577908, 19555.946625604676, 19600.0, 19647.508812279237, 47852.0, 52520.0, 52924.47075529196, 54758.726206368716, 55227.44772552384, 81671.0, 81671.59164204141, 82390.0, 82815.0, 83118.0, 5435.755391007335, 7823.530588164728, 8117.025956885212, 8138.430309878252, 8170.42807003504, 12313.32276724753, 12766.29785361814, 12966.02754793413, 13021.088523803623, 13296.667583310107, 11012.843651416486, 11037.11703063769, 11173.329600224013, 11302.830457543309, 11456.312621242752, 10730.356178629307, 10923.289986150874, 11015.647904750842, 11282.379469128948, 11291.266067705574, 10107.292489525662, 10188.847167292348, 10435.426051566934, 11543.422828858691, 11664.94167529157, 7831.216878312123, 7854.015474119798, 7968.561729104955, 8271.421000529905, 8289.792755181168, 8279.834403312021, 9854.0, 10982.06652434552, 11377.43112844371, 11397.202195846212], "value": 9087.01016045356, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.6175801654545, 1449.0943160524669, 1594.4897632757522, 1750.221151587544, 1798.3346161920092, 7365.963170184142, 8077.555734434603, 8525.147485251471, 8533.146685331463, 8535.189157030089, 7440.181580026207, 7667.8849817252785, 7719.961400193005, 8029.558374289411, 8318.500889946607, 2196.9011394487247, 2231.984447076576, 2233.7542870284256, 2238.5858616155983, 2242.416971587391, 2313.571989181998, 2351.271105957159, 2359.7876191142796, 2369.751176126499, 2371.2174982255815, 2258.3450799268194, 2263.649134384173, 2283.178055899883, 2288.6109361408517, 2324.1168356024687, 2275.5562665280277, 2306.054517647765, 2308.2728940383727, 2309.5034567568055, 2311.3759284992957, 2318.5131122464304, 2352.882355882199, 2355.316958082154, 2356.0340260493117, 2357.4342157882156, 8316.625751841182, 8337.333013358917, 8403.873941890877, 8452.492850428995, 8455.281301089415, 5057.190849464068, 5215.921761173586, 5220.164773636238, 5226.81706140287, 5238.68567885928, 3215.778004358352, 3273.558069660613, 3497.0208341664375, 3535.6641119093647, 3537.823108844573, 1032.7573020340214, 1057.9788404231872, 1070.8072546941548, 1075.0324707762998, 1078.487718333793, 10520.316179448388, 10880.075193608553, 10886.72783180419, 10951.616693415692, 11121.610743623934, 4280.636145927631, 4370.694051416434, 4476.798544065525, 4503.549645035536, 4505.05393867285, 8699.260562852229, 8706.608202630898, 8707.216350528483, 8719.34604904622, 8724.825503490021, 5116.181410974301, 5116.565091967224, 5125.615578831528, 5126.461721519261, 5128.9230661540105, 3891.727579069438, 4227.8097485613225, 4766.833160839354, 4831.227003679464, 4834.8791280218275, 3306.8015919044933, 3371.763976521669, 3571.4642803579673, 3613.5663720353728, 3659.3779057560278, 1132.7904337697553, 1137.9317240965568, 1138.1407037686495, 1141.868685101224, 1149.3965668024186, 834.7662654456641, 841.6296829395046, 871.7254064969515, 897.1073781587362, 933.4725879877983, 5474.91787623186, 5675.57433192504, 5798.88402231953, 5799.0, 5870.207521984477, 863.2877875752404, 875.872998415239, 888.6356593796512, 905.9365844390829, 912.1289168843738, 3654.8903532894055, 3751.7373783835415, 3790.886273411802, 3828.425736139601, 3865.246276976019, 9993.250506212064, 10239.232057595711, 10285.845712314322, 10349.223808214414, 10361.63734269312, 8728.825423491495, 10295.742606434898, 10304.587816487257, 10306.845397319046, 10319.948400258101, 7786.649600767979, 7941.126476087626, 7943.324817390587, 7947.245011723877, 7971.043474782947, 5276.182191760283, 5500.669959802264, 5556.416576259596, 5590.748416321194, 5596.720163991866, 9305.348625596143, 9535.809283814424, 9538.952305238707, 9552.092551207625, 9553.379030363005, 6931.549449285781, 9481.905180948102, 9491.477968711788, 9524.95237523808, 9661.806763864543, 6551.001944407001, 6758.966205168943, 6789.558678685869, 7041.5775053496955, 7218.530795498275, 7603.771886843404, 7716.996790417435, 7896.486728362638, 7961.601919903866, 7985.081715602548, 6991.44068474531, 7120.964395177991, 7136.964315178391, 7201.6399180041835, 7248.057752492142, 6769.593824370553, 6783.118194634666, 6984.650767461708, 7035.472339574655, 7042.471814613822, 6379.808605741835, 6546.345365463416, 6650.900236496554, 6742.426893713893, 6746.359095885883, 4821.95178048215, 4857.587105096107, 4930.309756634146, 4931.186354251652, 4997.675151115166, 4212.304969679968, 4746.359241502491, 4920.0, 4961.42943561495, 5026.978282855856], "value": 4363.504311689331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.98392096474214, 297.5804116196163, 298.9432007918497, 306.68564721160806, 309.0450507930494, 4811.3504676868615, 5050.8484745457645, 5173.680711418588, 5211.827338848757, 5242.475752424755, 3883.728139030269, 4682.742449165295, 5006.899862002758, 5089.46560611136, 5161.632167475613, 3195.8402079896027, 3624.5106910567133, 3934.9606503935024, 3999.340108882031, 4005.838306890998, 3969.24584328978, 3970.7419017763896, 3996.3605823068315, 3997.9800100999455, 4005.6595189408936, 3299.3668134273566, 3304.5208444775494, 3682.5638001179564, 3693.409054551272, 4001.9799901000456, 3336.382769187696, 3761.066368232769, 3951.209758048402, 3973.9006524836823, 3987.980060099681, 3416.641252668484, 3422.6309476209467, 3438.6905178534053, 3439.226174110805, 3442.7417943654327, 4155.252054630166, 4666.879948812295, 5069.363930756023, 5094.61790365724, 5124.948750512484, 3965.8413663453425, 3981.3629819228786, 4067.1662309226535, 4514.8194072237075, 4554.339620755005, 5295.602829787781, 5385.748894827512, 5483.287172667568, 5507.394186639466, 5515.628279839708, 3758.924821503582, 3764.0615083232155, 3766.8116594170183, 3775.320442320381, 3791.545014598266, 5306.52241298285, 5388.922215556904, 5638.520725738317, 5642.60189419491, 5681.545476361923, 3194.354907222782, 3224.5654530829543, 3447.2760720248525, 3812.561555421162, 3831.6743076838225, 3284.5730055092686, 3713.535808023997, 3837.3860182370686, 3851.422286657024, 3884.902877428087, 3773.2830762155104, 4344.500382455994, 4465.151621191963, 4469.608759313816, 4526.547345265447, 4421.248387774086, 4898.853034408973, 5497.972510137423, 5516.11114164513, 5576.498115169654, 1085.3976043295888, 1174.236746115015, 1252.2298786246392, 1253.229264002632, 1253.846461255647, 724.9891251631229, 801.0707579208091, 823.4112609484248, 828.5774255129927, 867.5381981361301, 3993.800309984489, 4286.663768246313, 4305.827766889352, 4603.723776573416, 4853.466118727008, 5230.869228269247, 5293.761780719799, 5296.629235953446, 5342.412334643186, 5454.118329176428, 3927.0, 4147.294959856831, 4488.304312831517, 4571.794269257892, 4863.465018847924, 2207.3708992936936, 2347.955159953838, 2448.559259333337, 2464.383904023994, 2823.9858800705865, 4691.413573303337, 5432.70120143388, 5456.536194423439, 5468.234447177399, 5562.4425160955, 4428.446444194476, 4491.595756381876, 4900.387451568554, 5017.795729025008, 5313.681179129265, 4745.857624271277, 4957.90084198314, 5363.069295053778, 5478.5211390767945, 5544.615815199503, 4288.421063156434, 4473.776311184492, 4615.538446155358, 4687.460941991714, 4890.339804126397, 5162.6902385856965, 5171.3018742469285, 5638.379778224474, 5656.406077361818, 5724.942750572441, 5477.424870388551, 5930.584859059824, 5972.790952316648, 6008.429199226067, 6013.849653758691, 3553.0406790167026, 3560.5935655416483, 3865.424482353755, 3876.4960555127655, 3910.3743401055694, 4481.350204220435, 4776.0, 5150.896982060262, 5401.297831281908, 5599.860003499782, 4915.926261106158, 5187.58499320061, 5510.944890551204, 5522.530584900329, 5618.297712785902, 4658.53414658545, 5133.947540754062, 5171.974140129275, 5434.673919564839, 5595.63628364155, 4290.3993440917675, 5088.542031217208, 5380.0, 5436.293281873332, 5454.890902182014, 5359.275303663916, 5388.11416004411, 5430.538404235526, 5581.860453488695, 5582.944170558405, 4586.706646676662, 4785.243583786711, 5496.120620700669, 5518.392976772632, 5522.337319521683], "value": 3857.973113241092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.2183176673891, 720.4812534974816, 724.1021133794097, 725.2095216214327, 737.5943231222826, 12641.747165056693, 13410.731785364287, 13422.731545369112, 13429.127106738055, 13429.731405371898, 12440.688982775435, 12565.05762067844, 12593.118481706262, 13242.867571324285, 13811.37848796804, 801.0227522422636, 823.3372135430976, 824.1017291152642, 826.1738261738262, 828.4821986258588, 818.0837462042521, 819.0744458761591, 820.5281962871343, 821.1296026212204, 825.3026192867047, 866.7963028688254, 867.037588277012, 868.6395146014428, 868.9702702297798, 871.8256348730248, 864.788126908905, 865.9826803463895, 866.5060915278294, 866.8526350520426, 867.397158974513, 642.5502148496072, 644.3749562923956, 644.9290578036412, 646.5635695905293, 647.3591144766694, 13437.664058398619, 13440.462381504729, 13442.19346839183, 13451.529196478174, 13469.259190744506, 11915.761684766343, 12106.878931210664, 12109.333986630732, 12169.20900141488, 12310.692232694255, 10113.595456181743, 10142.645007424779, 10282.588696452207, 10484.423356715377, 10556.894431055667, 3408.5739282589675, 3445.260143627477, 3469.0, 3559.056849934769, 3570.9285814283567, 86560.0, 90682.0, 91118.54440727754, 91540.0, 92700.0, 9051.411658242194, 9158.267338612895, 9311.348205625542, 9317.44095354281, 9391.060893910555, 17784.46646600604, 18807.623847522973, 18814.717779233324, 18860.717089243673, 18866.905665471586, 6962.756303529352, 6968.512204145763, 7016.5790052597, 7024.964875175694, 7201.243869393743, 3879.9030024249055, 3892.143728379752, 3895.2599006188734, 3947.1908258806875, 4066.5933406659096, 3148.511980643004, 3212.5020621803656, 3243.367543329028, 3246.0910944935454, 3249.415105281072, 536.9838904832861, 596.2755252368306, 601.035338282051, 618.0482057631198, 619.1115748900343, 566.963147395418, 567.2087438023933, 575.1085816983658, 591.5740666719955, 671.4024518178825, 7978.162292959272, 8290.626921788535, 8313.667453301921, 8586.48481091124, 8586.699465518677, 578.9334226563999, 616.0389791924612, 627.4321738826369, 631.4159402552621, 659.1200747002805, 3527.7530572859655, 3946.7631942082994, 4091.4067460218102, 4142.834286628561, 4191.872111703962, 73405.26594733984, 73549.6322518384, 73979.89030164552, 89517.0, 98384.0, 64406.71186576242, 69832.6508367455, 74212.0, 89569.55215223882, 90395.0, 82276.58861705654, 82315.58842205751, 84322.57838710767, 84654.0, 86112.56943715242, 9126.406783559047, 9571.0, 9576.856347154659, 9585.856212156683, 9749.658761943298, 36519.0, 43364.78317608518, 53153.202701960276, 53191.734041329546, 54335.0, 70130.64934675497, 73290.26709732834, 74070.0, 74169.14577135615, 75784.0, 10119.433662931557, 10983.39591322485, 11684.70044758137, 11836.467358968695, 12444.937775311066, 13033.218006919615, 13166.341682915625, 13305.201687898758, 13694.63376263907, 14072.78890816659, 12301.44643491027, 12357.352137855618, 12392.938035310126, 12515.120312703091, 12521.311327877054, 11803.940980295043, 12107.213031152947, 12629.11596188258, 12689.746205076031, 12831.10182287231, 12241.755164896831, 12405.689857753629, 12544.0, 12644.557440489538, 12706.30115343665, 10495.10791582724, 10657.360558366523, 10819.621313253998, 10824.954284836478, 11385.259958102697, 8259.504429733995, 8865.0, 10771.291215655716, 11052.0, 11065.557377705123], "value": 6877.798310340634, "unit": "score"}], "name": "dromaeo_css", "value": 6911.8941559640125, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 112.0, 113.0, 115.0, 113.0, 113.0, 114.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 110.0, 113.0, 171.0, 141.0, 100.0, 131.0, 142.0, 173.0, 115.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 181.0, 184.0, 183.0, 182.0, 179.0, 181.0, 181.0], "value": 182.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 59.0, 88.0, 60.0, 59.0, 59.0, 59.0, 83.0, 58.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 92.0, 72.0, 69.0, 69.0, 90.0, 67.0, 70.0, 97.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 85.0, 91.0, 86.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 79.0, 81.0, 82.0, 84.0, 82.0, 84.0, 80.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 56.0, 54.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 75.0, 72.0, 73.0, 72.0, 69.0, 73.0, 70.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 90.0, 86.0, 90.0, 87.0, 83.0, 92.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 160.0, 155.0, 143.0, 148.0, 146.0, 151.0, 151.0, 209.0, 155.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 239.0, 177.0, 171.0, 175.0, 175.0, 173.0, 173.0, 174.0, 172.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 68.0, 68.0, 68.0, 68.0, 70.0, 61.0, 57.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1458.6000000000004, "alertThreshold": 2.0}]} 05:59:26 INFO - Return code: 0 05:59:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:59:26 INFO - # TBPL SUCCESS # 05:59:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:26 INFO - 2016-11-15 05:59:26.315 screenresolution[1653:9827] starting screenresolution argv=screenresolution get 05:59:26 INFO - 2016-11-15 05:59:26.318 screenresolution[1653:9827] Display 0: 1600x1200x32@60 05:59:26 INFO - 2016-11-15 05:59:26.324 screenresolution[1654:9830] starting screenresolution argv=screenresolution list 05:59:26 INFO - Available Modes on Display 0 05:59:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:26 INFO - Intel Iris: 05:59:26 INFO - Chipset Model: Intel Iris 05:59:26 INFO - Type: GPU 05:59:26 INFO - Bus: Built-In 05:59:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:26 INFO - Vendor: Intel (0x8086) 05:59:26 INFO - Device ID: 0x0a2e 05:59:26 INFO - Revision ID: 0x0009 05:59:26 INFO - Displays: 05:59:26 INFO - Display: 05:59:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:26 INFO - Display Serial Number: 1600x1200 60 05:59:26 INFO - Main Display: Yes 05:59:26 INFO - Mirror: Off 05:59:26 INFO - Online: Yes 05:59:26 INFO - Rotation: Supported 05:59:26 INFO - Return code: 0 05:59:26 INFO - Running post-action listener: _resource_record_post_action 05:59:26 INFO - [mozharness: 2016-11-15 13:59:26.566915Z] Finished run-tests step (success) 05:59:26 INFO - Running post-run listener: _resource_record_post_run 05:59:26 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 36348928; Write bytes: 696834560; Read time: 236; Write time: 1970 05:59:26 INFO - TinderboxPrint: CPU usage
53.6% 05:59:26 INFO - TinderboxPrint: I/O read bytes / time
36,348,928 / 236 05:59:26 INFO - TinderboxPrint: I/O write bytes / time
696,834,560 / 1,970 05:59:26 INFO - TinderboxPrint: CPU idle
2,253.8 (46.4%) 05:59:26 INFO - TinderboxPrint: CPU system
969.6 (20.0%) 05:59:26 INFO - TinderboxPrint: CPU user
1,630.2 (33.6%) 05:59:26 INFO - TinderboxPrint: Swap in / out
435,286,016 / 0 05:59:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 393959936; Write bytes: 388306944; Read time: 29649; Write time: 831 05:59:26 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34280448; Write bytes: 293342208; Read time: 219; Write time: 1101 05:59:27 INFO - Running post-run listener: _upload_blobber_files 05:59:27 INFO - Blob upload gear active. 05:59:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:59:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:59:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:59:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:28 INFO - (blobuploader) - INFO - Done attempting. 05:59:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:59:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:59:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:29 INFO - (blobuploader) - INFO - Done attempting. 05:59:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:59:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:32 INFO - (blobuploader) - INFO - Done attempting. 05:59:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:32 INFO - Return code: 0 05:59:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db94e37ff84ca30fbf9acc3704e27e71e427eb7767ba073f72975ceeb2b41efefa3cd917eecc13bc9ddba716a4c4fc4ec0fbdca21ae25e1fcb7a5fd5ceba3028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89fb85e6e1463bb52e7ba44826169ddffc57b29bb446bd0c0acd156f967324039968f903241b292718e09e14c089dcdc34242356ada5cc8bb09d9eadabe23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a75315107bd19776bfd13752602e05ee6169644e480582af947960f838ef02c33d3d6217414fd475fcc6c6b8eea84f02b18a342576e7cf8f254c53d4f3359"} 05:59:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:32 INFO - Contents: 05:59:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db94e37ff84ca30fbf9acc3704e27e71e427eb7767ba073f72975ceeb2b41efefa3cd917eecc13bc9ddba716a4c4fc4ec0fbdca21ae25e1fcb7a5fd5ceba3028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89fb85e6e1463bb52e7ba44826169ddffc57b29bb446bd0c0acd156f967324039968f903241b292718e09e14c089dcdc34242356ada5cc8bb09d9eadabe23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a75315107bd19776bfd13752602e05ee6169644e480582af947960f838ef02c33d3d6217414fd475fcc6c6b8eea84f02b18a342576e7cf8f254c53d4f3359"} 05:59:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:32 INFO - Copying logs to upload dir... 05:59:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.420933 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-15 05:59:32.357791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 05:59:32.361169) ========= 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.vJtMKzMxFH/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.Iock0vozty/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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/db94e37ff84ca30fbf9acc3704e27e71e427eb7767ba073f72975ceeb2b41efefa3cd917eecc13bc9ddba716a4c4fc4ec0fbdca21ae25e1fcb7a5fd5ceba3028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89fb85e6e1463bb52e7ba44826169ddffc57b29bb446bd0c0acd156f967324039968f903241b292718e09e14c089dcdc34242356ada5cc8bb09d9eadabe23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a75315107bd19776bfd13752602e05ee6169644e480582af947960f838ef02c33d3d6217414fd475fcc6c6b8eea84f02b18a342576e7cf8f254c53d4f3359"} build_url:https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/MSUF0gk3TdSTv-5o7K3xAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db94e37ff84ca30fbf9acc3704e27e71e427eb7767ba073f72975ceeb2b41efefa3cd917eecc13bc9ddba716a4c4fc4ec0fbdca21ae25e1fcb7a5fd5ceba3028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90b89fb85e6e1463bb52e7ba44826169ddffc57b29bb446bd0c0acd156f967324039968f903241b292718e09e14c089dcdc34242356ada5cc8bb09d9eadabe23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8a75315107bd19776bfd13752602e05ee6169644e480582af947960f838ef02c33d3d6217414fd475fcc6c6b8eea84f02b18a342576e7cf8f254c53d4f3359"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 05:59:32.395382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 05:59:32.395697) ========= 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.vJtMKzMxFH/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.Iock0vozty/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.005318 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 05:59:32.443602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 05:59:32.443916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 05:59:32.444250) ========= ========= Total master_lag: 0.34 =========