builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0090 starttime: 1479044409.5 results: success (0) buildid: 20161113030203 builduid: 84e81a3769dd4dc6b6c6e565bb8d40a8 revision: b37be3d705d929ee52280051d58cedc70a47626f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:09.504998) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:09.505417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:09.505690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:09.530383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:09.530646) ========= 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.krNQlpfC37/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.UyClrowAAD/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-13 05:40:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2016-11-13 05:40:10 (13.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.623662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:10.174395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:10.175117) ========= 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.krNQlpfC37/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.UyClrowAAD/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.023856 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:10.223785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 05:40:10.224144) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b37be3d705d929ee52280051d58cedc70a47626f --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 b37be3d705d929ee52280051d58cedc70a47626f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.krNQlpfC37/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.UyClrowAAD/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-13 05:40:10,306 truncating revision to first 12 chars 2016-11-13 05:40:10,306 Setting DEBUG logging. 2016-11-13 05:40:10,306 attempt 1/10 2016-11-13 05:40:10,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b37be3d705d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-13 05:40:11,125 unpacking tar archive at: mozilla-central-b37be3d705d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.081475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-13 05:40:11.327758) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:11.328151) ========= script_repo_revision: b37be3d705d929ee52280051d58cedc70a47626f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:11.328607) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:11.328935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 05:40:11.347738) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-13 05:40:11.348212) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.krNQlpfC37/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.UyClrowAAD/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40:11 INFO - MultiFileLogger online at 20161113 05:40:11 in /builds/slave/test 05:40:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:40:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:40:11 INFO - {'append_to_log': False, 05:40:11 INFO - 'base_work_dir': '/builds/slave/test', 05:40:11 INFO - 'blob_upload_branch': 'Firefox', 05:40:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:40:11 INFO - 'branch': 'Firefox', 05:40:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:11 INFO - 'config_files': ('talos/mac_config.py',), 05:40:11 INFO - 'default_actions': ('clobber', 05:40:11 INFO - 'read-buildbot-config', 05:40:11 INFO - 'download-and-extract', 05:40:11 INFO - 'populate-webroot', 05:40:11 INFO - 'create-virtualenv', 05:40:11 INFO - 'install', 05:40:11 INFO - 'run-tests'), 05:40:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:11 INFO - 'download_minidump_stackwalk': True, 05:40:11 INFO - 'download_symbols': 'ondemand', 05:40:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:11 INFO - 'installer_path': 'installer.exe', 05:40:11 INFO - 'log_level': 'info', 05:40:11 INFO - 'log_name': 'talos', 05:40:11 INFO - 'log_to_console': True, 05:40:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:40:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:40:11 INFO - 'opt_config_files': (), 05:40:11 INFO - 'pip_index': False, 05:40:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:40:11 INFO - 'cmd': ('bash', 05:40:11 INFO - '-c', 05:40:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:40:11 INFO - 'enabled': True, 05:40:11 INFO - 'halt_on_failure': False, 05:40:11 INFO - 'name': 'check_screen_resolution'},), 05:40:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:40:11 INFO - 'cmd': ('bash', 05:40:11 INFO - '-c', 05:40:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:40:11 INFO - 'enabled': True, 05:40:11 INFO - 'halt_on_failure': False, 05:40:11 INFO - 'name': 'check_screen_resolution'},), 05:40:11 INFO - 'run_cmd_checks_enabled': True, 05:40:11 INFO - 'sps_profile': False, 05:40:11 INFO - 'sps_profile_interval': 0, 05:40:11 INFO - 'suite': 'dromaeojs-e10s', 05:40:11 INFO - 'system_bits': '32', 05:40:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:11 INFO - 'title': 't-yosemite-r7-0090', 05:40:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:11 INFO - 'use_talos_json': True, 05:40:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:40:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:11 INFO - 'work_dir': 'build'} 05:40:11 INFO - [mozharness: 2016-11-13 13:40:11.559709Z] Running clobber step. 05:40:11 INFO - Running pre-action listener: _resource_record_pre_action 05:40:11 INFO - Running main action method: clobber 05:40:11 INFO - rmtree: /builds/slave/test/build 05:40:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:40:13 INFO - Running post-action listener: _resource_record_post_action 05:40:13 INFO - [mozharness: 2016-11-13 13:40:13.792078Z] Finished clobber step (success) 05:40:13 INFO - [mozharness: 2016-11-13 13:40:13.792239Z] Running read-buildbot-config step. 05:40:13 INFO - Running pre-action listener: _resource_record_pre_action 05:40:13 INFO - Running main action method: read_buildbot_config 05:40:13 INFO - Using buildbot properties: 05:40:13 INFO - { 05:40:13 INFO - "project": "", 05:40:13 INFO - "product": "firefox", 05:40:13 INFO - "script_repo_revision": "production", 05:40:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:40:13 INFO - "repository": "", 05:40:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:40:13 INFO - "buildid": "20161113030203", 05:40:13 INFO - "stage_platform": "macosx64", 05:40:13 INFO - "basedir": "/builds/slave/test", 05:40:13 INFO - "nightly_build": "True", 05:40:13 INFO - "buildnumber": 18, 05:40:13 INFO - "slavename": "t-yosemite-r7-0090", 05:40:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:40:13 INFO - "platform": "yosemite_r7", 05:40:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:40:13 INFO - "branch": "mozilla-central", 05:40:13 INFO - "repo_path": "mozilla-central", 05:40:13 INFO - "revision": "b37be3d705d929ee52280051d58cedc70a47626f", 05:40:13 INFO - "pgo_build": "False", 05:40:13 INFO - "builduid": "84e81a3769dd4dc6b6c6e565bb8d40a8", 05:40:13 INFO - "slavebuilddir": "test" 05:40:13 INFO - } 05:40:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:40:13 INFO - Running post-action listener: _resource_record_post_action 05:40:13 INFO - [mozharness: 2016-11-13 13:40:13.795899Z] Finished read-buildbot-config step (success) 05:40:13 INFO - [mozharness: 2016-11-13 13:40:13.796039Z] Running download-and-extract step. 05:40:13 INFO - Running pre-action listener: _resource_record_pre_action 05:40:13 INFO - Running main action method: download_and_extract 05:40:13 INFO - mkdir: /builds/slave/test/build/tests 05:40:13 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:40:13 INFO - trying https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:40:13 INFO - Downloading https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:40:15 INFO - Downloaded 1199 bytes. 05:40:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:40:15 INFO - Using the following test package requirements: 05:40:15 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:40:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:40:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:40:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'jsshell-mac.zip'], 05:40:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:40:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:40:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:40:15 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:40:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:40:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:15 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:40:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:40:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:40:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:40:15 INFO - Fetch https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:40:15 INFO - Http code: 200 05:40:15 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 05:40:15 INFO - x-amz-cf-id: 3NWEMiQ-0TtlEwsNdmzT9hG1XR1kRd257fHt4gxIWDWfZeKKdF_Gfw== 05:40:15 INFO - x-amz-version-id: kKghIzXxzi3Iw.8BH33nXicn4JySG8OE 05:40:16 INFO - Expected file size: 16334036 05:40:16 INFO - Obtained file size: 16334036 05:40:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:40:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:40:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:40:23 INFO - Fetch https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:40:23 INFO - Http code: 200 05:40:23 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 05:40:23 INFO - x-amz-cf-id: 9m5pu2clVbtAv4wi7wFdZ3eYSL4rlJnyCevU8PfJA_uIq3Z4YcT3mw== 05:40:23 INFO - x-amz-version-id: kKghIzXxzi3Iw.8BH33nXicn4JySG8OE 05:40:24 INFO - Expected file size: 16334036 05:40:24 INFO - Obtained file size: 16334036 05:40:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:40:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:40:30 INFO - Fetch https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:40:31 INFO - Http code: 200 05:40:31 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 05:40:31 INFO - x-amz-cf-id: 5y1BWOYnUULDaLlfc_-mURs53M6fsn_IyZpdFB-15LT4OYnqyoHYYg== 05:40:31 INFO - x-amz-version-id: T12vAw7r7ptrY1wPH21l8FvnrM1ZQ4Ow 05:40:32 INFO - Expected file size: 14409038 05:40:32 INFO - Obtained file size: 14409038 05:40:32 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:40:32 INFO - trying https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:32 INFO - Downloading https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:40:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:40:35 INFO - Downloaded 111216907 bytes. 05:40:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:35 INFO - mkdir: /builds/slave/test/properties 05:40:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:35 INFO - Contents: 05:40:35 INFO - build_url:https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:35 INFO - Running post-action listener: _resource_record_post_action 05:40:35 INFO - Running post-action listener: set_extra_try_arguments 05:40:35 INFO - [mozharness: 2016-11-13 13:40:35.863313Z] Finished download-and-extract step (success) 05:40:35 INFO - [mozharness: 2016-11-13 13:40:35.863435Z] Running populate-webroot step. 05:40:35 INFO - Running pre-action listener: _resource_record_pre_action 05:40:35 INFO - Running main action method: populate_webroot 05:40:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:35 INFO - '--tppagecycles', 05:40:35 INFO - '7'], 05:40:35 INFO - 'tests': ['tsvgm']}}, 05:40:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['damp', 'tps']}, 05:40:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'tests': ['damp', 'tps']}, 05:40:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['dromaeo_dom']}, 05:40:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['basic_compositor_video']}, 05:40:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:40:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['a11yr', 05:40:35 INFO - 'ts_paint', 05:40:35 INFO - 'tpaint', 05:40:35 INFO - 'sessionrestore', 05:40:35 INFO - 'sessionrestore_no_auto_restore', 05:40:35 INFO - 'tabpaint']}, 05:40:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:35 INFO - 'ts_paint', 05:40:35 INFO - 'tpaint', 05:40:35 INFO - 'sessionrestore', 05:40:35 INFO - 'sessionrestore_no_auto_restore', 05:40:35 INFO - 'tabpaint']}, 05:40:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:35 INFO - 'ts_paint', 05:40:35 INFO - 'tpaint', 05:40:35 INFO - 'sessionrestore', 05:40:35 INFO - 'sessionrestore_no_auto_restore', 05:40:35 INFO - 'tabpaint']}, 05:40:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:35 INFO - 'ts_paint', 05:40:35 INFO - 'tpaint', 05:40:35 INFO - 'sessionrestore', 05:40:35 INFO - 'sessionrestore_no_auto_restore', 05:40:35 INFO - 'tabpaint']}, 05:40:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['a11yr', 05:40:35 INFO - 'ts_paint', 05:40:35 INFO - 'tpaint', 05:40:35 INFO - 'sessionrestore', 05:40:35 INFO - 'sessionrestore_no_auto_restore', 05:40:35 INFO - 'tabpaint']}, 05:40:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['a11yr', 05:40:35 INFO - 'ts_paint', 05:40:35 INFO - 'tpaint', 05:40:35 INFO - 'sessionrestore', 05:40:35 INFO - 'sessionrestore_no_auto_restore', 05:40:35 INFO - 'tabpaint']}, 05:40:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['tsvgx', 05:40:35 INFO - 'tsvgr_opacity', 05:40:35 INFO - 'tart', 05:40:35 INFO - 'tscrollx', 05:40:35 INFO - 'cart']}, 05:40:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:35 INFO - 'tsvgr_opacity', 05:40:35 INFO - 'tart', 05:40:35 INFO - 'tscrollx', 05:40:35 INFO - 'cart']}, 05:40:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'talos_options': ['--disable-e10s'], 05:40:35 INFO - 'tests': ['tp5o']}, 05:40:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'tests': ['tp5o']}, 05:40:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'talos_options': ['--disable-e10s', 05:40:35 INFO - '--xperf_path', 05:40:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:35 INFO - 'tests': ['tp5n']}, 05:40:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:35 INFO - 'talos_options': ['--xperf_path', 05:40:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:35 INFO - 'tests': ['tp5n']}}, 05:40:35 INFO - 'talos.zip': {'path': '', 05:40:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:35 INFO - Running post-action listener: _resource_record_post_action 05:40:35 INFO - [mozharness: 2016-11-13 13:40:35.881977Z] Finished populate-webroot step (success) 05:40:35 INFO - [mozharness: 2016-11-13 13:40:35.882080Z] Running create-virtualenv step. 05:40:35 INFO - Running pre-action listener: _resource_record_pre_action 05:40:35 INFO - Running main action method: create_virtualenv 05:40:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:35 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:40:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:36 INFO - Using real prefix '/tools/python27' 05:40:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:39 INFO - Installing pip.................done. 05:40:39 INFO - Return code: 0 05:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:40:39 INFO - Reading from file tmpfile_stdout 05:40:39 INFO - Output received: 05:40:39 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:40:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40:39 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:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40:39 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:40:39 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:40:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:40:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:39 INFO - 'HOME': '/Users/cltbld', 05:40:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:39 INFO - 'LOGNAME': 'cltbld', 05:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:39 INFO - 'MOZ_NO_REMOTE': '1', 05:40:39 INFO - 'NO_EM_RESTART': '1', 05:40:39 INFO - 'PAGER': '/bin/cat', 05:40:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:39 INFO - 'PWD': '/builds/slave/test', 05:40:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:39 INFO - 'SHELL': '/bin/bash', 05:40:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:40:39 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:40:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:39 INFO - 'USER': 'cltbld', 05:40:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:39 INFO - 'XPC_FLAGS': '0x0', 05:40:39 INFO - 'XPC_SERVICE_NAME': '0', 05:40:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:40 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:40:40 INFO - Cleaning up... 05:40:40 INFO - Return code: 0 05:40:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40:40 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:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:40 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:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:40 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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40:40 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:40:40 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:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:40 INFO - 'HOME': '/Users/cltbld', 05:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:40 INFO - 'LOGNAME': 'cltbld', 05:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:40 INFO - 'MOZ_NO_REMOTE': '1', 05:40:40 INFO - 'NO_EM_RESTART': '1', 05:40:40 INFO - 'PAGER': '/bin/cat', 05:40:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:40 INFO - 'PWD': '/builds/slave/test', 05:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:40 INFO - 'SHELL': '/bin/bash', 05:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:40:40 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:40 INFO - 'USER': 'cltbld', 05:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:40 INFO - 'XPC_FLAGS': '0x0', 05:40:40 INFO - 'XPC_SERVICE_NAME': '0', 05:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:40 INFO - Downloading/unpacking psutil>=3.1.1 05:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:44 INFO - Installing collected packages: psutil 05:40:44 INFO - Running setup.py install for psutil 05:40:44 INFO - building 'psutil._psutil_osx' extension 05:40:44 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:40:44 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:40:44 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:40:45 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:40:45 INFO - building 'psutil._psutil_posix' extension 05:40:45 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:40:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:40:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:40:45 INFO - ^ 05:40:45 INFO - 1 warning generated. 05:40:45 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:40:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:45 INFO - Successfully installed psutil 05:40:45 INFO - Cleaning up... 05:40:45 INFO - Return code: 0 05:40:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:45 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:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:45 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:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:45 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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40:45 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:40:45 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:40:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:40:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:45 INFO - 'HOME': '/Users/cltbld', 05:40:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:45 INFO - 'LOGNAME': 'cltbld', 05:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:45 INFO - 'MOZ_NO_REMOTE': '1', 05:40:45 INFO - 'NO_EM_RESTART': '1', 05:40:45 INFO - 'PAGER': '/bin/cat', 05:40:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:45 INFO - 'PWD': '/builds/slave/test', 05:40:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:45 INFO - 'SHELL': '/bin/bash', 05:40:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:40:45 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:40:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:45 INFO - 'USER': 'cltbld', 05:40:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:45 INFO - 'XPC_FLAGS': '0x0', 05:40:45 INFO - 'XPC_SERVICE_NAME': '0', 05:40:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:48 INFO - Installing collected packages: mozsystemmonitor 05:40:48 INFO - Running setup.py install for mozsystemmonitor 05:40:48 INFO - Successfully installed mozsystemmonitor 05:40:48 INFO - Cleaning up... 05:40:48 INFO - Return code: 0 05:40:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40: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:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', '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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:40: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 jsonschema==2.5.1 05:40:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:40:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:48 INFO - 'HOME': '/Users/cltbld', 05:40:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:48 INFO - 'LOGNAME': 'cltbld', 05:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:48 INFO - 'MOZ_NO_REMOTE': '1', 05:40:48 INFO - 'NO_EM_RESTART': '1', 05:40:48 INFO - 'PAGER': '/bin/cat', 05:40:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:48 INFO - 'PWD': '/builds/slave/test', 05:40:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:48 INFO - 'SHELL': '/bin/bash', 05:40:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:40:48 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:40:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:48 INFO - 'USER': 'cltbld', 05:40:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:48 INFO - 'XPC_FLAGS': '0x0', 05:40:48 INFO - 'XPC_SERVICE_NAME': '0', 05:40:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:48 INFO - Downloading/unpacking jsonschema==2.5.1 05:40:48 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:40:48 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:40:48 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:40:48 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:40:48 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:40:48 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:40:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:51 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:40:51 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:40:51 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:40:51 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:40:51 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:40:51 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:40:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:51 INFO - warning: no files found matching '*.txt' 05:40:51 INFO - no previously-included directories found matching 'build' 05:40:51 INFO - no previously-included directories found matching 'dist' 05:40:51 INFO - no previously-included directories found matching '.git*' 05:40:51 INFO - Installing collected packages: jsonschema, functools32 05:40:51 INFO - Running setup.py install for functools32 05:40:52 INFO - warning: no files found matching '*.txt' 05:40:52 INFO - no previously-included directories found matching 'build' 05:40:52 INFO - no previously-included directories found matching 'dist' 05:40:52 INFO - no previously-included directories found matching '.git*' 05:40:52 INFO - Successfully installed jsonschema functools32 05:40:52 INFO - Cleaning up... 05:40:52 INFO - Return code: 0 05:40:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:52 INFO - 'HOME': '/Users/cltbld', 05:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:52 INFO - 'LOGNAME': 'cltbld', 05:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:52 INFO - 'MOZ_NO_REMOTE': '1', 05:40:52 INFO - 'NO_EM_RESTART': '1', 05:40:52 INFO - 'PAGER': '/bin/cat', 05:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:52 INFO - 'PWD': '/builds/slave/test', 05:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:52 INFO - 'SHELL': '/bin/bash', 05:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:40:52 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:52 INFO - 'USER': 'cltbld', 05:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:52 INFO - 'XPC_FLAGS': '0x0', 05:40:52 INFO - 'XPC_SERVICE_NAME': '0', 05:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:40:52 INFO - Cleaning up... 05:40:52 INFO - Return code: 0 05:40:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:52 INFO - 'HOME': '/Users/cltbld', 05:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:52 INFO - 'LOGNAME': 'cltbld', 05:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:52 INFO - 'MOZ_NO_REMOTE': '1', 05:40:52 INFO - 'NO_EM_RESTART': '1', 05:40:52 INFO - 'PAGER': '/bin/cat', 05:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:52 INFO - 'PWD': '/builds/slave/test', 05:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:52 INFO - 'SHELL': '/bin/bash', 05:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:40:52 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:52 INFO - 'USER': 'cltbld', 05:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:52 INFO - 'XPC_FLAGS': '0x0', 05:40:52 INFO - 'XPC_SERVICE_NAME': '0', 05:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:40: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:40: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:40: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:40: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:40: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:40: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:40:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40: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:40: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:40: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:40: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:40: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:40: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:40:56 INFO - Downloading docopt-0.6.1.tar.gz 05:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:56 INFO - Running setup.py install for blobuploader 05:40:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:56 INFO - Running setup.py install for requests 05:40:57 INFO - Running setup.py install for docopt 05:40:57 INFO - Successfully installed blobuploader requests docopt 05:40:57 INFO - Cleaning up... 05:40:57 INFO - Return code: 0 05:40:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:40:57 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:40:57 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:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:57 INFO - 'HOME': '/Users/cltbld', 05:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:57 INFO - 'LOGNAME': 'cltbld', 05:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:57 INFO - 'MOZ_NO_REMOTE': '1', 05:40:57 INFO - 'NO_EM_RESTART': '1', 05:40:57 INFO - 'PAGER': '/bin/cat', 05:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:57 INFO - 'PWD': '/builds/slave/test', 05:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:57 INFO - 'SHELL': '/bin/bash', 05:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:40:57 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:57 INFO - 'USER': 'cltbld', 05:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:57 INFO - 'XPC_FLAGS': '0x0', 05:40:57 INFO - 'XPC_SERVICE_NAME': '0', 05:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:57 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-971p_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:57 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-cHl4Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:57 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-lJh4gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-1iKT6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-bMDbn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-vjn3jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-JamS_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-7KWlAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Mr_Xrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-q79zbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-JbTEJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-XwfuBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:58 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-p7bdoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-izaNSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hFkJ5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-lsXdXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-zQ_k6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:59 INFO - Running setup.py install for manifestparser 05:40:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:59 INFO - Running setup.py install for mozcrash 05:40:59 INFO - Running setup.py install for mozdebug 05:40:59 INFO - Running setup.py install for mozdevice 05:41:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozfile 05:41:00 INFO - Running setup.py install for mozhttpd 05:41:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozinfo 05:41:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozInstall 05:41:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozleak 05:41:00 INFO - Running setup.py install for mozlog 05:41:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for moznetwork 05:41:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Running setup.py install for mozprocess 05:41:01 INFO - Running setup.py install for mozprofile 05:41:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Running setup.py install for mozrunner 05:41:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Running setup.py install for mozscreenshot 05:41:01 INFO - Running setup.py install for moztest 05:41:01 INFO - Running setup.py install for mozversion 05:41:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:02 INFO - Cleaning up... 05:41:02 INFO - Return code: 0 05:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:02 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:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 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:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:41:02 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:41:02 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:41:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:41:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:02 INFO - 'HOME': '/Users/cltbld', 05:41:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:02 INFO - 'LOGNAME': 'cltbld', 05:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:02 INFO - 'MOZ_NO_REMOTE': '1', 05:41:02 INFO - 'NO_EM_RESTART': '1', 05:41:02 INFO - 'PAGER': '/bin/cat', 05:41:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:02 INFO - 'PWD': '/builds/slave/test', 05:41:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:02 INFO - 'SHELL': '/bin/bash', 05:41:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:41:02 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:41:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:02 INFO - 'USER': 'cltbld', 05:41:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:02 INFO - 'XPC_FLAGS': '0x0', 05:41:02 INFO - 'XPC_SERVICE_NAME': '0', 05:41:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-H5Awtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-VVv8pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-2f4Pje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-abQr11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-52SOlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rofRoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:02 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:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Q_70gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-3e4TlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-F14yYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-zLko5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-WyuCpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-1WHZNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-AKavrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-GfIzpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-JAzK1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:03 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:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-wKdRbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:04 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:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-HPXsIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:04 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:41:04 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:41:04 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:41:04 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:41:04 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:41:04 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:41:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:06 INFO - Downloading blessings-1.6.tar.gz 05:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:06 INFO - Installing collected packages: blessings 05:41:06 INFO - Running setup.py install for blessings 05:41:06 INFO - Successfully installed blessings 05:41:06 INFO - Cleaning up... 05:41:07 INFO - Return code: 0 05:41:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:07 INFO - Reading from file tmpfile_stdout 05:41:07 INFO - Current package versions: 05:41:07 INFO - blessings == 1.6 05:41:07 INFO - blobuploader == 1.2.4 05:41:07 INFO - docopt == 0.6.1 05:41:07 INFO - functools32 == 3.2.3-2 05:41:07 INFO - jsonschema == 2.5.1 05:41:07 INFO - manifestparser == 1.1 05:41:07 INFO - mozInstall == 1.12 05:41:07 INFO - mozcrash == 1.0 05:41:07 INFO - mozdebug == 0.1 05:41:07 INFO - mozdevice == 0.48 05:41:07 INFO - mozfile == 1.2 05:41:07 INFO - mozhttpd == 0.7 05:41:07 INFO - mozinfo == 0.9 05:41:07 INFO - mozleak == 0.1 05:41:07 INFO - mozlog == 3.4 05:41:07 INFO - moznetwork == 0.27 05:41:07 INFO - mozprocess == 0.23 05:41:07 INFO - mozprofile == 0.28 05:41:07 INFO - mozrunner == 6.13 05:41:07 INFO - mozscreenshot == 0.1 05:41:07 INFO - mozsystemmonitor == 0.3 05:41:07 INFO - moztest == 0.7 05:41:07 INFO - mozversion == 1.4 05:41:07 INFO - psutil == 3.1.1 05:41:07 INFO - requests == 1.2.3 05:41:07 INFO - wsgiref == 0.1.2 05:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:07 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:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 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:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:41:07 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:41:07 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:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:07 INFO - 'HOME': '/Users/cltbld', 05:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:07 INFO - 'LOGNAME': 'cltbld', 05:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:07 INFO - 'MOZ_NO_REMOTE': '1', 05:41:07 INFO - 'NO_EM_RESTART': '1', 05:41:07 INFO - 'PAGER': '/bin/cat', 05:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:07 INFO - 'PWD': '/builds/slave/test', 05:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:07 INFO - 'SHELL': '/bin/bash', 05:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:41:07 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:07 INFO - 'USER': 'cltbld', 05:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:07 INFO - 'XPC_FLAGS': '0x0', 05:41:07 INFO - 'XPC_SERVICE_NAME': '0', 05:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:07 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:41:07 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:41:07 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:41:07 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:41:07 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:41:07 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:41:07 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:41:07 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:41:07 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:41:07 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:41:07 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:41:07 INFO - Cleaning up... 05:41:07 INFO - Return code: 0 05:41:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:41:07 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:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 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:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 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 0x107e83490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f930ad81800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, '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.krNQlpfC37/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.UyClrowAAD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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:41:07 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:41:07 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:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:07 INFO - 'HOME': '/Users/cltbld', 05:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:07 INFO - 'LOGNAME': 'cltbld', 05:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:07 INFO - 'MOZ_NO_REMOTE': '1', 05:41:07 INFO - 'NO_EM_RESTART': '1', 05:41:07 INFO - 'PAGER': '/bin/cat', 05:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:07 INFO - 'PWD': '/builds/slave/test', 05:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:07 INFO - 'SHELL': '/bin/bash', 05:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:41:07 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:07 INFO - 'USER': 'cltbld', 05:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:07 INFO - 'XPC_FLAGS': '0x0', 05:41:07 INFO - 'XPC_SERVICE_NAME': '0', 05:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:41:07 INFO - Cleaning up... 05:41:07 INFO - Return code: 0 05:41:07 INFO - Running post-action listener: _resource_record_post_action 05:41:07 INFO - Running post-action listener: _start_resource_monitoring 05:41:07 INFO - Starting resource monitoring. 05:41:07 INFO - [mozharness: 2016-11-13 13:41:07.850553Z] Finished create-virtualenv step (success) 05:41:07 INFO - [mozharness: 2016-11-13 13:41:07.851607Z] Running install step. 05:41:07 INFO - Running pre-action listener: _resource_record_pre_action 05:41:07 INFO - Running main action method: install 05:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:08 INFO - Reading from file tmpfile_stdout 05:41:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:08 INFO - Reading from file tmpfile_stdout 05:41:08 INFO - Output received: 05:41:08 INFO - Usage: mozinstall [options] installer 05:41:08 INFO - Options: 05:41:08 INFO - -h, --help show this help message and exit 05:41:08 INFO - -d DEST, --destination=DEST 05:41:08 INFO - Directory to install application into. [default: 05:41:08 INFO - "/builds/slave/test"] 05:41:08 INFO - --app=APP Application being installed. [default: firefox] 05:41:08 INFO - mkdir: /builds/slave/test/build/application 05:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:41:42 INFO - Reading from file tmpfile_stdout 05:41:42 INFO - Output received: 05:41:42 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:41:42 INFO - Running post-action listener: _resource_record_post_action 05:41:42 INFO - [mozharness: 2016-11-13 13:41:42.068849Z] Finished install step (success) 05:41:42 INFO - [mozharness: 2016-11-13 13:41:42.068993Z] Running run-tests step. 05:41:42 INFO - Running pre-action listener: _resource_record_pre_action 05:41:42 INFO - Running main action method: run_tests 05:41:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:41:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:41:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:41:42 INFO - 2016-11-13 05:41:42.082 screenresolution[1646:8569] starting screenresolution argv=screenresolution get 05:41:42 INFO - 2016-11-13 05:41:42.085 screenresolution[1646:8569] Display 0: 1600x1200x32@60 05:41:42 INFO - 2016-11-13 05:41:42.090 screenresolution[1647:8571] starting screenresolution argv=screenresolution list 05:41:42 INFO - Available Modes on Display 0 05:41:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:41:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:41:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:41:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:41:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:41:42 INFO - Intel Iris: 05:41:42 INFO - Chipset Model: Intel Iris 05:41:42 INFO - Type: GPU 05:41:42 INFO - Bus: Built-In 05:41:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:41:42 INFO - Vendor: Intel (0x8086) 05:41:42 INFO - Device ID: 0x0a2e 05:41:42 INFO - Revision ID: 0x0009 05:41:42 INFO - Displays: 05:41:42 INFO - Display: 05:41:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:41:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:41:42 INFO - Display Serial Number: 1600x1200 60 05:41:42 INFO - Main Display: Yes 05:41:42 INFO - Mirror: Off 05:41:42 INFO - Online: Yes 05:41:42 INFO - Rotation: Supported 05:41:42 INFO - Return code: 0 05:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:42 INFO - Python 2.7.3 05:41:42 INFO - Return code: 0 05:41:42 INFO - grabbing minidump binary from tooltool 05:41:42 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:41:42 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 0x107c97d30>, '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 0x107abddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c8fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:42 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:41:42 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:41:42 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:41:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:42 INFO - Return code: 0 05:41:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:41:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:41:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:41:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.krNQlpfC37/Render', 05:41:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:42 INFO - 'HOME': '/Users/cltbld', 05:41:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:42 INFO - 'LOGNAME': 'cltbld', 05:41:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:42 INFO - 'MOZ_NO_REMOTE': '1', 05:41:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:42 INFO - 'NO_EM_RESTART': '1', 05:41:42 INFO - 'PAGER': '/bin/cat', 05:41:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:42 INFO - 'PWD': '/builds/slave/test', 05:41:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:42 INFO - 'SHELL': '/bin/bash', 05:41:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UyClrowAAD/Listeners', 05:41:42 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:41:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:42 INFO - 'USER': 'cltbld', 05:41:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:42 INFO - 'XPC_FLAGS': '0x0', 05:41:42 INFO - 'XPC_SERVICE_NAME': '0', 05:41:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:41:42 INFO - mozversion application_buildid: 20161113030203 05:41:42 INFO - mozversion application_changeset: b37be3d705d929ee52280051d58cedc70a47626f 05:41:42 INFO - mozversion application_display_name: Nightly 05:41:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:42 INFO - mozversion application_name: Firefox 05:41:42 INFO - mozversion application_remotingname: firefox 05:41:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:41:42 INFO - mozversion application_vendor: Mozilla 05:41:42 INFO - mozversion application_version: 52.0a1 05:41:42 INFO - mozversion platform_buildid: 20161113030203 05:41:42 INFO - mozversion platform_changeset: b37be3d705d929ee52280051d58cedc70a47626f 05:41:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:41:42 INFO - mozversion platform_version: 52.0a1 05:41:42 INFO - using testdate: 1479044502 05:41:42 INFO - actual date: 1479044502 05:41:42 INFO - starting webserver on 'localhost:49275' 05:41:42 INFO - SUITE-START | Running 2 tests 05:41:42 INFO - TEST-START | dromaeo_css 05:41:42 INFO - operating with platform_type : mac_ 05:41:42 INFO - Initialising browser for dromaeo_css test... 05:41:42 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmprWU3iv/profile http://localhost:49275/getInfo.html) 05:41:45 INFO - PROCESS | 1657 | 2016-11-13 05:41:45.872 plugin-container[1660:8750] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 05:41:45 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:45 INFO - PROCESS | 1657 | 2016-11-13 05:41:45.873 plugin-container[1660:8750] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 05:41:45 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:45 INFO - PROCESS | 1657 | 2016-11-13 05:41:45.873 plugin-container[1660:8750] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:41:45 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:41:45 INFO - PROCESS | 1657 | colorDepth:24 05:41:45 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:41:45 INFO - PROCESS | 1657 | __metrics 05:41:46 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 05:41:46 INFO - TEST-INFO | 1657: exit 0 05:41:46 INFO - Browser initialized. 05:41:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:46 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmprWU3iv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:49 INFO - PROCESS | 1662 | 2016-11-13 05:41:49.193 plugin-container[1663:8883] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:41:49 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:49 INFO - PROCESS | 1662 | 2016-11-13 05:41:49.193 plugin-container[1663:8883] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 05:41:49 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:49 INFO - PROCESS | 1662 | 2016-11-13 05:41:49.194 plugin-container[1663:8883] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:41:58 INFO - PROCESS | 1662 | RSS: Main: 237527040 05:41:58 INFO - PROCESS | 1662 | 05:42:48 INFO - PROCESS | 1662 | 1479044568457 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:45:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:45:04 INFO - PROCESS | 1662 | RSS: Main: 252301312 05:45:04 INFO - PROCESS | 1662 | 05:48:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:48:06 INFO - PROCESS | 1662 | RSS: Main: 263929856 05:48:06 INFO - PROCESS | 1662 | 05:51:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:51:09 INFO - PROCESS | 1662 | RSS: Main: 271372288 05:51:09 INFO - PROCESS | 1662 | 05:54:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:54:12 INFO - PROCESS | 1662 | RSS: Main: 270176256 05:54:12 INFO - PROCESS | 1662 | 05:57:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:57:15 INFO - PROCESS | 1662 | RSS: Main: 274751488 05:57:15 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:00:18 INFO - PROCESS | 1662 | RSS: Main: 276815872 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | __start_tp_report 06:00:18 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:00:18 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:00:18 INFO - PROCESS | 1662 | |i|pagename|runs| 06:00:18 INFO - PROCESS | 1662 | |0;dojo.html;3336.532885396045;3361.7814842035264;3396.626371099179;3403.676650718181;3417.555717756692;5030.924536131961;5343.893122137555;5711.657300561958;5719.942800571993;5731.627444216123;4266.933266683329;5012.523810238031;5747.3677895431465;5833.82498525045;5844.561657875655;5201.167813149897;5276.736163191844;5279.366476022883;5326.014687282845;5339.813106541272;5282.656627319231;5341.599380046493;5352.652077614962;5356.1697936819855;5379.1662292344745;5274.4461831507715;5284.260203571503;5357.866053348658;5364.436734142898;5383.919241211385;5262.315898933152;5334.22653715213;5376.946230537684;5386.649867758602;5392.56859451243;5220.765065572058;5328.387235467932;5335.9466405336225;5336.59975501835;5352.598555108343;5551.9722401388135;5667.744951477152;5722.427757224286;5803;5983.940160598382;5403;6267.843303917393;6293.150424692653;6294.276158241815;6298.590591611576;6213.968930155365;6271.937280627181;6283.6858157091965;6289.182406287154;6290.43386095249;5726.3700992890745;5832.066869300891;5834.416558344132;5954.761809527614;5988.071689445416;6171.876562468726;6207.6275423474735;6232.937670623326;6253;6254.437100660963;6225.875482490324;6236.064590311399;6239.407256310643;6241.7191226394925;6242.500599951993;6218.844528886814;6219.222597175353;6283.371662833772;6285.2457705075685;6290.370962903765;4717.858464246078;6086.6652334122045;6135.998322733915;6183.96908015457;6214.533909956771;6230.345813689588;6251.218597675291;6253.624782513064;6286.968565157145;6289.8742025159245;4868.756562171877;4990.326305948723;4994.90010199794;5011;5026.1204289249235;4393.824247030083;4442.42248507692;4448.132614140276;4489.685721999429;4500.662450316239;5010.2735103409805;5955.076963070731;6056.485198758155;6075.665838378844;6112.358202388685;4889.071076495526;5767.942320576824;6204.720787564571;6260.812175634738;6268.874622507616;5672.659640421588;5696.1455781633085;6018.578699490994;6058.666773327421;6086.330503644595;5232.1628539433505;5331.840044798662;5345.1982202669915;5377.4891385319115;5497.835064948058;6238.781642642486;6261.78083767066;6271.184745983175;6364.459020983269;6380.808575742735;6247.437730604086;6259.280182779039;6266.404691554295;6272.40412160844;6279.96860015697;6469.644169570531;6479.870402592016;6480.157579514633;6482.870342593216;6519.348065193442;6076.1493390924425;6116.609690437491;6137.836677219377;6255.124282600531;6277.121203031488;6097.939020609914;6188.1027251049245;6224.688765561795;6270.529710271657;6276.717547710456;6167.691615419121;6199.380061993765;6204.038374052029;6209.410106039919;6234.657093859882;6085.6348619083;6144.56988010835;6206.565540412128;6238.126662267196;6261.62430254168;5947.405259474018;5981.371955944737;6076.331603523698;6099.146119543178;6109.725062372115;5025.899482010413;5065.544101030925;6058.90911636317;6156.26124865019;6161.075838624242;5948.137520059654;5984.162217289496;5996.790112346047;5997.640141591519;6003.6998150093195 06:00:18 INFO - PROCESS | 1662 | |1;ext.html;427.09669049959336;460.3095356964553;509.02013623774224;521.5358331085334;559.1361346719316;35830.64169358306;37853.43219851697;37945.051373715636;37948.62051379486;37950.810245948735;38887.80556097223;39238.01904952378;39357.01607459815;39485;39495.60504394955;9105.863412048808;9281.257499400066;9325;9327.393719408217;9353.532323383804;9218.723438296862;9316.301277404222;9329.53352332384;9333.393329433598;9353.064693530661;9338.252939764836;9361.953190234039;9366.063393660648;9366.765830854249;9391.6712915048;9251.213646839993;9324.580393882257;9335;9335.953320233355;9381.484018378986;9190.678326258616;9266.305027122926;9285.164335209864;9288.164065234094;9309.115634014757;37807.621923780964;37820.43269350962;38027.429588556195;38147.80926095379;38165.23669526622;3240.4491236489853;3270.1824543864036;3307.4542700454394;3351.279474912881;3406;29181;29587.556186657217;30194.84902575495;30418;30845.845770771226;2573.8455692658313;2732.7540521352976;2774.7918906082123;3193.297474555594;3266.297745984601;394170;428923;456042;478694;487159;52953;56869;57504;57843.42156578464;57962.7101864488;52626;61649.767004660556;61742.382576173666;61878.690606546676;62000.759984800054;12744.745105097845;15479.767803482957;15571.987820791612;15622.843771562138;15639.3744250231;11783.528658853722;11860.525578976743;11934.52261909514;11961;11969.46137423818;14562.451570975038;14682.486112986207;16022.679546409006;18038.90980545089;18150;7735.419843511759;7766.883496747553;7775.995362388375;7784.338331241795;7877.803054923558;829.6017911402561;944.7732544189482;971.6647756523988;1009.1926458832904;1026.312370711625;29140.271493212414;29143.562846557317;29239.7076029237;29322.706772932423;29820.658070386886;1003.598560575761;1020.1074060197327;1026.3995562595965;1038.5793753529833;1050.448514529878;12388.132830701765;14416.207108608918;14824.62938426548;14890;14910.627234319012;663833;666708;672750;672884;674814;54992;55283;55532.72233638806;55648.16527752087;55936;1127.4250132432355;1344.388303321986;1355.5391167003265;1366.3509832829525;1370.595674276091;21262;28529.857350713115;28580.85709571439;28701.569476458288;29020.12939611815;45688.771556142005;46209.306860397795;46436.767816160704;46563.76718116388;46599;542848;542905;543241;544208;548287;23493;25153.74846251514;25865.870670646527;26134.86932565325;26971.056013040234;43910.78044609757;44064.77967610142;44312.55687443084;44494.332585010605;45379.86550336268;36759;36826.8158659205;37016;37756.867293981224;37837.86486405412;36724.08189795277;36726;37876.62123378731;38079.428808568446;38147.42778858375;31940.68059319377;35415;35417.64582354143;36270;37054;27871.44257114887;31779.600128830494;32052.51921221137;32641.34717305688;33110.66889331076;23285;24502.509949800547;24628.01487940534;24776.76116194147;24868.37829054288 06:00:18 INFO - PROCESS | 1662 | |2;jquery.html;302.8712797061248;305.3389411923186;309.6578280999494;376.91519408133155;385.1014498522284;15201.84798152018;16087.59781005474;19176;19335.12991915364;20155.39533813986;18270.269189232415;19214.807851921476;19544.902275488603;19749.210031598755;19986.700199496983;4546.363509108719;5731.885362292752;5797.913031304533;5802.912956305659;5820.708964551776;4890.290907818364;5582.302212223472;5697.857553561153;5714.285714285715;5788.016037273653;5733.799317023905;5740.856478588048;5741.511971482429;5742.081266997281;5747;5609.691466969315;5721.998650236213;5743.655380677152;5753.280839895013;5786.884262314772;4366.8034938427845;5042.369703787027;5048.217526283432;5051.696898186121;5079.466656001104;23391.766082339298;23750.04999800006;23814.404639883967;23943.92252348631;24124.517509649708;2188.4091295350167;2216.2907869481774;2379.9286021419384;2388.116396933146;2392.330147558669;14038.1577105374;14790.40838366464;15057.94594378394;15187.392504299814;15261.785953675408;1778.3775678512418;1820.4811628685761;1834.9633007339778;1893.6970084786506;1899.0125134929758;109560;112871.48514059428;114463;114496.28255576173;114605.4269728646;10178.592856285813;10431.775131071929;10709.162072050913;10740;10774.838377424345;13154.671133221746;13164.539241126515;13184.670383240496;13207.867921320663;13214.33928303581;7951.064262910398;8226;8231.300339471212;8310.501369917823;8375.036870759819;8218.753437396888;8221.835563288701;8223.506589604523;8410.705625303084;8415.663373465115;6424.935750642528;6436.613803171825;6441.5490915635455;6450.096986421905;6468.15913931186;1798.3166396769143;1815.4553633909775;1815.7639506864023;1819.854411647065;1838.6782313095423;786.9331106855867;882.3691060891365;948.2556193388157;957.3107362698846;1016.1565900302732;19489.902550487157;20415.387538373874;20504.38486845397;20543;20551.4862128448;926.7831367278989;927.8608208768738;958.4967891856692;1006.7483129217695;1037.7509397744639;9369.203617692572;10588.682339529827;10826.837597436044;11113.333200008025;11131.220814543067;225050;239494;541657;578279;581158;74567;108898.45550772196;111095.88904111017;112131.43934280277;114872;821.4537332673824;853.180946291567;1001.8146642871092;1005.8390657494912;1006.4665727164614;18064;18332.058607399475;18472.722909156106;18601.53496162607;18742.437726868215;40435.33905253326;50505.74747126388;50695;51396.74301628468;51531.48468515267;55378.72310638421;59994.40005599888;61299.38700613115;61961;62501.687491562254;6771.255161932282;7082.504224704221;7115.6086415247655;7225.674844631899;7765.883511747215;10163.7459063524;11746.412679366169;11884.881151188723;12262.509499620272;12420.689482763004;10414.895851041392;10450.477476126316;10669.706013207198;10738.194635402533;10804.081653059264;7205.459590530836;10145.594176233164;10416.843747343948;10760.246782725135;11062.944685276521;7099.716011359487;7265.346118849329;7678.424118191047;7701.3068823806125;7713.922860771545;11517.94241028823;11872.703182420508;11884.82172767392;12113.849184327475;12179.025677945567;11190.32858028521;11371.943140284246;11444.484998175269;11451.942740286246;11466.713332166762 06:00:18 INFO - PROCESS | 1662 | |3;mootools.html;1508.803855498785;1531.4730694354314;1730.7749992500974;1786.8838525495835;1836.8806027608205;7094.964525177367;7748.30265276125;7973.083095444018;8446.450980686252;8449.535275559841;7856.332211762007;8145.959270203655;8163.387745919065;8249.257566819;8263.669453221879;2286.3369622809364;2329.685492458522;2331.0093210385603;2331.4754180309465;2342.227065068523;2325.267540724666;2348.9295321140307;2366.100881664965;2373.4185124644487;2375.9406014849596;2261.3555136786017;2283.178055899875;2297.597920363938;2305.4351683837485;2316.968948817777;2271.1823743452346;2287.8970446329954;2294.655801629752;2295.2999335202758;2308.73449553301;2310.653401989715;2322.465832858435;2325.6511523271474;2330.6154484510034;2336.6962294901555;8264.421490495668;8280.958595207047;8325.25072743456;8349.373796965252;8351.874721879176;5058.3929928408825;5220.295260139908;5221.242919776649;5225.4513276105845;5232.816851410221;3252.447083995726;3395.6943875051365;3506.1760486285957;3587.7488575799703;3595.8921232363073;1001.3491230700031;1049.5382031905938;1064.132731823569;1078.687180717591;1087.3910610058392;10672.30630009047;10718.249722519427;10731;10797;10817.891821081847;4414.161309351277;4530.932036019462;4618.399608050931;4623.283391074388;4654.208784506642;9263.25893928484;9327;9356.766080847898;9369.390989585656;9383.24934005278;5152.948470515322;5162.148245539519;5163.3545806774155;5175;5179;3921.5490218624655;4326.610605045561;4647;4718.386609740712;4735.715857048588;2900.521413966672;3290.6709329066903;3523.718102551841;3706.240220754739;3863.478430411915;1094.4473041114186;1262.3877419451558;1273.5860845225154;1275.5535562553218;1278.1883503975043;791.6239786101555;881.4843316659698;901.369041670833;923.7782932096248;937.1331518345503;4789.329493870791;4961.82633607822;5512.783482565268;5696.487316141567;6021.217241758543;818.6397984886631;891.1355984694835;921.6451666108596;941.6939494664261;985.2758222706306;3297;3549.2369140634373;3616.4087801367314;3812.6274541165158;3901.921961560753;9501.762455938657;9748.46383448903;10018.549165287433;10021.048000439947;10028.498575071217;9683.467409292556;9903.752406189902;9957.850632240523;9968.401895886125;10060.245481588763;6325.557210995186;7798.532088074734;7802.414818888606;7814.6874125034365;7837.529748215125;5426.403095659553;5430.945690543044;5488.5334746545395;5550.195221692913;5557.110862262019;9220.769480762767;9346.953265233631;9350.579223935076;9352.298577606844;9358.859617105885;8318.667253309799;9296.163345298955;9321.673741419017;9341.673041443517;9441.669541566012;6457.192850893638;6685.431738302104;6893.103896493424;7036.894446583407;7197.388222001188;7616.543007419573;7903.525788452711;7906.683732650629;7918.524888506708;7922.7227047053075;6115.593413514827;6971.616561088986;7118.323759242864;7130.393916516947;7230.457715671451;6149.446549810538;6834.829129271609;6988;7000.50996430245;7046.2249152594195;6505.991571306455;6547.508936829852;6567.868642627025;6636.668166591748;6650.168728908887;3854.8843534694006;4798.880027999188;4824.6863953842885;4910.165271903714;4910.975445122895;4135.6898232632075;4789.401324834395;4933.55597996182;4943.159662857251;5004.949950500449 06:00:18 INFO - PROCESS | 1662 | |4;prototype.html;280.2615109187291;294.0824627163251;303.7903846346021;307.57400999615527;310.76537214403123;5453.890922181554;5511.448855114487;5515.986664867324;5516.531094856937;5540.307461567304;5419.430959749228;5423.810166644168;5446.319210098738;5453.454654534545;5471.972640136793;3930.66589339905;3934.567197608261;4049.088954985134;4078.3270760324513;4085.142120154771;4072.816723247446;4076.2866498362814;4108.36320370343;4121.505419349683;4134.193832202722;3875.6318149775866;4084.854661910327;4107.383892416146;4110.321796903508;4148.979255103735;3135.8745650173964;3274.5251938469028;3741.887743367676;3762.454444105603;4141.503019637633;2683.8658067096567;3212.1969507623094;3476.148343655795;3489.4242449995722;3498.492718555821;4039.878803635866;4609.893625529882;5230.529252367267;5257.86855328616;5261.789528418859;4371.584699453547;4404.801783919731;4482.85687149778;4623.1678297906365;4626.653001024903;5013.799448022075;5356.6518176318805;5421.322334708161;5565.777368905239;5627.380988091307;2900.941981160365;3176.6664500227375;3805.771653700787;3817.4273858921106;3820.2932457495176;4897.681650692693;5604.383517812997;5906.616069955439;5971.552133589998;6011.909821352683;3656.665317159218;3856.2094770571966;3909.3158697227873;3915.8237879295502;3937.9015524612114;3983.7609743415487;3986.3223252047223;3998.3402738547816;4036.858709945138;4041.8585349512628;4020.9195816083516;4680.4149481314835;4691.249400095969;4692.929606055844;4700.88247793801;4882.120383652248;4893.6329775266995;5429.864253393618;5764.827055188351;5862.443067908542;1115.726646971481;1192.8986036186848;1297.5847728726906;1303.2245813740808;1305.5039085147582;823.8805373220849;829.2081062585216;867.1848462445281;874.1957399192758;881.9603117859712;4948.8762780930765;5015.247712843103;5286.603504737083;5325.83113047736;5336.251830307395;5361.035013697572;5563.415841336682;5935.60513279379;5937;5951.702414879239;5165.612579056586;5190.377154741455;5258.368995720538;5534.280543529316;5552.805651802249;2570.4730530241254;2739.6027576001766;2969.9851500742357;3016.5324374721954;3041.847907604611;5563.661802918297;5682.573806964411;5946.464818166386;5953.613015154087;5998.3701711320555;5184.5593124584075;5385.111456609616;5538.695371754511;5607.822357305012;5632.971835140798;5001.974990125099;5121.513456221653;5372.140457526777;5418.945810541923;5946.910796338145;4610.720724770053;4986.276989836381;5104.417630534546;5145.176771716508;5713.771449141987;4820.807167713392;5385.676859388449;5423.3491980962535;5618.2134501170685;5686.431356864446;5056.367954005749;5159.793608255628;5652.349979752381;5862.765489380377;5949.0962891875915;3212.6305474869755;3554.733394995334;3626.7279954004084;3735.7198210133806;3736.9252614947004;5890.730644492348;5902.881942361043;5910.379410162043;5932.851678708067;5933.673647949404;4622.514635963175;5526.253955715927;5712.200291959212;5770.682612456355;5876.559258055749;5296.814611488579;5406.594285485723;5442.945570544244;5450.236966824568;5762.222100016612;4717.481077081449;5449.23710680513;5694.914576281276;5717.456841600041;5721.794481056503;4350.260455722471;4469.21788686972;4878.243872199815;5089.414717307409;5782.5663075268685;4895.926561101515;5350.892982140414;5573.801632649;5636.9436305638055;5652.886942261214 06:00:18 INFO - PROCESS | 1662 | |5;yui.html;614.5329549542347;662.4534758823971;718.690962885959;747.5066456138946;787.0987719061675;14314.498992535264;14858.925705371485;14907.850921490783;14950.850491495095;14967.101973881574;13219.801702974462;13273.535426260083;13334.466621335136;13346.466141354334;13361.599152025456;648.7859006527834;660.8182749743835;711.7651175112201;814.0922870998838;835.8871552340447;743.9442041846856;827.3960009193293;832.3549249331786;839.7354833227545;850.8425941200867;866.57537806475;873.8951325840876;894.6868595991383;897.3539051882634;898.5821592959272;874.2743522876029;879.7140929198036;892.772343052524;895.3777124898165;896.3591032411857;653.3531803514534;654.5025780406877;669.8995150727382;672.2235817630595;673.1451057157432;14080.71838563223;14402.639934001629;14431.639209019753;14563.635909102251;14565.198914059722;13689.178649281075;13715.657108572266;13920.791188132187;14049.367778449994;14210.431582736677;11355.886441135566;11403.201775875692;11456.255343402736;11505.424728763528;11718.23831450953;3159.541866429378;3223.677632236781;3586.8027258500774;3665.3952097903816;3674.8530058797614;69584.6520767398;91346;92537;93950.53024734833;94947.57578636326;10457.633982810717;10530.526126324334;10699.465026748632;10843.295185812896;10880;21064.894675526524;21110.47223819386;21135;21171;21438.356849294236;7089.432845372461;7332.973383726283;7681.76954691349;7850.882236766453;7894.921050789533;3487.75585709003;4184.7070705050355;4315.827366905289;4331.198728235287;4448.911021779546;3292.456744637108;3367.393869103585;3406.914827129292;3409.9659003409647;3417.79493230407;611.9755209791648;631.8925782616966;640.3372509452694;644.5069521815815;648.5136147889083;525.6845892464568;604.6402390577599;616.2174038970483;661.566673828643;672.9596224226563;7563.773086807405;8689.782755431039;8799.29605631548;8829.64681412749;9151.588178531982;547.7370861986269;654.3401074631607;655.5509476008949;663.7676813115371;668.9163854518185;4294.656427485794;4402.965303153756;4408.25059739845;4419.381286619876;4424.225760491965;104960.47519762353;109701;110321.44839275752;111888;112664;60215.39784602186;73094.26905730981;88098;89154.10845891458;95744.52127739317;66413.66793166003;72886.271137289;78667;84125;85833.71249431264;8191.83616327682;8944.5080520572;9294.25645948336;9530;9556.95221523888;40944.385834213106;47871;48749;53313;54713.72643136759;49184.75407622939;49486.50513494963;66908.3309166902;73453;75703.62148189444;10366.429846358222;12712.982961363254;12908;12952;13156.736865262832;13167.67080822987;13649.713484787528;13857.518219225381;13995.090319129224;13997.580072597839;12328.691782705146;12659.240445573296;13060.934695326463;13103.2138071716;13716.451341946211;13125.737485250433;13169.407376668265;13207.075504714578;13376.531821386205;13460.394282257126;12952.028597855011;13181.406836692564;13319.800202996768;13372.331383430985;13557.728845423233;7901.644426000728;9052.909470905206;9095.1441683433;9152.040516223002;9876.950615246878;9026.007139214813;9441.291903107433;10171.135453486537;10218.897811021794;11460.426978651201 06:00:18 INFO - PROCESS | 1662 | __end_tp_report 06:00:18 INFO - PROCESS | 1662 | __start_cc_report 06:00:18 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,382 06:00:18 INFO - PROCESS | 1662 | __end_cc_report 06:00:18 INFO - PROCESS | 1662 | __startTimestamp1479045618703__endTimestamp 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:00:18 INFO - PROCESS | 1662 | Number of tests: 6 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5747.60 Median:6018.58 stddev:663.48 (11.0%) stddev-sans-first:637.98 06:00:18 INFO - PROCESS | 1662 | Values: 3336.5 3361.8 3396.6 3403.7 3417.6 5030.9 5343.9 5711.7 5719.9 5731.6 4266.9 5012.5 5747.4 5833.8 5844.6 5201.2 5276.7 5279.4 5326.0 5339.8 5282.7 5341.6 5352.7 5356.2 5379.2 5274.4 5284.3 5357.9 5364.4 5383.9 5262.3 5334.2 5376.9 5386.6 5392.6 5220.8 5328.4 5335.9 5336.6 5352.6 5552.0 5667.7 5722.4 5803.0 5983.9 5403.0 6267.8 6293.2 6294.3 6298.6 6214.0 6271.9 6283.7 6289.2 6290.4 5726.4 5832.1 5834.4 5954.8 5988.1 6171.9 6207.6 6232.9 6253.0 6254.4 6225.9 6236.1 6239.4 6241.7 6242.5 6218.8 6219.2 6283.4 6285.2 6290.4 4717.9 6086.7 6136.0 6184.0 6214.5 6230.3 6251.2 6253.6 6287.0 6289.9 4868.8 4990.3 4994.9 5011.0 5026.1 4393.8 4442.4 4448.1 4489.7 4500.7 5010.3 5955.1 6056.5 6075.7 6112.4 4889.1 5767.9 6204.7 6260.8 6268.9 5672.7 5696.1 6018.6 6058.7 6086.3 5232.2 5331.8 5345.2 5377.5 5497.8 6238.8 6261.8 6271.2 6364.5 6380.8 6247.4 6259.3 6266.4 6272.4 6280.0 6469.6 6479.9 6480.2 6482.9 6519.3 6076.1 6116.6 6137.8 6255.1 6277.1 6097.9 6188.1 6224.7 6270.5 6276.7 6167.7 6199.4 6204.0 6209.4 6234.7 6085.6 6144.6 6206.6 6238.1 6261.6 5947.4 5981.4 6076.3 6099.1 6109.7 5025.9 5065.5 6058.9 6156.3 6161.1 5948.1 5984.2 5996.8 5997.6 6003.7 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:67803.82 Median:37949.72 stddev:150535.98 (396.7%) stddev-sans-first:150873.28 06:00:18 INFO - PROCESS | 1662 | Values: 427.1 460.3 509.0 521.5 559.1 35830.6 37853.4 37945.1 37948.6 37950.8 38887.8 39238.0 39357.0 39485.0 39495.6 9105.9 9281.3 9325.0 9327.4 9353.5 9218.7 9316.3 9329.5 9333.4 9353.1 9338.3 9362.0 9366.1 9366.8 9391.7 9251.2 9324.6 9335.0 9336.0 9381.5 9190.7 9266.3 9285.2 9288.2 9309.1 37807.6 37820.4 38027.4 38147.8 38165.2 3240.4 3270.2 3307.5 3351.3 3406.0 29181.0 29587.6 30194.8 30418.0 30845.8 2573.8 2732.8 2774.8 3193.3 3266.3 394170.0 428923.0 456042.0 478694.0 487159.0 52953.0 56869.0 57504.0 57843.4 57962.7 52626.0 61649.8 61742.4 61878.7 62000.8 12744.7 15479.8 15572.0 15622.8 15639.4 11783.5 11860.5 11934.5 11961.0 11969.5 14562.5 14682.5 16022.7 18038.9 18150.0 7735.4 7766.9 7776.0 7784.3 7877.8 829.6 944.8 971.7 1009.2 1026.3 29140.3 29143.6 29239.7 29322.7 29820.7 1003.6 1020.1 1026.4 1038.6 1050.4 12388.1 14416.2 14824.6 14890.0 14910.6 663833.0 666708.0 672750.0 672884.0 674814.0 54992.0 55283.0 55532.7 55648.2 55936.0 1127.4 1344.4 1355.5 1366.4 1370.6 21262.0 28529.9 28580.9 28701.6 29020.1 45688.8 46209.3 46436.8 46563.8 46599.0 542848.0 542905.0 543241.0 544208.0 548287.0 23493.0 25153.7 25865.9 26134.9 26971.1 43910.8 44064.8 44312.6 44494.3 45379.9 36759.0 36826.8 37016.0 37756.9 37837.9 36724.1 36726.0 37876.6 38079.4 38147.4 31940.7 35415.0 35417.6 36270.0 37054.0 27871.4 31779.6 32052.5 32641.3 33110.7 23285.0 24502.5 24628.0 24776.8 24868.4 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:28851.84 Median:124220.88 stddev:78110.81 (62.9%) stddev-sans-first:78300.52 06:00:18 INFO - PROCESS | 1662 | Values: 302.9 305.3 309.7 376.9 385.1 15201.8 16087.6 19176.0 19335.1 20155.4 18270.3 19214.8 19544.9 19749.2 19986.7 4546.4 5731.9 5797.9 5802.9 5820.7 4890.3 5582.3 5697.9 5714.3 5788.0 5733.8 5740.9 5741.5 5742.1 5747.0 5609.7 5722.0 5743.7 5753.3 5786.9 4366.8 5042.4 5048.2 5051.7 5079.5 23391.8 23750.0 23814.4 23943.9 24124.5 2188.4 2216.3 2379.9 2388.1 2392.3 14038.2 14790.4 15057.9 15187.4 15261.8 1778.4 1820.5 1835.0 1893.7 1899.0 109560.0 112871.5 114463.0 114496.3 114605.4 10178.6 10431.8 10709.2 10740.0 10774.8 13154.7 13164.5 13184.7 13207.9 13214.3 7951.1 8226.0 8231.3 8310.5 8375.0 8218.8 8221.8 8223.5 8410.7 8415.7 6424.9 6436.6 6441.5 6450.1 6468.2 1798.3 1815.5 1815.8 1819.9 1838.7 786.9 882.4 948.3 957.3 1016.2 19489.9 20415.4 20504.4 20543.0 20551.5 926.8 927.9 958.5 1006.7 1037.8 9369.2 10588.7 10826.8 11113.3 11131.2 225050.0 239494.0 541657.0 578279.0 581158.0 74567.0 108898.5 111095.9 112131.4 114872.0 821.5 853.2 1001.8 1005.8 1006.5 18064.0 18332.1 18472.7 18601.5 18742.4 40435.3 50505.7 50695.0 51396.7 51531.5 55378.7 59994.4 61299.4 61961.0 62501.7 6771.3 7082.5 7115.6 7225.7 7765.9 10163.7 11746.4 11884.9 12262.5 12420.7 10414.9 10450.5 10669.7 10738.2 10804.1 7205.5 10145.6 10416.8 10760.2 11062.9 7099.7 7265.3 7678.4 7701.3 7713.9 11517.9 11872.7 11884.8 12113.8 12179.0 11190.3 11371.9 11444.5 11451.9 11466.7 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5357.70 Median:5177.00 stddev:2932.26 (56.6%) stddev-sans-first:2926.22 06:00:18 INFO - PROCESS | 1662 | Values: 1508.8 1531.5 1730.8 1786.9 1836.9 7095.0 7748.3 7973.1 8446.5 8449.5 7856.3 8146.0 8163.4 8249.3 8263.7 2286.3 2329.7 2331.0 2331.5 2342.2 2325.3 2348.9 2366.1 2373.4 2375.9 2261.4 2283.2 2297.6 2305.4 2317.0 2271.2 2287.9 2294.7 2295.3 2308.7 2310.7 2322.5 2325.7 2330.6 2336.7 8264.4 8281.0 8325.3 8349.4 8351.9 5058.4 5220.3 5221.2 5225.5 5232.8 3252.4 3395.7 3506.2 3587.7 3595.9 1001.3 1049.5 1064.1 1078.7 1087.4 10672.3 10718.2 10731.0 10797.0 10817.9 4414.2 4530.9 4618.4 4623.3 4654.2 9263.3 9327.0 9356.8 9369.4 9383.2 5152.9 5162.1 5163.4 5175.0 5179.0 3921.5 4326.6 4647.0 4718.4 4735.7 2900.5 3290.7 3523.7 3706.2 3863.5 1094.4 1262.4 1273.6 1275.6 1278.2 791.6 881.5 901.4 923.8 937.1 4789.3 4961.8 5512.8 5696.5 6021.2 818.6 891.1 921.6 941.7 985.3 3297.0 3549.2 3616.4 3812.6 3901.9 9501.8 9748.5 10018.5 10021.0 10028.5 9683.5 9903.8 9957.9 9968.4 10060.2 6325.6 7798.5 7802.4 7814.7 7837.5 5426.4 5430.9 5488.5 5550.2 5557.1 9220.8 9347.0 9350.6 9352.3 9358.9 8318.7 9296.2 9321.7 9341.7 9441.7 6457.2 6685.4 6893.1 7036.9 7197.4 7616.5 7903.5 7906.7 7918.5 7922.7 6115.6 6971.6 7118.3 7130.4 7230.5 6149.4 6834.8 6988.0 7000.5 7046.2 6506.0 6547.5 6567.9 6636.7 6650.2 3854.9 4798.9 4824.7 4910.2 4911.0 4135.7 4789.4 4933.6 4943.2 5004.9 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4507.46 Median:5112.97 stddev:1412.84 (27.6%) stddev-sans-first:1380.72 06:00:18 INFO - PROCESS | 1662 | Values: 280.3 294.1 303.8 307.6 310.8 5453.9 5511.4 5516.0 5516.5 5540.3 5419.4 5423.8 5446.3 5453.5 5472.0 3930.7 3934.6 4049.1 4078.3 4085.1 4072.8 4076.3 4108.4 4121.5 4134.2 3875.6 4084.9 4107.4 4110.3 4149.0 3135.9 3274.5 3741.9 3762.5 4141.5 2683.9 3212.2 3476.1 3489.4 3498.5 4039.9 4609.9 5230.5 5257.9 5261.8 4371.6 4404.8 4482.9 4623.2 4626.7 5013.8 5356.7 5421.3 5565.8 5627.4 2900.9 3176.7 3805.8 3817.4 3820.3 4897.7 5604.4 5906.6 5971.6 6011.9 3656.7 3856.2 3909.3 3915.8 3937.9 3983.8 3986.3 3998.3 4036.9 4041.9 4020.9 4680.4 4691.2 4692.9 4700.9 4882.1 4893.6 5429.9 5764.8 5862.4 1115.7 1192.9 1297.6 1303.2 1305.5 823.9 829.2 867.2 874.2 882.0 4948.9 5015.2 5286.6 5325.8 5336.3 5361.0 5563.4 5935.6 5937.0 5951.7 5165.6 5190.4 5258.4 5534.3 5552.8 2570.5 2739.6 2970.0 3016.5 3041.8 5563.7 5682.6 5946.5 5953.6 5998.4 5184.6 5385.1 5538.7 5607.8 5633.0 5002.0 5121.5 5372.1 5418.9 5946.9 4610.7 4986.3 5104.4 5145.2 5713.8 4820.8 5385.7 5423.3 5618.2 5686.4 5056.4 5159.8 5652.3 5862.8 5949.1 3212.6 3554.7 3626.7 3735.7 3736.9 5890.7 5902.9 5910.4 5932.9 5933.7 4622.5 5526.3 5712.2 5770.7 5876.6 5296.8 5406.6 5442.9 5450.2 5762.2 4717.5 5449.2 5694.9 5717.5 5721.8 4350.3 4469.2 4878.2 5089.4 5782.6 4895.9 5350.9 5573.8 5636.9 5652.9 06:00:18 INFO - PROCESS | 1662 | 06:00:18 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:19474.48 Median:48966.88 stddev:28236.50 (57.7%) stddev-sans-first:28280.20 06:00:18 INFO - PROCESS | 1662 | Values: 614.5 662.5 718.7 747.5 787.1 14314.5 14858.9 14907.9 14950.9 14967.1 13219.8 13273.5 13334.5 13346.5 13361.6 648.8 660.8 711.8 814.1 835.9 743.9 827.4 832.4 839.7 850.8 866.6 873.9 894.7 897.4 898.6 874.3 879.7 892.8 895.4 896.4 653.4 654.5 669.9 672.2 673.1 14080.7 14402.6 14431.6 14563.6 14565.2 13689.2 13715.7 13920.8 14049.4 14210.4 11355.9 11403.2 11456.3 11505.4 11718.2 3159.5 3223.7 3586.8 3665.4 3674.9 69584.7 91346.0 92537.0 93950.5 94947.6 10457.6 10530.5 10699.5 10843.3 10880.0 21064.9 21110.5 21135.0 21171.0 21438.4 7089.4 7333.0 7681.8 7850.9 7894.9 3487.8 4184.7 4315.8 4331.2 4448.9 3292.5 3367.4 3406.9 3410.0 3417.8 612.0 631.9 640.3 644.5 648.5 525.7 604.6 616.2 661.6 673.0 7563.8 8689.8 8799.3 8829.6 9151.6 547.7 654.3 655.6 663.8 668.9 4294.7 4403.0 4408.3 4419.4 4424.2 104960.5 109701.0 110321.4 111888.0 112664.0 60215.4 73094.3 88098.0 89154.1 95744.5 66413.7 72886.3 78667.0 84125.0 85833.7 8191.8 8944.5 9294.3 9530.0 9557.0 40944.4 47871.0 48749.0 53313.0 54713.7 49184.8 49486.5 66908.3 73453.0 75703.6 10366.4 12713.0 12908.0 12952.0 13156.7 13167.7 13649.7 13857.5 13995.1 13997.6 12328.7 12659.2 13060.9 13103.2 13716.5 13125.7 13169.4 13207.1 13376.5 13460.4 12952.0 13181.4 13319.8 13372.3 13557.7 7901.6 9052.9 9095.1 9152.0 9877.0 9026.0 9441.3 10171.1 10218.9 11460.4 06:00:18 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:00:18 INFO - PROCESS | 1662 | 06:00:19 INFO - TEST-INFO | 1662: exit 0 06:00:19 INFO - TEST-OK | dromaeo_css | took 1116664ms 06:00:19 INFO - TEST-START | kraken 06:00:19 INFO - operating with platform_type : mac_ 06:00:19 INFO - Initialising browser for kraken test... 06:00:19 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpbRX5vn/profile http://localhost:49275/getInfo.html) 06:00:22 INFO - PROCESS | 1670 | 2016-11-13 06:00:22.202 plugin-container[1672:11257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 06:00:22 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:22 INFO - PROCESS | 1670 | 2016-11-13 06:00:22.203 plugin-container[1672:11257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 06:00:22 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:22 INFO - PROCESS | 1670 | 2016-11-13 06:00:22.203 plugin-container[1672:11257] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:00:22 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 06:00:22 INFO - PROCESS | 1670 | colorDepth:24 06:00:22 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 06:00:22 INFO - PROCESS | 1670 | __metrics 06:00:22 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 06:00:23 INFO - TEST-INFO | 1670: exit 0 06:00:23 INFO - Browser initialized. 06:00:23 INFO - Running cycle 1/1 for kraken test... 06:00:23 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpbRX5vn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:25 INFO - PROCESS | 1673 | 2016-11-13 06:00:25.759 plugin-container[1674:11380] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 06:00:25 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:25 INFO - PROCESS | 1673 | 2016-11-13 06:00:25.759 plugin-container[1674:11380] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 06:00:25 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:25 INFO - PROCESS | 1673 | 2016-11-13 06:00:25.759 plugin-container[1674:11380] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:00:35 INFO - PROCESS | 1673 | RSS: Main: 237498368 06:00:35 INFO - PROCESS | 1673 | 06:00:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:38 INFO - PROCESS | 1673 | RSS: Main: 249925632 06:00:38 INFO - PROCESS | 1673 | 06:00:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:00:42 INFO - PROCESS | 1673 | RSS: Main: 257597440 06:00:42 INFO - PROCESS | 1673 | 06:00:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:00:46 INFO - PROCESS | 1673 | RSS: Main: 259891200 06:00:46 INFO - PROCESS | 1673 | 06:00:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:00:48 INFO - PROCESS | 1673 | RSS: Main: 262152192 06:00:48 INFO - PROCESS | 1673 | 06:00:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:51 INFO - PROCESS | 1673 | RSS: Main: 262557696 06:00:51 INFO - PROCESS | 1673 | 06:00:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:54 INFO - PROCESS | 1673 | RSS: Main: 268218368 06:00:54 INFO - PROCESS | 1673 | 06:00:57 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:58 INFO - PROCESS | 1673 | RSS: Main: 268214272 06:00:58 INFO - PROCESS | 1673 | 06:01:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:01:01 INFO - PROCESS | 1673 | RSS: Main: 267915264 06:01:01 INFO - PROCESS | 1673 | 06:01:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:04 INFO - PROCESS | 1673 | RSS: Main: 267149312 06:01:04 INFO - PROCESS | 1673 | 06:01:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:06 INFO - PROCESS | 1673 | RSS: Main: 267042816 06:01:06 INFO - PROCESS | 1673 | 06:01:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:09 INFO - PROCESS | 1673 | RSS: Main: 266997760 06:01:09 INFO - PROCESS | 1673 | 06:01:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:13 INFO - PROCESS | 1673 | RSS: Main: 266989568 06:01:13 INFO - PROCESS | 1673 | 06:01:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:16 INFO - PROCESS | 1673 | RSS: Main: 267362304 06:01:16 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:01:18 INFO - PROCESS | 1673 | RSS: Main: 269062144 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | __start_tp_report 06:01:18 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 06:01:18 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 06:01:18 INFO - PROCESS | 1673 | |i|pagename|runs| 06:01:18 INFO - PROCESS | 1673 | |0;ai-astar;121;178;117;117;118;117;117;117;108;115 06:01:18 INFO - PROCESS | 1673 | |1;audio-beat-detection;147;117;112;152;115;132;114;116;145;123 06:01:18 INFO - PROCESS | 1673 | |2;audio-dft;190;199;193;249;229;280;194;195;193;195 06:01:18 INFO - PROCESS | 1673 | |3;audio-fft;74;60;60;81;61;59;61;58;78;59 06:01:18 INFO - PROCESS | 1673 | |4;audio-oscillator;83;71;87;70;70;75;120;100;99;89 06:01:18 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;89;86;89;86;90;85;89;86;101;86 06:01:18 INFO - PROCESS | 1673 | |6;imaging-darkroom;111;153;119;95;95;95;96;118;122;97 06:01:18 INFO - PROCESS | 1673 | |7;imaging-desaturate;89;100;87;72;146;134;93;90;89;90 06:01:18 INFO - PROCESS | 1673 | |8;json-parse-financial;56;57;56;55;58;58;56;57;55;58 06:01:18 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;69;77;68;72;76;73;73;71;70;72 06:01:18 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;88;87;92;90;89;92;95;91;89;101 06:01:18 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;153;197;155;161;160;144;164;165;213;171 06:01:18 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;174;177;175;174;181;180;180;180;176;173 06:01:18 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;65;69;67;68;70;68;69;79;92 06:01:18 INFO - PROCESS | 1673 | __end_tp_report 06:01:18 INFO - PROCESS | 1673 | __start_cc_report 06:01:18 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,972 06:01:18 INFO - PROCESS | 1673 | __end_cc_report 06:01:18 INFO - PROCESS | 1673 | __startTimestamp1479045678981__endTimestamp 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | ------- Summary: start ------- 06:01:18 INFO - PROCESS | 1673 | Number of tests: 14 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:122.50 Median:117.00 stddev:19.78 (16.9%) stddev-sans-first:20.97 06:01:18 INFO - PROCESS | 1673 | Values: 121.0 178.0 117.0 117.0 118.0 117.0 117.0 117.0 108.0 115.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:127.50 stddev:15.45 (12.1%) stddev-sans-first:14.65 06:01:18 INFO - PROCESS | 1673 | Values: 147.0 117.0 112.0 152.0 115.0 132.0 114.0 116.0 145.0 123.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:211.70 Median:197.00 stddev:30.84 (15.7%) stddev-sans-first:31.69 06:01:18 INFO - PROCESS | 1673 | Values: 190.0 199.0 193.0 249.0 229.0 280.0 194.0 195.0 193.0 195.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:65.10 Median:61.00 stddev:8.88 (14.5%) stddev-sans-first:8.81 06:01:18 INFO - PROCESS | 1673 | Values: 74.0 60.0 60.0 81.0 61.0 59.0 61.0 58.0 78.0 59.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:79.00 stddev:16.32 (20.7%) stddev-sans-first:17.26 06:01:18 INFO - PROCESS | 1673 | Values: 83.0 71.0 87.0 70.0 70.0 75.0 120.0 100.0 99.0 89.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:87.50 stddev:4.67 (5.3%) stddev-sans-first:4.95 06:01:18 INFO - PROCESS | 1673 | Values: 89.0 86.0 89.0 86.0 90.0 85.0 89.0 86.0 101.0 86.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:110.10 Median:95.00 stddev:18.79 (19.8%) stddev-sans-first:19.93 06:01:18 INFO - PROCESS | 1673 | Values: 111.0 153.0 119.0 95.0 95.0 95.0 96.0 118.0 122.0 97.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:99.00 Median:89.00 stddev:22.87 (25.7%) stddev-sans-first:23.97 06:01:18 INFO - PROCESS | 1673 | Values: 89.0 100.0 87.0 72.0 146.0 134.0 93.0 90.0 89.0 90.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.17 (2.1%) stddev-sans-first:1.22 06:01:18 INFO - PROCESS | 1673 | Values: 56.0 57.0 56.0 55.0 58.0 58.0 56.0 57.0 55.0 58.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.50 stddev:2.85 (3.9%) stddev-sans-first:2.79 06:01:18 INFO - PROCESS | 1673 | Values: 69.0 77.0 68.0 72.0 76.0 73.0 73.0 71.0 70.0 72.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:90.50 stddev:4.09 (4.5%) stddev-sans-first:4.15 06:01:18 INFO - PROCESS | 1673 | Values: 88.0 87.0 92.0 90.0 89.0 92.0 95.0 91.0 89.0 101.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:168.30 Median:164.50 stddev:21.03 (12.8%) stddev-sans-first:21.57 06:01:18 INFO - PROCESS | 1673 | Values: 153.0 197.0 155.0 161.0 160.0 144.0 164.0 165.0 213.0 171.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:178.50 stddev:3.02 (1.7%) stddev-sans-first:3.00 06:01:18 INFO - PROCESS | 1673 | Values: 174.0 177.0 175.0 174.0 181.0 180.0 180.0 180.0 176.0 173.0 06:01:18 INFO - PROCESS | 1673 | 06:01:18 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:69.00 stddev:8.22 (11.9%) stddev-sans-first:8.49 06:01:18 INFO - PROCESS | 1673 | Values: 66.0 65.0 69.0 67.0 68.0 70.0 68.0 69.0 79.0 92.0 06:01:18 INFO - PROCESS | 1673 | -------- Summary: end -------- 06:01:18 INFO - PROCESS | 1673 | 06:01:19 INFO - TEST-INFO | 1673: exit 0 06:01:19 INFO - TEST-OK | kraken | took 60492ms 06:01:19 INFO - SUITE-END | took 1177s 06:01:20 INFO - Completed test suite (00:19:37) 06:01:20 INFO - javascript benchmark 06:01:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7073.789124388045, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.532885396045, 3361.7814842035264, 3396.626371099179, 3403.676650718181, 3417.555717756692, 5030.924536131961, 5343.893122137555, 5711.657300561958, 5719.942800571993, 5731.627444216123, 4266.933266683329, 5012.523810238031, 5747.3677895431465, 5833.82498525045, 5844.561657875655, 5201.167813149897, 5276.736163191844, 5279.366476022883, 5326.014687282845, 5339.813106541272, 5282.656627319231, 5341.599380046493, 5352.652077614962, 5356.1697936819855, 5379.1662292344745, 5274.4461831507715, 5284.260203571503, 5357.866053348658, 5364.436734142898, 5383.919241211385, 5262.315898933152, 5334.22653715213, 5376.946230537684, 5386.649867758602, 5392.56859451243, 5220.765065572058, 5328.387235467932, 5335.9466405336225, 5336.59975501835, 5352.598555108343, 5551.9722401388135, 5667.744951477152, 5722.427757224286, 5803.0, 5983.940160598382, 5403.0, 6267.843303917393, 6293.150424692653, 6294.276158241815, 6298.590591611576, 6213.968930155365, 6271.937280627181, 6283.6858157091965, 6289.182406287154, 6290.43386095249, 5726.3700992890745, 5832.066869300891, 5834.416558344132, 5954.761809527614, 5988.071689445416, 6171.876562468726, 6207.6275423474735, 6232.937670623326, 6253.0, 6254.437100660963, 6225.875482490324, 6236.064590311399, 6239.407256310643, 6241.7191226394925, 6242.500599951993, 6218.844528886814, 6219.222597175353, 6283.371662833772, 6285.2457705075685, 6290.370962903765, 4717.858464246078, 6086.6652334122045, 6135.998322733915, 6183.96908015457, 6214.533909956771, 6230.345813689588, 6251.218597675291, 6253.624782513064, 6286.968565157145, 6289.8742025159245, 4868.756562171877, 4990.326305948723, 4994.90010199794, 5011.0, 5026.1204289249235, 4393.824247030083, 4442.42248507692, 4448.132614140276, 4489.685721999429, 4500.662450316239, 5010.2735103409805, 5955.076963070731, 6056.485198758155, 6075.665838378844, 6112.358202388685, 4889.071076495526, 5767.942320576824, 6204.720787564571, 6260.812175634738, 6268.874622507616, 5672.659640421588, 5696.1455781633085, 6018.578699490994, 6058.666773327421, 6086.330503644595, 5232.1628539433505, 5331.840044798662, 5345.1982202669915, 5377.4891385319115, 5497.835064948058, 6238.781642642486, 6261.78083767066, 6271.184745983175, 6364.459020983269, 6380.808575742735, 6247.437730604086, 6259.280182779039, 6266.404691554295, 6272.40412160844, 6279.96860015697, 6469.644169570531, 6479.870402592016, 6480.157579514633, 6482.870342593216, 6519.348065193442, 6076.1493390924425, 6116.609690437491, 6137.836677219377, 6255.124282600531, 6277.121203031488, 6097.939020609914, 6188.1027251049245, 6224.688765561795, 6270.529710271657, 6276.717547710456, 6167.691615419121, 6199.380061993765, 6204.038374052029, 6209.410106039919, 6234.657093859882, 6085.6348619083, 6144.56988010835, 6206.565540412128, 6238.126662267196, 6261.62430254168, 5947.405259474018, 5981.371955944737, 6076.331603523698, 6099.146119543178, 6109.725062372115, 5025.899482010413, 5065.544101030925, 6058.90911636317, 6156.26124865019, 6161.075838624242, 5948.137520059654, 5984.162217289496, 5996.790112346047, 5997.640141591519, 6003.6998150093195], "value": 5707.830068715064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.09669049959336, 460.3095356964553, 509.02013623774224, 521.5358331085334, 559.1361346719316, 35830.64169358306, 37853.43219851697, 37945.051373715636, 37948.62051379486, 37950.810245948735, 38887.80556097223, 39238.01904952378, 39357.01607459815, 39485.0, 39495.60504394955, 9105.863412048808, 9281.257499400066, 9325.0, 9327.393719408217, 9353.532323383804, 9218.723438296862, 9316.301277404222, 9329.53352332384, 9333.393329433598, 9353.064693530661, 9338.252939764836, 9361.953190234039, 9366.063393660648, 9366.765830854249, 9391.6712915048, 9251.213646839993, 9324.580393882257, 9335.0, 9335.953320233355, 9381.484018378986, 9190.678326258616, 9266.305027122926, 9285.164335209864, 9288.164065234094, 9309.115634014757, 37807.621923780964, 37820.43269350962, 38027.429588556195, 38147.80926095379, 38165.23669526622, 3240.4491236489853, 3270.1824543864036, 3307.4542700454394, 3351.279474912881, 3406.0, 29181.0, 29587.556186657217, 30194.84902575495, 30418.0, 30845.845770771226, 2573.8455692658313, 2732.7540521352976, 2774.7918906082123, 3193.297474555594, 3266.297745984601, 394170.0, 428923.0, 456042.0, 478694.0, 487159.0, 52953.0, 56869.0, 57504.0, 57843.42156578464, 57962.7101864488, 52626.0, 61649.767004660556, 61742.382576173666, 61878.690606546676, 62000.759984800054, 12744.745105097845, 15479.767803482957, 15571.987820791612, 15622.843771562138, 15639.3744250231, 11783.528658853722, 11860.525578976743, 11934.52261909514, 11961.0, 11969.46137423818, 14562.451570975038, 14682.486112986207, 16022.679546409006, 18038.90980545089, 18150.0, 7735.419843511759, 7766.883496747553, 7775.995362388375, 7784.338331241795, 7877.803054923558, 829.6017911402561, 944.7732544189482, 971.6647756523988, 1009.1926458832904, 1026.312370711625, 29140.271493212414, 29143.562846557317, 29239.7076029237, 29322.706772932423, 29820.658070386886, 1003.598560575761, 1020.1074060197327, 1026.3995562595965, 1038.5793753529833, 1050.448514529878, 12388.132830701765, 14416.207108608918, 14824.62938426548, 14890.0, 14910.627234319012, 663833.0, 666708.0, 672750.0, 672884.0, 674814.0, 54992.0, 55283.0, 55532.72233638806, 55648.16527752087, 55936.0, 1127.4250132432355, 1344.388303321986, 1355.5391167003265, 1366.3509832829525, 1370.595674276091, 21262.0, 28529.857350713115, 28580.85709571439, 28701.569476458288, 29020.12939611815, 45688.771556142005, 46209.306860397795, 46436.767816160704, 46563.76718116388, 46599.0, 542848.0, 542905.0, 543241.0, 544208.0, 548287.0, 23493.0, 25153.74846251514, 25865.870670646527, 26134.86932565325, 26971.056013040234, 43910.78044609757, 44064.77967610142, 44312.55687443084, 44494.332585010605, 45379.86550336268, 36759.0, 36826.8158659205, 37016.0, 37756.867293981224, 37837.86486405412, 36724.08189795277, 36726.0, 37876.62123378731, 38079.428808568446, 38147.42778858375, 31940.68059319377, 35415.0, 35417.64582354143, 36270.0, 37054.0, 27871.44257114887, 31779.600128830494, 32052.51921221137, 32641.34717305688, 33110.66889331076, 23285.0, 24502.509949800547, 24628.01487940534, 24776.76116194147, 24868.37829054288], "value": 19033.228651622638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.8712797061248, 305.3389411923186, 309.6578280999494, 376.91519408133155, 385.1014498522284, 15201.84798152018, 16087.59781005474, 19176.0, 19335.12991915364, 20155.39533813986, 18270.269189232415, 19214.807851921476, 19544.902275488603, 19749.210031598755, 19986.700199496983, 4546.363509108719, 5731.885362292752, 5797.913031304533, 5802.912956305659, 5820.708964551776, 4890.290907818364, 5582.302212223472, 5697.857553561153, 5714.285714285715, 5788.016037273653, 5733.799317023905, 5740.856478588048, 5741.511971482429, 5742.081266997281, 5747.0, 5609.691466969315, 5721.998650236213, 5743.655380677152, 5753.280839895013, 5786.884262314772, 4366.8034938427845, 5042.369703787027, 5048.217526283432, 5051.696898186121, 5079.466656001104, 23391.766082339298, 23750.04999800006, 23814.404639883967, 23943.92252348631, 24124.517509649708, 2188.4091295350167, 2216.2907869481774, 2379.9286021419384, 2388.116396933146, 2392.330147558669, 14038.1577105374, 14790.40838366464, 15057.94594378394, 15187.392504299814, 15261.785953675408, 1778.3775678512418, 1820.4811628685761, 1834.9633007339778, 1893.6970084786506, 1899.0125134929758, 109560.0, 112871.48514059428, 114463.0, 114496.28255576173, 114605.4269728646, 10178.592856285813, 10431.775131071929, 10709.162072050913, 10740.0, 10774.838377424345, 13154.671133221746, 13164.539241126515, 13184.670383240496, 13207.867921320663, 13214.33928303581, 7951.064262910398, 8226.0, 8231.300339471212, 8310.501369917823, 8375.036870759819, 8218.753437396888, 8221.835563288701, 8223.506589604523, 8410.705625303084, 8415.663373465115, 6424.935750642528, 6436.613803171825, 6441.5490915635455, 6450.096986421905, 6468.15913931186, 1798.3166396769143, 1815.4553633909775, 1815.7639506864023, 1819.854411647065, 1838.6782313095423, 786.9331106855867, 882.3691060891365, 948.2556193388157, 957.3107362698846, 1016.1565900302732, 19489.902550487157, 20415.387538373874, 20504.38486845397, 20543.0, 20551.4862128448, 926.7831367278989, 927.8608208768738, 958.4967891856692, 1006.7483129217695, 1037.7509397744639, 9369.203617692572, 10588.682339529827, 10826.837597436044, 11113.333200008025, 11131.220814543067, 225050.0, 239494.0, 541657.0, 578279.0, 581158.0, 74567.0, 108898.45550772196, 111095.88904111017, 112131.43934280277, 114872.0, 821.4537332673824, 853.180946291567, 1001.8146642871092, 1005.8390657494912, 1006.4665727164614, 18064.0, 18332.058607399475, 18472.722909156106, 18601.53496162607, 18742.437726868215, 40435.33905253326, 50505.74747126388, 50695.0, 51396.74301628468, 51531.48468515267, 55378.72310638421, 59994.40005599888, 61299.38700613115, 61961.0, 62501.687491562254, 6771.255161932282, 7082.504224704221, 7115.6086415247655, 7225.674844631899, 7765.883511747215, 10163.7459063524, 11746.412679366169, 11884.881151188723, 12262.509499620272, 12420.689482763004, 10414.895851041392, 10450.477476126316, 10669.706013207198, 10738.194635402533, 10804.081653059264, 7205.459590530836, 10145.594176233164, 10416.843747343948, 10760.246782725135, 11062.944685276521, 7099.716011359487, 7265.346118849329, 7678.424118191047, 7701.3068823806125, 7713.922860771545, 11517.94241028823, 11872.703182420508, 11884.82172767392, 12113.849184327475, 12179.025677945567, 11190.32858028521, 11371.943140284246, 11444.484998175269, 11451.942740286246, 11466.713332166762], "value": 9169.898746980401, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.803855498785, 1531.4730694354314, 1730.7749992500974, 1786.8838525495835, 1836.8806027608205, 7094.964525177367, 7748.30265276125, 7973.083095444018, 8446.450980686252, 8449.535275559841, 7856.332211762007, 8145.959270203655, 8163.387745919065, 8249.257566819, 8263.669453221879, 2286.3369622809364, 2329.685492458522, 2331.0093210385603, 2331.4754180309465, 2342.227065068523, 2325.267540724666, 2348.9295321140307, 2366.100881664965, 2373.4185124644487, 2375.9406014849596, 2261.3555136786017, 2283.178055899875, 2297.597920363938, 2305.4351683837485, 2316.968948817777, 2271.1823743452346, 2287.8970446329954, 2294.655801629752, 2295.2999335202758, 2308.73449553301, 2310.653401989715, 2322.465832858435, 2325.6511523271474, 2330.6154484510034, 2336.6962294901555, 8264.421490495668, 8280.958595207047, 8325.25072743456, 8349.373796965252, 8351.874721879176, 5058.3929928408825, 5220.295260139908, 5221.242919776649, 5225.4513276105845, 5232.816851410221, 3252.447083995726, 3395.6943875051365, 3506.1760486285957, 3587.7488575799703, 3595.8921232363073, 1001.3491230700031, 1049.5382031905938, 1064.132731823569, 1078.687180717591, 1087.3910610058392, 10672.30630009047, 10718.249722519427, 10731.0, 10797.0, 10817.891821081847, 4414.161309351277, 4530.932036019462, 4618.399608050931, 4623.283391074388, 4654.208784506642, 9263.25893928484, 9327.0, 9356.766080847898, 9369.390989585656, 9383.24934005278, 5152.948470515322, 5162.148245539519, 5163.3545806774155, 5175.0, 5179.0, 3921.5490218624655, 4326.610605045561, 4647.0, 4718.386609740712, 4735.715857048588, 2900.521413966672, 3290.6709329066903, 3523.718102551841, 3706.240220754739, 3863.478430411915, 1094.4473041114186, 1262.3877419451558, 1273.5860845225154, 1275.5535562553218, 1278.1883503975043, 791.6239786101555, 881.4843316659698, 901.369041670833, 923.7782932096248, 937.1331518345503, 4789.329493870791, 4961.82633607822, 5512.783482565268, 5696.487316141567, 6021.217241758543, 818.6397984886631, 891.1355984694835, 921.6451666108596, 941.6939494664261, 985.2758222706306, 3297.0, 3549.2369140634373, 3616.4087801367314, 3812.6274541165158, 3901.921961560753, 9501.762455938657, 9748.46383448903, 10018.549165287433, 10021.048000439947, 10028.498575071217, 9683.467409292556, 9903.752406189902, 9957.850632240523, 9968.401895886125, 10060.245481588763, 6325.557210995186, 7798.532088074734, 7802.414818888606, 7814.6874125034365, 7837.529748215125, 5426.403095659553, 5430.945690543044, 5488.5334746545395, 5550.195221692913, 5557.110862262019, 9220.769480762767, 9346.953265233631, 9350.579223935076, 9352.298577606844, 9358.859617105885, 8318.667253309799, 9296.163345298955, 9321.673741419017, 9341.673041443517, 9441.669541566012, 6457.192850893638, 6685.431738302104, 6893.103896493424, 7036.894446583407, 7197.388222001188, 7616.543007419573, 7903.525788452711, 7906.683732650629, 7918.524888506708, 7922.7227047053075, 6115.593413514827, 6971.616561088986, 7118.323759242864, 7130.393916516947, 7230.457715671451, 6149.446549810538, 6834.829129271609, 6988.0, 7000.50996430245, 7046.2249152594195, 6505.991571306455, 6547.508936829852, 6567.868642627025, 6636.668166591748, 6650.168728908887, 3854.8843534694006, 4798.880027999188, 4824.6863953842885, 4910.165271903714, 4910.975445122895, 4135.6898232632075, 4789.401324834395, 4933.55597996182, 4943.159662857251, 5004.949950500449], "value": 4360.208180919438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.2615109187291, 294.0824627163251, 303.7903846346021, 307.57400999615527, 310.76537214403123, 5453.890922181554, 5511.448855114487, 5515.986664867324, 5516.531094856937, 5540.307461567304, 5419.430959749228, 5423.810166644168, 5446.319210098738, 5453.454654534545, 5471.972640136793, 3930.66589339905, 3934.567197608261, 4049.088954985134, 4078.3270760324513, 4085.142120154771, 4072.816723247446, 4076.2866498362814, 4108.36320370343, 4121.505419349683, 4134.193832202722, 3875.6318149775866, 4084.854661910327, 4107.383892416146, 4110.321796903508, 4148.979255103735, 3135.8745650173964, 3274.5251938469028, 3741.887743367676, 3762.454444105603, 4141.503019637633, 2683.8658067096567, 3212.1969507623094, 3476.148343655795, 3489.4242449995722, 3498.492718555821, 4039.878803635866, 4609.893625529882, 5230.529252367267, 5257.86855328616, 5261.789528418859, 4371.584699453547, 4404.801783919731, 4482.85687149778, 4623.1678297906365, 4626.653001024903, 5013.799448022075, 5356.6518176318805, 5421.322334708161, 5565.777368905239, 5627.380988091307, 2900.941981160365, 3176.6664500227375, 3805.771653700787, 3817.4273858921106, 3820.2932457495176, 4897.681650692693, 5604.383517812997, 5906.616069955439, 5971.552133589998, 6011.909821352683, 3656.665317159218, 3856.2094770571966, 3909.3158697227873, 3915.8237879295502, 3937.9015524612114, 3983.7609743415487, 3986.3223252047223, 3998.3402738547816, 4036.858709945138, 4041.8585349512628, 4020.9195816083516, 4680.4149481314835, 4691.249400095969, 4692.929606055844, 4700.88247793801, 4882.120383652248, 4893.6329775266995, 5429.864253393618, 5764.827055188351, 5862.443067908542, 1115.726646971481, 1192.8986036186848, 1297.5847728726906, 1303.2245813740808, 1305.5039085147582, 823.8805373220849, 829.2081062585216, 867.1848462445281, 874.1957399192758, 881.9603117859712, 4948.8762780930765, 5015.247712843103, 5286.603504737083, 5325.83113047736, 5336.251830307395, 5361.035013697572, 5563.415841336682, 5935.60513279379, 5937.0, 5951.702414879239, 5165.612579056586, 5190.377154741455, 5258.368995720538, 5534.280543529316, 5552.805651802249, 2570.4730530241254, 2739.6027576001766, 2969.9851500742357, 3016.5324374721954, 3041.847907604611, 5563.661802918297, 5682.573806964411, 5946.464818166386, 5953.613015154087, 5998.3701711320555, 5184.5593124584075, 5385.111456609616, 5538.695371754511, 5607.822357305012, 5632.971835140798, 5001.974990125099, 5121.513456221653, 5372.140457526777, 5418.945810541923, 5946.910796338145, 4610.720724770053, 4986.276989836381, 5104.417630534546, 5145.176771716508, 5713.771449141987, 4820.807167713392, 5385.676859388449, 5423.3491980962535, 5618.2134501170685, 5686.431356864446, 5056.367954005749, 5159.793608255628, 5652.349979752381, 5862.765489380377, 5949.0962891875915, 3212.6305474869755, 3554.733394995334, 3626.7279954004084, 3735.7198210133806, 3736.9252614947004, 5890.730644492348, 5902.881942361043, 5910.379410162043, 5932.851678708067, 5933.673647949404, 4622.514635963175, 5526.253955715927, 5712.200291959212, 5770.682612456355, 5876.559258055749, 5296.814611488579, 5406.594285485723, 5442.945570544244, 5450.236966824568, 5762.222100016612, 4717.481077081449, 5449.23710680513, 5694.914576281276, 5717.456841600041, 5721.794481056503, 4350.260455722471, 4469.21788686972, 4878.243872199815, 5089.414717307409, 5782.5663075268685, 4895.926561101515, 5350.892982140414, 5573.801632649, 5636.9436305638055, 5652.886942261214], "value": 4050.9973492340328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.5329549542347, 662.4534758823971, 718.690962885959, 747.5066456138946, 787.0987719061675, 14314.498992535264, 14858.925705371485, 14907.850921490783, 14950.850491495095, 14967.101973881574, 13219.801702974462, 13273.535426260083, 13334.466621335136, 13346.466141354334, 13361.599152025456, 648.7859006527834, 660.8182749743835, 711.7651175112201, 814.0922870998838, 835.8871552340447, 743.9442041846856, 827.3960009193293, 832.3549249331786, 839.7354833227545, 850.8425941200867, 866.57537806475, 873.8951325840876, 894.6868595991383, 897.3539051882634, 898.5821592959272, 874.2743522876029, 879.7140929198036, 892.772343052524, 895.3777124898165, 896.3591032411857, 653.3531803514534, 654.5025780406877, 669.8995150727382, 672.2235817630595, 673.1451057157432, 14080.71838563223, 14402.639934001629, 14431.639209019753, 14563.635909102251, 14565.198914059722, 13689.178649281075, 13715.657108572266, 13920.791188132187, 14049.367778449994, 14210.431582736677, 11355.886441135566, 11403.201775875692, 11456.255343402736, 11505.424728763528, 11718.23831450953, 3159.541866429378, 3223.677632236781, 3586.8027258500774, 3665.3952097903816, 3674.8530058797614, 69584.6520767398, 91346.0, 92537.0, 93950.53024734833, 94947.57578636326, 10457.633982810717, 10530.526126324334, 10699.465026748632, 10843.295185812896, 10880.0, 21064.894675526524, 21110.47223819386, 21135.0, 21171.0, 21438.356849294236, 7089.432845372461, 7332.973383726283, 7681.76954691349, 7850.882236766453, 7894.921050789533, 3487.75585709003, 4184.7070705050355, 4315.827366905289, 4331.198728235287, 4448.911021779546, 3292.456744637108, 3367.393869103585, 3406.914827129292, 3409.9659003409647, 3417.79493230407, 611.9755209791648, 631.8925782616966, 640.3372509452694, 644.5069521815815, 648.5136147889083, 525.6845892464568, 604.6402390577599, 616.2174038970483, 661.566673828643, 672.9596224226563, 7563.773086807405, 8689.782755431039, 8799.29605631548, 8829.64681412749, 9151.588178531982, 547.7370861986269, 654.3401074631607, 655.5509476008949, 663.7676813115371, 668.9163854518185, 4294.656427485794, 4402.965303153756, 4408.25059739845, 4419.381286619876, 4424.225760491965, 104960.47519762353, 109701.0, 110321.44839275752, 111888.0, 112664.0, 60215.39784602186, 73094.26905730981, 88098.0, 89154.10845891458, 95744.52127739317, 66413.66793166003, 72886.271137289, 78667.0, 84125.0, 85833.71249431264, 8191.83616327682, 8944.5080520572, 9294.25645948336, 9530.0, 9556.95221523888, 40944.385834213106, 47871.0, 48749.0, 53313.0, 54713.72643136759, 49184.75407622939, 49486.50513494963, 66908.3309166902, 73453.0, 75703.62148189444, 10366.429846358222, 12712.982961363254, 12908.0, 12952.0, 13156.736865262832, 13167.67080822987, 13649.713484787528, 13857.518219225381, 13995.090319129224, 13997.580072597839, 12328.691782705146, 12659.240445573296, 13060.934695326463, 13103.2138071716, 13716.451341946211, 13125.737485250433, 13169.407376668265, 13207.075504714578, 13376.531821386205, 13460.394282257126, 12952.028597855011, 13181.406836692564, 13319.800202996768, 13372.331383430985, 13557.728845423233, 7901.644426000728, 9052.909470905206, 9095.1441683433, 9152.040516223002, 9876.950615246878, 9026.007139214813, 9441.291903107433, 10171.135453486537, 10218.897811021794, 11460.426978651201], "value": 7119.503924418879, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 178.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 108.0, 115.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 112.0, 152.0, 115.0, 132.0, 114.0, 116.0, 145.0, 123.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 199.0, 193.0, 249.0, 229.0, 280.0, 194.0, 195.0, 193.0, 195.0], "value": 211.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 60.0, 60.0, 81.0, 61.0, 59.0, 61.0, 58.0, 78.0, 59.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 87.0, 70.0, 70.0, 75.0, 120.0, 100.0, 99.0, 89.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 90.0, 85.0, 89.0, 86.0, 101.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 153.0, 119.0, 95.0, 95.0, 95.0, 96.0, 118.0, 122.0, 97.0], "value": 110.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 100.0, 87.0, 72.0, 146.0, 134.0, 93.0, 90.0, 89.0, 90.0], "value": 99.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 55.0, 58.0, 58.0, 56.0, 57.0, 55.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 68.0, 72.0, 76.0, 73.0, 73.0, 71.0, 70.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 92.0, 90.0, 89.0, 92.0, 95.0, 91.0, 89.0, 101.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 197.0, 155.0, 161.0, 160.0, 144.0, 164.0, 165.0, 213.0, 171.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 175.0, 174.0, 181.0, 180.0, 180.0, 180.0, 176.0, 173.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 69.0, 67.0, 68.0, 70.0, 68.0, 69.0, 79.0, 92.0], "value": 71.3, "unit": "score"}]}]} 06:01:20 INFO - Return code: 0 06:01:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:20 ERROR - # TBPL SUCCESS # 06:01:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:01:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:01:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:01:20 INFO - 2016-11-13 06:01:20.267 screenresolution[1678:11773] starting screenresolution argv=screenresolution get 06:01:20 INFO - 2016-11-13 06:01:20.270 screenresolution[1678:11773] Display 0: 1600x1200x32@60 06:01:20 INFO - 2016-11-13 06:01:20.277 screenresolution[1679:11776] starting screenresolution argv=screenresolution list 06:01:20 INFO - Available Modes on Display 0 06:01:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:01:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:01:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:01:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:01:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:01:20 INFO - Intel Iris: 06:01:20 INFO - Chipset Model: Intel Iris 06:01:20 INFO - Type: GPU 06:01:20 INFO - Bus: Built-In 06:01:20 INFO - VRAM (Dynamic, Max): 1536 MB 06:01:20 INFO - Vendor: Intel (0x8086) 06:01:20 INFO - Device ID: 0x0a2e 06:01:20 INFO - Revision ID: 0x0009 06:01:20 INFO - Displays: 06:01:20 INFO - Display: 06:01:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:01:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:01:20 INFO - Display Serial Number: 1600x1200 60 06:01:20 INFO - Main Display: Yes 06:01:20 INFO - Mirror: Off 06:01:20 INFO - Online: Yes 06:01:20 INFO - Rotation: Supported 06:01:20 INFO - Return code: 0 06:01:20 INFO - Running post-action listener: _resource_record_post_action 06:01:20 INFO - [mozharness: 2016-11-13 14:01:20.523076Z] Finished run-tests step (success) 06:01:20 INFO - Running post-run listener: _resource_record_post_run 06:01:20 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 34721792; Write bytes: 707025408; Read time: 325; Write time: 2287 06:01:20 INFO - TinderboxPrint: CPU usage
54.5% 06:01:20 INFO - TinderboxPrint: I/O read bytes / time
34,721,792 / 325 06:01:20 INFO - TinderboxPrint: I/O write bytes / time
707,025,408 / 2,287 06:01:20 INFO - TinderboxPrint: CPU idle
2,207.4 (45.5%) 06:01:20 INFO - TinderboxPrint: CPU system
980.4 (20.2%) 06:01:20 INFO - TinderboxPrint: CPU user
1,662.1 (34.3%) 06:01:20 INFO - TinderboxPrint: Swap in / out
430,223,360 / 0 06:01:20 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398549504; Write bytes: 393764352; Read time: 29926; Write time: 757 06:01:20 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 32595968; Write bytes: 303197184; Read time: 302; Write time: 1495 06:01:21 INFO - Running post-run listener: _upload_blobber_files 06:01:21 INFO - Blob upload gear active. 06:01:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:21 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 06:01:21 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'] 06:01:21 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 06:01:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:22 INFO - (blobuploader) - INFO - Done attempting. 06:01:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:01:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:23 INFO - (blobuploader) - INFO - Done attempting. 06:01:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:25 INFO - (blobuploader) - INFO - Done attempting. 06:01:25 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:25 INFO - Return code: 0 06:01:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fce3850030706392d20beb54958d834a0abb453fbca7b03c2d2966dfcd7a8855de48c1c2eab521268704040d810e9e3dc3eb1954049ae64e5c0b976628430c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0fe4ee664d970ae183386f5222dc0f36bd8b830f56634015f6d48cac5832f86628a5329021a471e919b86f8cbf86d34ff0d8256f8f8f98dd8e64814338297de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f59e77f5aa5448cf9086aabab59ac179bbdbed92ed9ee7104458f3b9af7bea5166e09e88cb9772f57e883b55a1e5998d236d3baed955cf28e1b6bce2b9880028"} 06:01:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:25 INFO - Contents: 06:01:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fce3850030706392d20beb54958d834a0abb453fbca7b03c2d2966dfcd7a8855de48c1c2eab521268704040d810e9e3dc3eb1954049ae64e5c0b976628430c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0fe4ee664d970ae183386f5222dc0f36bd8b830f56634015f6d48cac5832f86628a5329021a471e919b86f8cbf86d34ff0d8256f8f8f98dd8e64814338297de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f59e77f5aa5448cf9086aabab59ac179bbdbed92ed9ee7104458f3b9af7bea5166e09e88cb9772f57e883b55a1e5998d236d3baed955cf28e1b6bce2b9880028"} 06:01:25 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:25 INFO - Copying logs to upload dir... 06:01:25 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.436192 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-13 06:01:25.832769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 06:01:25.836479) ========= 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.krNQlpfC37/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.UyClrowAAD/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fce3850030706392d20beb54958d834a0abb453fbca7b03c2d2966dfcd7a8855de48c1c2eab521268704040d810e9e3dc3eb1954049ae64e5c0b976628430c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0fe4ee664d970ae183386f5222dc0f36bd8b830f56634015f6d48cac5832f86628a5329021a471e919b86f8cbf86d34ff0d8256f8f8f98dd8e64814338297de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f59e77f5aa5448cf9086aabab59ac179bbdbed92ed9ee7104458f3b9af7bea5166e09e88cb9772f57e883b55a1e5998d236d3baed955cf28e1b6bce2b9880028"} build_url:https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010698 build_url: 'https://queue.taskcluster.net/v1/task/NiMkvmq5RyCPD5pgl2QN9g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fce3850030706392d20beb54958d834a0abb453fbca7b03c2d2966dfcd7a8855de48c1c2eab521268704040d810e9e3dc3eb1954049ae64e5c0b976628430c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0fe4ee664d970ae183386f5222dc0f36bd8b830f56634015f6d48cac5832f86628a5329021a471e919b86f8cbf86d34ff0d8256f8f8f98dd8e64814338297de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f59e77f5aa5448cf9086aabab59ac179bbdbed92ed9ee7104458f3b9af7bea5166e09e88cb9772f57e883b55a1e5998d236d3baed955cf28e1b6bce2b9880028"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 06:01:25.871941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 06:01:25.872507) ========= 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.krNQlpfC37/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.UyClrowAAD/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005134 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 06:01:25.923453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 06:01:25.924016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 06:01:25.924578) ========= ========= Total master_lag: 0.19 =========