builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0030 starttime: 1487886614.7 results: success (0) buildid: 20170223120822 builduid: 86366fe5fc1c40fb827c97dbe3e79bed revision: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:14.701547) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:14.701969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:14.702236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:14.728199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:14.728574) ========= 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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-23 13:50:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.22M=0.001s 2017-02-23 13:50:14 (9.22 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131978 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:15.094593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:15.094896) ========= 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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.027333 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:15.143658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 13:50:15.144007) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8a654cb6a61e3c051d50542cc67b61943e4fbf80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8a654cb6a61e3c051d50542cc67b61943e4fbf80 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h6HKdFQo2G/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.pY9mPYdo4w/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-23 13:50:15,246 truncating revision to first 12 chars 2017-02-23 13:50:15,246 Setting DEBUG logging. 2017-02-23 13:50:15,246 attempt 1/10 2017-02-23 13:50:15,246 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8a654cb6a61e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 13:50:16,295 unpacking tar archive at: mozilla-beta-8a654cb6a61e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316202 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 13:50:16.482912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:16.483256) ========= script_repo_revision: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:16.483736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:16.484015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 13:50:16.503052) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-23 13:50:16.503438) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h6HKdFQo2G/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.pY9mPYdo4w/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:50:16 INFO - MultiFileLogger online at 20170223 13:50:16 in /builds/slave/test 13:50:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:50:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:16 INFO - {'append_to_log': False, 13:50:16 INFO - 'base_work_dir': '/builds/slave/test', 13:50:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:50:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:16 INFO - 'branch': 'Mozilla-Beta', 13:50:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:16 INFO - 'config_files': ('talos/mac_config.py',), 13:50:16 INFO - 'default_actions': ('clobber', 13:50:16 INFO - 'read-buildbot-config', 13:50:16 INFO - 'download-and-extract', 13:50:16 INFO - 'populate-webroot', 13:50:16 INFO - 'create-virtualenv', 13:50:16 INFO - 'install', 13:50:16 INFO - 'run-tests'), 13:50:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:16 INFO - 'download_minidump_stackwalk': True, 13:50:16 INFO - 'download_symbols': 'ondemand', 13:50:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:16 INFO - 'installer_path': 'installer.exe', 13:50:16 INFO - 'log_level': 'info', 13:50:16 INFO - 'log_name': 'talos', 13:50:16 INFO - 'log_to_console': True, 13:50:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:16 INFO - 'opt_config_files': (), 13:50:16 INFO - 'pip_index': False, 13:50:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:16 INFO - 'cmd': ('bash', 13:50:16 INFO - '-c', 13:50:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:16 INFO - 'enabled': True, 13:50:16 INFO - 'halt_on_failure': False, 13:50:16 INFO - 'name': 'check_screen_resolution'},), 13:50:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:16 INFO - 'cmd': ('bash', 13:50:16 INFO - '-c', 13:50:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:16 INFO - 'enabled': True, 13:50:16 INFO - 'halt_on_failure': False, 13:50:16 INFO - 'name': 'check_screen_resolution'},), 13:50:16 INFO - 'run_cmd_checks_enabled': True, 13:50:16 INFO - 'sps_profile': False, 13:50:16 INFO - 'sps_profile_interval': 0, 13:50:16 INFO - 'suite': 'dromaeojs-e10s', 13:50:16 INFO - 'system_bits': '32', 13:50:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:16 INFO - 'title': 't-yosemite-r7-0030', 13:50:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:16 INFO - 'use_talos_json': True, 13:50:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:16 INFO - 'work_dir': 'build'} 13:50:16 INFO - [mozharness: 2017-02-23 21:50:16.727313Z] Running clobber step. 13:50:16 INFO - Running pre-action listener: _resource_record_pre_action 13:50:16 INFO - Running main action method: clobber 13:50:16 INFO - rmtree: /builds/slave/test/build 13:50:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:19 INFO - Running post-action listener: _resource_record_post_action 13:50:19 INFO - [mozharness: 2017-02-23 21:50:19.295635Z] Finished clobber step (success) 13:50:19 INFO - [mozharness: 2017-02-23 21:50:19.295778Z] Running read-buildbot-config step. 13:50:19 INFO - Running pre-action listener: _resource_record_pre_action 13:50:19 INFO - Running main action method: read_buildbot_config 13:50:19 INFO - Using buildbot properties: 13:50:19 INFO - { 13:50:19 INFO - "project": "", 13:50:19 INFO - "product": "firefox", 13:50:19 INFO - "script_repo_revision": "production", 13:50:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:50:19 INFO - "repository": "", 13:50:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:50:19 INFO - "buildid": "20170223120822", 13:50:19 INFO - "pgo_build": "False", 13:50:19 INFO - "basedir": "/builds/slave/test", 13:50:19 INFO - "buildnumber": 20, 13:50:19 INFO - "slavename": "t-yosemite-r7-0030", 13:50:19 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:50:19 INFO - "platform": "yosemite_r7", 13:50:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:50:19 INFO - "branch": "mozilla-beta", 13:50:19 INFO - "repo_path": "releases/mozilla-beta", 13:50:19 INFO - "revision": "8a654cb6a61e3c051d50542cc67b61943e4fbf80", 13:50:19 INFO - "stage_platform": "macosx64", 13:50:19 INFO - "builduid": "86366fe5fc1c40fb827c97dbe3e79bed", 13:50:19 INFO - "slavebuilddir": "test" 13:50:19 INFO - } 13:50:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:50:19 INFO - Running post-action listener: _resource_record_post_action 13:50:19 INFO - [mozharness: 2017-02-23 21:50:19.299080Z] Finished read-buildbot-config step (success) 13:50:19 INFO - [mozharness: 2017-02-23 21:50:19.299185Z] Running download-and-extract step. 13:50:19 INFO - Running pre-action listener: _resource_record_pre_action 13:50:19 INFO - Running main action method: download_and_extract 13:50:19 INFO - mkdir: /builds/slave/test/build/tests 13:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:19 INFO - trying https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:50:19 INFO - Downloading https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 13:50:20 INFO - Downloaded 1165 bytes. 13:50:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:50:20 INFO - Using the following test package requirements: 13:50:20 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:50:20 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:50:20 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:50:20 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:50:20 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:50:20 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:50:20 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:50:20 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:50:20 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:50:20 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:50:20 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:50:20 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:50:20 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:50:20 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:50:20 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:50:20 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:50:20 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:50:20 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:50:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:50:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:50:20 INFO - Fetch https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:50:20 INFO - Http code: 200 13:50:20 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 13:50:20 INFO - x-amz-cf-id: aT_jaU8xNxsnaT51K9EDB-cP3yWT01LMIa8hvKe9NSHjQ8WdrLZfJA== 13:50:20 INFO - x-amz-version-id: 0uAFzhUgfrn8CzYiXfSC1_DfUJlPgayq 13:50:21 INFO - Expected file size: 16093342 13:50:21 INFO - Obtained file size: 16093342 13:50:27 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:50:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:50:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:50:27 INFO - Fetch https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:50:28 INFO - Http code: 200 13:50:28 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 13:50:28 INFO - x-amz-cf-id: H7AOzkbBR6iM4HlTACaPFoY3hzJUOyS1fAQEboisCUc1TKJY5j1iVw== 13:50:28 INFO - x-amz-version-id: 0uAFzhUgfrn8CzYiXfSC1_DfUJlPgayq 13:50:28 INFO - Expected file size: 16093342 13:50:28 INFO - Obtained file size: 16093342 13:50:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:50:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:50:35 INFO - Fetch https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:50:35 INFO - Http code: 200 13:50:35 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 13:50:35 INFO - x-amz-cf-id: mVTe3T1suGvVW1XBBmyjQ3UPrfKdEDHJNPsBDc2BhVlg2Prq96gmXw== 13:50:35 INFO - x-amz-version-id: NwVYPMhUHmYiaZcaYfl_sHL3rYFch8RF 13:50:35 INFO - Expected file size: 14402992 13:50:35 INFO - Obtained file size: 14402992 13:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:36 INFO - trying https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:50:36 INFO - Downloading https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 13:50:39 INFO - Downloaded 82109575 bytes. 13:50:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:50:39 INFO - mkdir: /builds/slave/test/properties 13:50:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:50:39 INFO - Writing to file /builds/slave/test/properties/build_url 13:50:39 INFO - Contents: 13:50:39 INFO - build_url:https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:50:40 INFO - Running post-action listener: _resource_record_post_action 13:50:40 INFO - Running post-action listener: set_extra_try_arguments 13:50:40 INFO - [mozharness: 2017-02-23 21:50:40.145124Z] Finished download-and-extract step (success) 13:50:40 INFO - [mozharness: 2017-02-23 21:50:40.145272Z] Running populate-webroot step. 13:50:40 INFO - Running pre-action listener: _resource_record_pre_action 13:50:40 INFO - Running main action method: populate_webroot 13:50:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:50:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:50:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:50:40 INFO - '--tppagecycles', 13:50:40 INFO - '7'], 13:50:40 INFO - 'tests': ['tsvgm']}}, 13:50:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:50:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:50:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:50:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:50:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['damp', 'tps']}, 13:50:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'tests': ['damp', 'tps']}, 13:50:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['dromaeo_dom']}, 13:50:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:50:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['basic_compositor_video']}, 13:50:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:50:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['a11yr', 13:50:40 INFO - 'ts_paint', 13:50:40 INFO - 'tpaint', 13:50:40 INFO - 'sessionrestore', 13:50:40 INFO - 'sessionrestore_no_auto_restore', 13:50:40 INFO - 'tabpaint']}, 13:50:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:50:40 INFO - 'ts_paint', 13:50:40 INFO - 'tpaint', 13:50:40 INFO - 'sessionrestore', 13:50:40 INFO - 'sessionrestore_no_auto_restore', 13:50:40 INFO - 'tabpaint']}, 13:50:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:50:40 INFO - 'ts_paint', 13:50:40 INFO - 'tpaint', 13:50:40 INFO - 'sessionrestore', 13:50:40 INFO - 'sessionrestore_no_auto_restore', 13:50:40 INFO - 'tabpaint']}, 13:50:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:50:40 INFO - 'ts_paint', 13:50:40 INFO - 'tpaint', 13:50:40 INFO - 'sessionrestore', 13:50:40 INFO - 'sessionrestore_no_auto_restore', 13:50:40 INFO - 'tabpaint']}, 13:50:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['a11yr', 13:50:40 INFO - 'ts_paint', 13:50:40 INFO - 'tpaint', 13:50:40 INFO - 'sessionrestore', 13:50:40 INFO - 'sessionrestore_no_auto_restore', 13:50:40 INFO - 'tabpaint']}, 13:50:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['a11yr', 13:50:40 INFO - 'ts_paint', 13:50:40 INFO - 'tpaint', 13:50:40 INFO - 'sessionrestore', 13:50:40 INFO - 'sessionrestore_no_auto_restore', 13:50:40 INFO - 'tabpaint']}, 13:50:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['tsvgx', 13:50:40 INFO - 'tsvgr_opacity', 13:50:40 INFO - 'tart', 13:50:40 INFO - 'tscrollx', 13:50:40 INFO - 'cart']}, 13:50:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:50:40 INFO - 'tsvgr_opacity', 13:50:40 INFO - 'tart', 13:50:40 INFO - 'tscrollx', 13:50:40 INFO - 'cart']}, 13:50:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'talos_options': ['--disable-e10s'], 13:50:40 INFO - 'tests': ['tp5o']}, 13:50:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'tests': ['tp5o']}, 13:50:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'talos_options': ['--disable-e10s', 13:50:40 INFO - '--xperf_path', 13:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:40 INFO - 'tests': ['tp5n']}, 13:50:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:40 INFO - 'talos_options': ['--xperf_path', 13:50:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:40 INFO - 'tests': ['tp5n']}}, 13:50:40 INFO - 'talos.zip': {'path': '', 13:50:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:50:40 INFO - Running post-action listener: _resource_record_post_action 13:50:40 INFO - [mozharness: 2017-02-23 21:50:40.164541Z] Finished populate-webroot step (success) 13:50:40 INFO - [mozharness: 2017-02-23 21:50:40.164621Z] Running create-virtualenv step. 13:50:40 INFO - Running pre-action listener: _resource_record_pre_action 13:50:40 INFO - Running main action method: create_virtualenv 13:50:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:50:40 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 13:50:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:50:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:50:40 INFO - Using real prefix '/tools/python27' 13:50:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:50:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:50:43 INFO - Installing pip.................done. 13:50:43 INFO - Return code: 0 13:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:50:44 INFO - Reading from file tmpfile_stdout 13:50:44 INFO - Output received: 13:50:44 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) 13:50:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:44 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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:50:44 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 13:50:44 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 13:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:44 INFO - 'HOME': '/Users/cltbld', 13:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:44 INFO - 'LOGNAME': 'cltbld', 13:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:44 INFO - 'MOZ_NO_REMOTE': '1', 13:50:44 INFO - 'NO_EM_RESTART': '1', 13:50:44 INFO - 'PAGER': '/bin/cat', 13:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:44 INFO - 'PWD': '/builds/slave/test', 13:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:44 INFO - 'SHELL': '/bin/bash', 13:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:50:44 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:44 INFO - 'USER': 'cltbld', 13:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:44 INFO - 'XPC_FLAGS': '0x0', 13:50:44 INFO - 'XPC_SERVICE_NAME': '0', 13:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:44 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 13:50:44 INFO - Cleaning up... 13:50:44 INFO - Return code: 0 13:50:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:44 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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:50:44 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 13:50:44 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 13:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:44 INFO - 'HOME': '/Users/cltbld', 13:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:44 INFO - 'LOGNAME': 'cltbld', 13:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:44 INFO - 'MOZ_NO_REMOTE': '1', 13:50:44 INFO - 'NO_EM_RESTART': '1', 13:50:44 INFO - 'PAGER': '/bin/cat', 13:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:44 INFO - 'PWD': '/builds/slave/test', 13:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:44 INFO - 'SHELL': '/bin/bash', 13:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:50:44 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:44 INFO - 'USER': 'cltbld', 13:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:44 INFO - 'XPC_FLAGS': '0x0', 13:50:44 INFO - 'XPC_SERVICE_NAME': '0', 13:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:44 INFO - Downloading/unpacking psutil>=3.1.1 13:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:50:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:48 INFO - Installing collected packages: psutil 13:50:48 INFO - Running setup.py install for psutil 13:50:48 INFO - building 'psutil._psutil_osx' extension 13:50:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:50:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:50:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:50:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:50:49 INFO - building 'psutil._psutil_posix' extension 13:50:49 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 13:50:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:50:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:50:49 INFO - ^ 13:50:49 INFO - 1 warning generated. 13:50:49 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 13:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:49 INFO - Successfully installed psutil 13:50:49 INFO - Cleaning up... 13:50:49 INFO - Return code: 0 13:50:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:50:49 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')]} 13:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:49 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')]} 13:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:49 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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:50:49 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 13:50:49 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 13:50:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:50:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:49 INFO - 'HOME': '/Users/cltbld', 13:50:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:49 INFO - 'LOGNAME': 'cltbld', 13:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:49 INFO - 'MOZ_NO_REMOTE': '1', 13:50:49 INFO - 'NO_EM_RESTART': '1', 13:50:49 INFO - 'PAGER': '/bin/cat', 13:50:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:49 INFO - 'PWD': '/builds/slave/test', 13:50:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:49 INFO - 'SHELL': '/bin/bash', 13:50:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:50:49 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:50:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:49 INFO - 'USER': 'cltbld', 13:50:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:49 INFO - 'XPC_FLAGS': '0x0', 13:50:49 INFO - 'XPC_SERVICE_NAME': '0', 13:50:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:50:52 INFO - Installing collected packages: mozsystemmonitor 13:50:52 INFO - Running setup.py install for mozsystemmonitor 13:50:52 INFO - Successfully installed mozsystemmonitor 13:50:52 INFO - Cleaning up... 13:50:52 INFO - Return code: 0 13:50:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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', '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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:50: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:50: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 jsonschema==2.5.1 13:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:52 INFO - 'HOME': '/Users/cltbld', 13:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:52 INFO - 'LOGNAME': 'cltbld', 13:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:52 INFO - 'MOZ_NO_REMOTE': '1', 13:50:52 INFO - 'NO_EM_RESTART': '1', 13:50:52 INFO - 'PAGER': '/bin/cat', 13:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:52 INFO - 'PWD': '/builds/slave/test', 13:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:52 INFO - 'SHELL': '/bin/bash', 13:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:50:52 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:52 INFO - 'USER': 'cltbld', 13:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:52 INFO - 'XPC_FLAGS': '0x0', 13:50:52 INFO - 'XPC_SERVICE_NAME': '0', 13:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:52 INFO - Downloading/unpacking jsonschema==2.5.1 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:50:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:50:55 INFO - warning: no files found matching '*.txt' 13:50:55 INFO - no previously-included directories found matching 'build' 13:50:55 INFO - no previously-included directories found matching 'dist' 13:50:55 INFO - no previously-included directories found matching '.git*' 13:50:55 INFO - Installing collected packages: jsonschema, functools32 13:50:56 INFO - Running setup.py install for functools32 13:50:56 INFO - warning: no files found matching '*.txt' 13:50:56 INFO - no previously-included directories found matching 'build' 13:50:56 INFO - no previously-included directories found matching 'dist' 13:50:56 INFO - no previously-included directories found matching '.git*' 13:50:56 INFO - Successfully installed jsonschema functools32 13:50:56 INFO - Cleaning up... 13:50:56 INFO - Return code: 0 13:50:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:56 INFO - 'HOME': '/Users/cltbld', 13:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:56 INFO - 'LOGNAME': 'cltbld', 13:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:56 INFO - 'MOZ_NO_REMOTE': '1', 13:50:56 INFO - 'NO_EM_RESTART': '1', 13:50:56 INFO - 'PAGER': '/bin/cat', 13:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:56 INFO - 'PWD': '/builds/slave/test', 13:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:56 INFO - 'SHELL': '/bin/bash', 13:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:50:56 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:56 INFO - 'USER': 'cltbld', 13:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:56 INFO - 'XPC_FLAGS': '0x0', 13:50:56 INFO - 'XPC_SERVICE_NAME': '0', 13:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:50:56 INFO - Cleaning up... 13:50:56 INFO - Return code: 0 13:50:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:56 INFO - 'HOME': '/Users/cltbld', 13:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:56 INFO - 'LOGNAME': 'cltbld', 13:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:56 INFO - 'MOZ_NO_REMOTE': '1', 13:50:56 INFO - 'NO_EM_RESTART': '1', 13:50:56 INFO - 'PAGER': '/bin/cat', 13:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:56 INFO - 'PWD': '/builds/slave/test', 13:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:56 INFO - 'SHELL': '/bin/bash', 13:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:50:56 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:56 INFO - 'USER': 'cltbld', 13:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:56 INFO - 'XPC_FLAGS': '0x0', 13:50:56 INFO - 'XPC_SERVICE_NAME': '0', 13:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:50:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:00 INFO - Downloading docopt-0.6.1.tar.gz 13:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:00 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:00 INFO - Running setup.py install for blobuploader 13:51:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:00 INFO - Running setup.py install for requests 13:51:01 INFO - Running setup.py install for docopt 13:51:01 INFO - Successfully installed blobuploader requests docopt 13:51:01 INFO - Cleaning up... 13:51:01 INFO - Return code: 0 13:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:01 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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:51:01 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 13:51:01 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 13:51:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:51:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:01 INFO - 'HOME': '/Users/cltbld', 13:51:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:01 INFO - 'LOGNAME': 'cltbld', 13:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:01 INFO - 'MOZ_NO_REMOTE': '1', 13:51:01 INFO - 'NO_EM_RESTART': '1', 13:51:01 INFO - 'PAGER': '/bin/cat', 13:51:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:01 INFO - 'PWD': '/builds/slave/test', 13:51:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:01 INFO - 'SHELL': '/bin/bash', 13:51:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:51:01 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:51:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:01 INFO - 'USER': 'cltbld', 13:51:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:01 INFO - 'XPC_FLAGS': '0x0', 13:51:01 INFO - 'XPC_SERVICE_NAME': '0', 13:51:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-_aw7i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-u4l5MC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-efvRAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-UTLshj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-e7t37f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-AogcBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-nhpE_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Zd7Hbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-rwLMoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-KXl6oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:02 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xrOTv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:03 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Y2mzRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:03 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-uaDOxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:03 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-fQJ_Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:03 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-tgNZn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:03 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-s2Th56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:03 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-tIeosN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:03 INFO - Running setup.py install for manifestparser 13:51:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:03 INFO - Running setup.py install for mozcrash 13:51:03 INFO - Running setup.py install for mozdebug 13:51:04 INFO - Running setup.py install for mozdevice 13:51:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Running setup.py install for mozfile 13:51:04 INFO - Running setup.py install for mozhttpd 13:51:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Running setup.py install for mozinfo 13:51:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Running setup.py install for mozInstall 13:51:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:04 INFO - Running setup.py install for mozleak 13:51:04 INFO - Running setup.py install for mozlog 13:51:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:05 INFO - Running setup.py install for moznetwork 13:51:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:05 INFO - Running setup.py install for mozprocess 13:51:05 INFO - Running setup.py install for mozprofile 13:51:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:05 INFO - Running setup.py install for mozrunner 13:51:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:05 INFO - Running setup.py install for mozscreenshot 13:51:05 INFO - Running setup.py install for moztest 13:51:06 INFO - Running setup.py install for mozversion 13:51:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:06 INFO - Cleaning up... 13:51:06 INFO - Return code: 0 13:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:06 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')]} 13:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:06 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')]} 13:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:06 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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:51:06 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 13:51:06 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 13:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:06 INFO - 'HOME': '/Users/cltbld', 13:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:06 INFO - 'LOGNAME': 'cltbld', 13:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:06 INFO - 'MOZ_NO_REMOTE': '1', 13:51:06 INFO - 'NO_EM_RESTART': '1', 13:51:06 INFO - 'PAGER': '/bin/cat', 13:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:06 INFO - 'PWD': '/builds/slave/test', 13:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:06 INFO - 'SHELL': '/bin/bash', 13:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:51:06 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:06 INFO - 'USER': 'cltbld', 13:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:06 INFO - 'XPC_FLAGS': '0x0', 13:51:06 INFO - 'XPC_SERVICE_NAME': '0', 13:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-CPmcbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:06 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)) 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Ca0vqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:06 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)) 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-XVKZQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:06 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)) 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8wIOdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:06 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)) 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-aMwLdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-lhR4ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mFkDJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-oqi4wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-js3_An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-uaqsfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VavhWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VAyb4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-FywVeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:07 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)) 13:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:07 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QuCI7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:08 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)) 13:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:08 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-MIjjRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:08 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)) 13:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:08 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Br_o0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:08 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Mhl40r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:08 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)) 13:51:08 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)) 13:51:08 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)) 13:51:08 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)) 13:51:08 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)) 13:51:08 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)) 13:51:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:10 INFO - Downloading blessings-1.6.tar.gz 13:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:11 INFO - Installing collected packages: blessings 13:51:11 INFO - Running setup.py install for blessings 13:51:11 INFO - Successfully installed blessings 13:51:11 INFO - Cleaning up... 13:51:11 INFO - Return code: 0 13:51:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:11 INFO - Reading from file tmpfile_stdout 13:51:11 INFO - Current package versions: 13:51:11 INFO - blessings == 1.6 13:51:11 INFO - blobuploader == 1.2.4 13:51:11 INFO - docopt == 0.6.1 13:51:11 INFO - functools32 == 3.2.3-2 13:51:11 INFO - jsonschema == 2.5.1 13:51:11 INFO - manifestparser == 1.1 13:51:11 INFO - mozInstall == 1.12 13:51:11 INFO - mozcrash == 1.0 13:51:11 INFO - mozdebug == 0.1 13:51:11 INFO - mozdevice == 0.48 13:51:11 INFO - mozfile == 1.2 13:51:11 INFO - mozhttpd == 0.7 13:51:11 INFO - mozinfo == 0.9 13:51:11 INFO - mozleak == 0.1 13:51:11 INFO - mozlog == 3.4 13:51:11 INFO - moznetwork == 0.27 13:51:11 INFO - mozprocess == 0.23 13:51:11 INFO - mozprofile == 0.28 13:51:11 INFO - mozrunner == 6.13 13:51:11 INFO - mozscreenshot == 0.1 13:51:11 INFO - mozsystemmonitor == 0.3 13:51:11 INFO - moztest == 0.8 13:51:11 INFO - mozversion == 1.4 13:51:11 INFO - psutil == 3.1.1 13:51:11 INFO - requests == 1.2.3 13:51:11 INFO - wsgiref == 0.1.2 13:51:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:12 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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:51:12 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 13:51:12 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 13:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:12 INFO - 'HOME': '/Users/cltbld', 13:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:12 INFO - 'LOGNAME': 'cltbld', 13:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:12 INFO - 'MOZ_NO_REMOTE': '1', 13:51:12 INFO - 'NO_EM_RESTART': '1', 13:51:12 INFO - 'PAGER': '/bin/cat', 13:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:12 INFO - 'PWD': '/builds/slave/test', 13:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:12 INFO - 'SHELL': '/bin/bash', 13:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:51:12 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:12 INFO - 'USER': 'cltbld', 13:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:12 INFO - 'XPC_FLAGS': '0x0', 13:51:12 INFO - 'XPC_SERVICE_NAME': '0', 13:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 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)) 13:51:12 INFO - Cleaning up... 13:51:12 INFO - Return code: 0 13:51:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:12 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')]} 13:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:12 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')]} 13:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:12 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 0x1089b4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7db4bf2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, '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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 13:51:12 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 13:51:12 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 13:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:12 INFO - 'HOME': '/Users/cltbld', 13:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:12 INFO - 'LOGNAME': 'cltbld', 13:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:12 INFO - 'MOZ_NO_REMOTE': '1', 13:51:12 INFO - 'NO_EM_RESTART': '1', 13:51:12 INFO - 'PAGER': '/bin/cat', 13:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:12 INFO - 'PWD': '/builds/slave/test', 13:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:12 INFO - 'SHELL': '/bin/bash', 13:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:51:12 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:12 INFO - 'USER': 'cltbld', 13:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:12 INFO - 'XPC_FLAGS': '0x0', 13:51:12 INFO - 'XPC_SERVICE_NAME': '0', 13:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:13 INFO - Cleaning up... 13:51:13 INFO - Return code: 0 13:51:13 INFO - Running post-action listener: _resource_record_post_action 13:51:13 INFO - Running post-action listener: _start_resource_monitoring 13:51:13 INFO - Starting resource monitoring. 13:51:13 INFO - [mozharness: 2017-02-23 21:51:13.221035Z] Finished create-virtualenv step (success) 13:51:13 INFO - [mozharness: 2017-02-23 21:51:13.222042Z] Running install step. 13:51:13 INFO - Running pre-action listener: _resource_record_pre_action 13:51:13 INFO - Running main action method: install 13:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:13 INFO - Reading from file tmpfile_stdout 13:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:13 INFO - Reading from file tmpfile_stdout 13:51:13 INFO - Output received: 13:51:13 INFO - Usage: mozinstall [options] installer 13:51:13 INFO - Options: 13:51:13 INFO - -h, --help show this help message and exit 13:51:13 INFO - -d DEST, --destination=DEST 13:51:13 INFO - Directory to install application into. [default: 13:51:13 INFO - "/builds/slave/test"] 13:51:13 INFO - --app=APP Application being installed. [default: firefox] 13:51:13 INFO - mkdir: /builds/slave/test/build/application 13:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:51:35 INFO - Reading from file tmpfile_stdout 13:51:35 INFO - Output received: 13:51:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:51:35 INFO - Running post-action listener: _resource_record_post_action 13:51:35 INFO - [mozharness: 2017-02-23 21:51:35.009676Z] Finished install step (success) 13:51:35 INFO - [mozharness: 2017-02-23 21:51:35.009803Z] Running run-tests step. 13:51:35 INFO - Running pre-action listener: _resource_record_pre_action 13:51:35 INFO - Running main action method: run_tests 13:51:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:51:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:51:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:51:35 INFO - 2017-02-23 13:51:35.024 screenresolution[1628:7402] starting screenresolution argv=screenresolution get 13:51:35 INFO - 2017-02-23 13:51:35.027 screenresolution[1628:7402] Display 0: 1600x1200x32@60 13:51:35 INFO - 2017-02-23 13:51:35.032 screenresolution[1629:7404] starting screenresolution argv=screenresolution list 13:51:35 INFO - Available Modes on Display 0 13:51:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:51:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:51:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:51:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:51:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:51:35 INFO - Intel Iris: 13:51:35 INFO - Chipset Model: Intel Iris 13:51:35 INFO - Type: GPU 13:51:35 INFO - Bus: Built-In 13:51:35 INFO - VRAM (Dynamic, Max): 1536 MB 13:51:35 INFO - Vendor: Intel (0x8086) 13:51:35 INFO - Device ID: 0x0a2e 13:51:35 INFO - Revision ID: 0x0009 13:51:35 INFO - Displays: 13:51:35 INFO - Display: 13:51:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:51:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:51:35 INFO - Display Serial Number: 1600x1200 60 13:51:35 INFO - Main Display: Yes 13:51:35 INFO - Mirror: Off 13:51:35 INFO - Online: Yes 13:51:35 INFO - Rotation: Supported 13:51:35 INFO - Return code: 0 13:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:51:35 INFO - Python 2.7.3 13:51:35 INFO - Return code: 0 13:51:35 INFO - grabbing minidump binary from tooltool 13:51:35 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')]} 13:51:35 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 0x1087c8d30>, '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 0x10862edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:51:35 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 13:51:35 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 13:51:35 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 13:51:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:51:35 INFO - Return code: 0 13:51:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:51:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:51:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:51:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:51:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 13:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --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 13:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h6HKdFQo2G/Render', 13:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:35 INFO - 'HOME': '/Users/cltbld', 13:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PAGER': '/bin/cat', 13:51:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pY9mPYdo4w/Listeners', 13:51:35 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 13:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - 'XPC_FLAGS': '0x0', 13:51:35 INFO - 'XPC_SERVICE_NAME': '0', 13:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 13:51:35 INFO - mozversion application_buildid: 20170223120822 13:51:35 INFO - mozversion application_changeset: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 13:51:35 INFO - mozversion application_display_name: Firefox 13:51:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:51:35 INFO - mozversion application_name: Firefox 13:51:35 INFO - mozversion application_remotingname: firefox 13:51:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:51:35 INFO - mozversion application_vendor: Mozilla 13:51:35 INFO - mozversion application_version: 52.0 13:51:35 INFO - mozversion platform_buildid: 20170223120822 13:51:35 INFO - mozversion platform_changeset: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 13:51:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:51:35 INFO - mozversion platform_version: 52.0 13:51:35 INFO - using testdate: 1487886695 13:51:35 INFO - actual date: 1487886695 13:51:35 INFO - starting webserver on 'localhost:49240' 13:51:35 INFO - SUITE-START | Running 2 tests 13:51:35 INFO - TEST-START | dromaeo_css 13:51:35 INFO - operating with platform_type : mac_ 13:51:35 INFO - Initialising browser for dromaeo_css test... 13:51:35 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpKkiuGp/profile http://localhost:49240/getInfo.html) 13:51:38 INFO - PROCESS | 1639 | 2017-02-23 13:51:38.500 plugin-container[1642:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c37, name = 'com.apple.tsm.portname' 13:51:38 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:38 INFO - PROCESS | 1639 | 2017-02-23 13:51:38.501 plugin-container[1642:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 13:51:38 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:38 INFO - PROCESS | 1639 | 2017-02-23 13:51:38.501 plugin-container[1642:7588] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:51:38 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 13:51:38 INFO - PROCESS | 1639 | colorDepth:24 13:51:38 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 13:51:38 INFO - PROCESS | 1639 | __metrics 13:51:38 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:51:39 INFO - TEST-INFO | 1639: exit 0 13:51:39 INFO - Browser initialized. 13:51:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:51:39 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpKkiuGp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:41 INFO - PROCESS | 1643 | 2017-02-23 13:51:41.787 plugin-container[1644:7730] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864b, name = 'com.apple.tsm.portname' 13:51:41 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:41 INFO - PROCESS | 1643 | 2017-02-23 13:51:41.788 plugin-container[1644:7730] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 13:51:41 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:51:41 INFO - PROCESS | 1643 | 2017-02-23 13:51:41.788 plugin-container[1644:7730] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:51:51 INFO - PROCESS | 1643 | RSS: Main: 177545216 13:51:51 INFO - PROCESS | 1643 | 13:54:54 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:54:56 INFO - PROCESS | 1643 | RSS: Main: 182059008 13:54:56 INFO - PROCESS | 1643 | 13:57:58 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:57:58 INFO - PROCESS | 1643 | RSS: Main: 191922176 13:57:58 INFO - PROCESS | 1643 | 14:01:00 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 14:01:01 INFO - PROCESS | 1643 | RSS: Main: 194498560 14:01:01 INFO - PROCESS | 1643 | 14:04:03 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:04:03 INFO - PROCESS | 1643 | RSS: Main: 199045120 14:04:03 INFO - PROCESS | 1643 | 14:07:06 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:07:07 INFO - PROCESS | 1643 | RSS: Main: 201404416 14:07:07 INFO - PROCESS | 1643 | 14:10:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:10:10 INFO - PROCESS | 1643 | RSS: Main: 201764864 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | __start_tp_report 14:10:10 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:10:10 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:10:10 INFO - PROCESS | 1643 | |i|pagename|runs| 14:10:10 INFO - PROCESS | 1643 | |0;dojo.html;3567.6253993330697;3579.087332730155;3579.910502237445;3607.116256517153;3642.3625865473537;5940.88118237635;5981.162637230791;5992.011318132503;6016.879662406749;6029.246344206974;4822.107910036646;5296.364436267643;5777.306723193223;5976.252968378953;6035.456808887199;4457.398251236074;5322.893542129155;5343.599230057742;5378.569714422856;5419.403865574804;5423.728813559326;5459.69971651559;5478.506934375905;5510.366307874586;5513.50378465938;5290.418054014055;5319.0957537218765;5456.672599644034;5466.890662186774;5468.6171967962255;5340;5343.492368225013;5383.757730902119;5415.539679127279;5461.726913654302;5249.396319423239;5371.301730774974;5379.542738867201;5391.622586418952;5394.352677678665;6033.728482218311;6038.667873266969;6061.878762424727;6096.908546371808;6131.570790044699;6193.256809182927;6217.87564248717;6229.87540249197;6233.625982441068;6264.091706702548;6219.595726277777;6275.780347687809;6282.591631543935;6296;6296.433321001132;6049.122877182828;6077.088436734525;6090.599162192632;6091.238595175603;6094.238220222473;6359.268684101387;6373.426391624684;6437.7103030362805;6473.320301368382;6477.805665829938;6248.250209974832;6264.843378915563;6283.7800676976085;6303.621782693053;6304.306526282106;6147.72335244915;6343.714532846033;6356.110144579762;6356.841078973062;6379.617222966544;6151.907721384183;6201.96899015502;6243.500519958392;6271.623702577769;6315.242170939517;5054.494550544916;6259.061140828821;6270.059491076284;6280;6294.622322660655;5085.4914508548845;5098.821541246039;5111.207762796773;5112.795488180505;5119.692818430906;4499.730016199039;4503.482099558592;4528.637708983273;4531.886702832389;4587.9082418351445;5972.223610930551;6098.054801505774;6178.62928224308;6180.4437600615265;6221.688915554204;6278.937210627927;6285.340039295899;6337.081123237105;6364.363563643691;6366.140571022946;6099.9390006099375;6102.72537735803;6113.902014424272;6146.6004709693725;6176.227971503562;5641.943580564224;5643.463870932255;5650.152477128464;5653.123765816305;5697.601167918288;6502.577332473374;6550.8362290943105;6558.983357579583;6561.179852518435;6578.703958321983;6181.876362472635;6203.565750397429;6234.251889773075;6261.812145635638;6336.904946425715;6575.736970521317;6577.309382514767;6589.143411356493;6602.801915942529;6618.70215840298;6213.96893015532;6297.370262973849;6318.715657795318;6324.968375158095;6331.366863313632;6131.223750760645;6180.165677633642;6206.751729930752;6363.3636636336;6392.9360706392345;6141.547378150984;6223.595466294676;6248.125262463168;6248.375162483715;6255.155554000152;6231.501479881689;6233.625982441068;6238.376162383725;6238.844028899314;6251.71867265965;6086.543509236736;6090.390960903874;6111.8956224267595;6199.256089269316;6226.62640241587;6141.570090093651;6200.503959683305;6212.844678883064;6233.501319894307;6251.4061164189325;5488.204210389391;5888.17565540816;6192.938070619416;6198.504119670325;6198.752049917953 14:10:10 INFO - PROCESS | 1643 | |1;ext.html;479.9832005879794;546.4699241735518;547.1109447148382;577.1717585265142;577.9683265371314;38003.61996380035;39764;40492.39261411081;40531.79734101329;40602.98492537688;36477.45283820745;36651.4502282466;41383.58616413835;42769.78615106928;42844;8579.056303806576;9599.136077753019;9759.75600609987;9786.266030047775;9798.951005244999;9632.181264592518;9683.322167448247;9758.316917815755;9767;9795.06946840049;8395.370347223952;9654.13112819846;9685.515724213761;9696.75758106046;9714.465704386255;9733.07535784103;9782.755431114208;9838.458884761336;9844.409335439897;9854.753631159207;9719.757006074835;9723.173530249936;9756.170725488342;9769.316147869651;9788.119069283728;34602.48096278558;40268.79865600653;40388.99027524306;40640;40774.388384174265;3397.8470968806214;3449.7757645753195;3465.8380160038055;3962.056077564465;4055.3916912463073;29645.851770741225;29799.70200297991;30269.848650756827;30502.389952200832;32393.028209153763;3238.886638967625;3245.7403407727325;3317.485789702576;3380.577427821522;3438.6905178534053;414833;503735;506823;507673.99999999633;507821;62352.688236558526;62498;62815;62907;63028.36971630317;64074.679626601566;65574;65648.01527977084;66103.33896661068;66177.67644647177;16777.328906843588;16898.83101168997;17111.74332385015;17124.14379281031;17171.828281717022;12847.421866015864;13177.802332964822;13186.472541098441;13197.076204665582;13247.536336228186;16444.76664250186;18000.639987200182;18117.275308987755;18138.727919081226;18294.725579116322;3271.198556353661;5748.5688573357165;6449.806505804833;6617.9669101655145;6626.370494802986;887.7869311365226;957.812312732221;982.3025651787168;1050.3540322701635;1076.34343050739;29982.650780714484;30433.847830761148;30633.234169145504;30971;31282.374352512823;953.3564843730593;1032.5456799008412;1094.956201751921;1098.3080659184823;1163.1276542593055;13952.534983826756;15146.924265378602;16051.839481605268;16083.758743618855;16181.4336498222;688926;695177;696332;696408;696574;49886;58367;58889;58997;59002.11496827551;1353.8781509663982;1373.2515778900524;1399.4262352435453;1404.2206575350574;1408.3521580073077;28613;29658.110256692333;29728.959486417873;30550.541741873447;30701.53947690742;49044.509554905424;57703.71148144401;59255.11117333157;59566;62319.06521402092;609394;613045;619321.9033904981;620625;621352.7864721295;43809.78095109504;43825.34261986009;44334.89162770956;44405;44452.33321500245;47587;47926;48037;48407.75796121138;49177.508224918725;38545.6145438542;39516;39707.2058558833;40630.18739625132;40951;35891.820540897126;37353;37712.24575508529;38000;38471.422928655535;38369.4244586337;39317.41023884701;39426;39550.60449395469;41202;31023.68976310208;34217.97346079622;34914.65085349114;34985.82507087448;35038.82480587683;26355.077572285645;26355.868220658773;26378;26622.201333959238;26799 14:10:10 INFO - PROCESS | 1643 | |2;jquery.html;303.8921182980042;331.74600011954806;369.4310761427401;403.53593367627207;417.52610786757043;16500.917495412523;17076.829231707678;19595.5101122472;19990.7001394979;20085.136998621027;19757.50606234845;20433.386998390073;20738.066786994583;20743.377698669065;20950.685739713917;5689.943100569003;5730.9426905730825;5841.474267315941;5916.556258280624;5946.108083787445;5641.858953526174;5761.596688231825;5811.796587119452;5818.359980402152;5819;5167.4574169712205;5515.944840551603;5610.214569960209;5704.286964129484;5714.171445140452;5707.65754054756;5710.857228569319;5784.421557844203;5806.883862322772;5817.825465236049;5036.899262014739;5100.056489549445;5144.511271429208;5151.45909679482;5429.701366424845;13192.472301107944;13247;13451.798223026663;13452;16175.514734557983;2077.314486219544;2347.9882600587057;2496.2012156110054;2570.3831080540535;2626.75045870642;10146.492675366202;10421.166306695446;12005.219660722112;15271.541853744406;15632.983856049434;1676.983230167695;1758.516407987801;1847.8706490545667;1849.5561065344355;1855.4433669898976;124115;126802.36598816946;126954.36522817326;127544.36227818801;132063;11568.942155289169;11768.470418831173;11924.403779811148;12039.63881083569;12270.447829847679;14913.179775112472;14983.951123421473;15054.247287635575;15058;15072.698546029018;8495.320374370036;8878.73363799087;8891.333150013776;8931.151540603632;8970.82058358829;8819.236152769472;8820.382573219813;8846.601902914384;8979.191872731355;9017.053209413049;4012.277789997828;4077;4317.438732964694;4532.388127602731;4621.6764826462495;1654.9503514894573;2007.6687346587942;2009.7889721579315;2015.6976453532088;2027.2397850805949;837;888.8089060851947;907.8728977943093;931.2038207332633;953.8125034332162;20014.69977950332;21305.467363316042;21319.147234110773;21334.03996820147;21643.891780541;961.8653388525612;972.547765289144;1007.3804610164842;1011.1405305490422;1033.266380869576;10730.946345268223;11069.667909962714;11202.775944481065;11999.520019199133;12208.694782630328;623870;629194;635617;637498.8125059438;640138;119055;119442.61114777655;130083;135811.6418835799;136782;975.8877729061107;1009.2329829329763;1037.8339465685606;1039.0285083447002;1044.300318786415;16636;18069.006204658344;18510.907445462686;19277.22891084341;19363.225470981568;53955.190672139164;54285.45714542962;54806.177907330624;55478.72260638671;56812.43187568237;80635.59682201552;81072.18927810647;83168;83344.58327708322;84181.57909210415;7129.607871566906;7878.369730421668;8012.118666946515;8056.11382747909;8194.22154895284;12036.097292702907;12408;12579.433925473559;12607.873921261036;12631.93684031574;10616.681499555025;10711.94644026775;11065.004149626573;11101.888981110409;11169.888301116885;8674.696385626472;10800.351978880977;10902.781944361226;10945.288556243819;11175.888241117485;10895.237333386587;11093.833592496281;11288.322700637988;11304.152188586053;11316.94341528287;6762.8647427052165;7009.474289428212;7392.26077392278;7444.739434119996;8054.879176812469;8933.374663773473;10674.35953842772;10765.515551800032;10931.890681093088;11357.432128393713 14:10:10 INFO - PROCESS | 1643 | |3;mootools.html;1460.5472303585889;1480.5706345159904;1705.5906582420216;1817.8454831339336;1875.5311172206948;7689.231076892308;7912.6439310231035;8182.386321025924;8636.524991125485;8640.567971601418;8099.91900080999;8392.664293428255;8422.747317580466;8504.107068757785;8534.57327133644;2385.6660067590506;2416.1301931304715;2416.504616553611;2417.576924038295;2419.0323870451784;2389.23544465771;2414.915477958272;2433.3551608823677;2434.075051480444;2436.878156092197;2077.6156411063926;2382.404398900275;2387.6776635154292;2408.4580969281947;2419.1170222868614;2365.077619728307;2372.9406764830846;2380.4881950380664;2388.2118900762707;2412.2522018174423;2364.929052128439;2398.9520209595885;2405.6511805788236;2412.915547955831;2418.709754829432;8537.829243415097;8583.270422014137;8584.442011269248;8627.40393027292;8642.395032347738;5210.374755029383;5365.222042803772;5375.758090885881;5382.4886635769535;5390.78436862525;3140.1992491914643;3497.387957107496;3516.4901089342156;3523.6300188480354;3584.2473080653094;1053.5733028123545;1066.4134725900801;1077.7682798198346;1117.0672488472135;1129.728865072385;11038.724031899186;11077.446127693584;11077.99999999992;11089.445527723663;11107.611233606785;4517.728936263835;4576.313552967015;4622.791974361162;4627.9768601156775;4840.782164802592;9555.378900371454;9579.952100239594;9589.520523973773;9599.136077753035;9607;4630.28230624247;5328;5334.119870221448;5338.412774594792;5342.652727572696;4379.934300985424;4400.031992961607;4817.445993710698;4878.56092951636;4892.241702536113;3863.169418574964;3915;3968.940465893014;4004.619561141745;4022.316206244887;1306.0596370613143;1315.7302752935816;1318.5253308809013;1326.827512423398;1334.2794890759076;792.7780221537979;798.1778767869104;898.4923518212189;904.8506996345661;922.7739203895088;5580.218769372291;5591.189277554732;5601.80393686219;5770.19217309577;5843.766249349978;983.7245571240064;1022.8721409823772;1036.3212096077082;1047.586203449633;1069.973250668724;3795.81020948957;3853.499045124116;3866.2654095721723;3935.9606403935595;3964.4251583520804;9568.712938611714;9612.807743845084;9983.351082179635;10152.23858210637;10367.170626349875;9842.557084931195;10180.745481362877;10284.537195826206;10284.897151028394;10335.689929302132;7606.8098297543;7962.7213047543055;7976.082750483769;7987.281144697005;8017.438779285394;5016.523430274118;5506.421825708403;5507.284053073236;5587.860303492283;5768.1636162757;9368.625254989724;9398.483083430478;9463.574139163617;9484.051594840737;9501.57242924084;9552.90447095548;9641.37331073478;9643.27675424332;9739;9767.365121267096;6363.6818159090935;6451.806445806634;6671.799846004627;6805.319468053155;6903.896441553481;7931.444798864024;8093.919060809317;8127.634256458356;8146.511209327459;8148.103708592169;6053.727582258721;7143;7238.6018768968215;7321.524100933422;7374.520656157332;7041.802893508218;7118.323759242864;7125.429965602636;7146.071010768567;7250.456215783732;5310.867228319323;5888.764449422147;5912.320083190488;6399.488040956805;6749.055132281386;4718.811247550197;4777.402824646919;4781.5935645469135;4826.8069277228515;4833.564979151894;4737.692050016875;4831.371921650163;4888.193448081027;4943.925841112315;4996.675216110941 14:10:10 INFO - PROCESS | 1643 | |4;prototype.html;307.3698917219699;314.7560640503609;321.3861524488227;324.57156553349586;325.38177462820636;4578.4963653998075;5370.731463426832;5470.699111548864;5512.531434828034;5531.723413829302;5062.164742817431;5249.737513124348;5405.351357837055;5422.945770542294;5450.618456708032;3454.533637958881;3476.687098161165;3893.800002998311;4186.204621121977;4189.874303770892;3518.9443167049913;3839.34731095713;4190.434291370657;4204.432401625787;4216.873493795176;3735.2529494101154;4041.373587094005;4108.8356465741335;4125.834966601333;4126.5667104953845;4022.3363145081025;4105.7418419869255;4129.256733787917;4144.668426525871;4175.874723758292;3150.5979838971666;3422.161570415264;3598.1394791141106;3606.972012976289;3626.746127771057;4409.536998615164;4970.329005584236;5274.810953454312;5317.548008419289;5370.979513892348;3922;4544.88637784058;4707.882302942419;4733.928991065137;4744.95610965587;4597.3793537872625;4775.689580177277;4979.601631869478;5069.645124841262;5754.482096611283;3288.3094550144497;3423.7432192585657;3554.964450355489;3902.590228026073;3962.603739626043;5780.456599096384;5879.235699359098;5976.641401515923;6005.759769609211;6015.608985415934;3974.4038394240515;3985.960140398617;4002.9799851000557;4004.8798536043964;4006.779627120478;3418.7265018798435;3688.3914154164263;3780.773153610792;3994.7403418777685;4025.6376926076796;4338.74176488821;4690.507496712864;4694.2958556216845;4721.693089949211;4755.57199852008;5056.418511871108;5440.537554307928;5756.597038207369;5792.391798861059;5810.941890581124;1152.4180288954024;1255.3848614178987;1265.9050571207197;1289.954851580209;1323.4706117552864;812.321711371;868.2880038368603;890.3900827932887;891.9821603567892;902.3142411766974;4977.601791856643;5103.234514822732;5132.28148059272;5201.505856943584;5245.344331958505;5415.512603865671;5573.080441727069;5636.464535869168;5646.322441307069;5647.858803529944;4389.868303950887;4731;5136.481510165549;5167.431582525919;5196.45437229093;2739.493193759161;2880.775670340097;2926.707329267099;2928.535732133933;2945.9247374708507;5598.58010649203;5831.94168058314;5845.18799172258;5895.027320492157;5910.940890591125;5466.316710411199;5766.855828604318;5770.740316685759;5793.768249269982;5856.443637854397;4688.929666055012;5238.109521381298;5343.931213757186;5724.570657200643;5923.289205295392;5032.295478632921;5342.893142137058;5435.945640543544;5627.8874422512135;5667.376588575171;4780.474147843804;4832.903341933212;5306.42638320422;5502.257195278747;5569.157281475769;5063.5695965843315;5444.346678398618;5484.341878974389;5854.531637469077;5873.530117590497;3462.601800792941;3639.9272014560092;3641.9089522761083;3649.872254471081;3808.095952023988;4405.515393306798;4896.6572339935865;5067.70599110581;5445.455454454523;5616.8715993743745;5038.908852826036;5533.889322213453;5620.74706638194;5719.655880868076;5885.881682480315;5245.344331958505;5293.391260005149;5302.859885124717;5607.579431542732;5783.681897495678;4396.153615481441;5201.765920533509;5207.1668533034535;5648.604597678123;5709.857253568694;5044.646874718735;5443.52319694546;5681.744321505625;5716.828495145152;5759.596828221985;4999.775010124626;5568.6658800472105;5621.550275977994;5635.690037048002;5711.857203569944 14:10:10 INFO - PROCESS | 1643 | |5;yui.html;688.8002479281009;762.7635433015765;779.3375630713892;794.4915254237293;810.8864758933751;14944.925275373622;15574.844251557495;15611.921940390283;15643.296051677673;15646.608834779136;13714.24571648559;13802.723945521084;13811.654708632264;13824.377902994363;13885;707.9946476004073;749.3031480722925;865.709987154304;868.8827008353854;869.8477766390888;851.0340763233743;852.8592782190931;853.0616322045731;855.2260204514924;856.7729551668813;772.9690812367498;886.0032463478586;898.6944438890775;901.7520181949951;902.9683961061364;857.8756080368343;863.0032312678866;875.5797217335682;879.1340529578392;893.5710858787753;649.0134994807913;650.6909218121402;658.4929604204735;674.1404708996021;674.197704731368;12645.241285522898;12726.10917235794;12740.745185096339;12753.681157971032;12926.547570834975;11283.492242849092;11562.88437115635;11996.70008249792;12422.06834487408;12574.68563285916;11953.163278570504;12290.446929888176;12407.07103792587;12533;12662.81005784914;3946.506686664167;4506.391637128979;4549.772511374451;4561.156186105581;4795.688280261772;91058;93484.53257733736;96551.51724241405;96762.51618741931;97576;10354.482275886176;10467.371957682564;10572.418516981486;10591.735206619742;10827.296225745302;19529.902350488155;19606.80393196078;19649.901750491157;19698.70451943222;20013.299534516224;6636.966815165893;6651.534392592569;7489.400847932152;7620.161782203953;7848.175941526171;3851.6340947609933;4319.719218250803;4453;4519.9774001130445;4599.747013914267;3285.8849940251976;3349.2296771742635;3379.7803142795638;3400.540926974876;3403.3193361327835;560.8054843183992;625.4183609243356;631.8294060603612;638.7381173718753;654.9050387693853;534.959878009143;541.9214213939035;566.8837888232903;580.9041508151108;587.2395248153651;7355.5954422507275;8447;8855.822883542292;8859.778505537413;9128.22410095136;588.8213165211971;600.3140716003741;625.9937400625936;639.9008153736179;644.4168027934633;3931.7051221158526;4260.211860805761;4279.186954478639;4348.195583817004;4395.802188901507;80675.59662201651;91452;115370;118653;122538.77461225452;92626;103137;103496;103900.96099039064;103912.48043759733;73535.63232183804;82595.5870220645;92392.07607923969;93369.53315233381;97484;9438.087821242558;9731.562079706571;9908.900910990798;9990.600375984879;10029.197664186993;50881.47355579338;51543.74228128835;53128.399620740485;54785.72607136939;55608;70258;70764.93852592318;71011.64494177702;74881.62559187169;76451;11711.707207319885;12552;12571.622851314476;12624;12738.745225095261;13877.306134693426;14025.438982440995;14034.859651403356;14362.425502979764;14478.420863165355;12716.809247861105;13104.934475327944;13249.1642045373;13251;13268.27024513661;12293.83208595182;12825.486980521047;13346.799798002843;13349.799753003519;14000.369983350978;12075.879241207476;12297.508099675913;13074.09280691816;13175.538856139989;13269.137506062076;10681.732956676145;10843.837342439712;10959;11063.446827658423;11068.501917413574;9286.582103805209;9649.758756031155;11035.613753518588;11288.322700637988;11411.942940285246 14:10:10 INFO - PROCESS | 1643 | __end_tp_report 14:10:10 INFO - PROCESS | 1643 | __start_cc_report 14:10:10 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,369 14:10:10 INFO - PROCESS | 1643 | __end_cc_report 14:10:10 INFO - PROCESS | 1643 | __startTimestamp1487887810043__endTimestamp 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:10:10 INFO - PROCESS | 1643 | Number of tests: 6 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5895.31 Median:6176.23 stddev:634.82 (10.3%) stddev-sans-first:609.94 14:10:10 INFO - PROCESS | 1643 | Values: 3567.6 3579.1 3579.9 3607.1 3642.4 5940.9 5981.2 5992.0 6016.9 6029.2 4822.1 5296.4 5777.3 5976.3 6035.5 4457.4 5322.9 5343.6 5378.6 5419.4 5423.7 5459.7 5478.5 5510.4 5513.5 5290.4 5319.1 5456.7 5466.9 5468.6 5340.0 5343.5 5383.8 5415.5 5461.7 5249.4 5371.3 5379.5 5391.6 5394.4 6033.7 6038.7 6061.9 6096.9 6131.6 6193.3 6217.9 6229.9 6233.6 6264.1 6219.6 6275.8 6282.6 6296.0 6296.4 6049.1 6077.1 6090.6 6091.2 6094.2 6359.3 6373.4 6437.7 6473.3 6477.8 6248.3 6264.8 6283.8 6303.6 6304.3 6147.7 6343.7 6356.1 6356.8 6379.6 6151.9 6202.0 6243.5 6271.6 6315.2 5054.5 6259.1 6270.1 6280.0 6294.6 5085.5 5098.8 5111.2 5112.8 5119.7 4499.7 4503.5 4528.6 4531.9 4587.9 5972.2 6098.1 6178.6 6180.4 6221.7 6278.9 6285.3 6337.1 6364.4 6366.1 6099.9 6102.7 6113.9 6146.6 6176.2 5641.9 5643.5 5650.2 5653.1 5697.6 6502.6 6550.8 6559.0 6561.2 6578.7 6181.9 6203.6 6234.3 6261.8 6336.9 6575.7 6577.3 6589.1 6602.8 6618.7 6214.0 6297.4 6318.7 6325.0 6331.4 6131.2 6180.2 6206.8 6363.4 6392.9 6141.5 6223.6 6248.1 6248.4 6255.2 6231.5 6233.6 6238.4 6238.8 6251.7 6086.5 6090.4 6111.9 6199.3 6226.6 6141.6 6200.5 6212.8 6233.5 6251.4 5488.2 5888.2 6192.9 6198.5 6198.8 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:73637.82 Median:40707.19 stddev:162216.22 (398.5%) stddev-sans-first:162578.29 14:10:10 INFO - PROCESS | 1643 | Values: 480.0 546.5 547.1 577.2 578.0 38003.6 39764.0 40492.4 40531.8 40603.0 36477.5 36651.5 41383.6 42769.8 42844.0 8579.1 9599.1 9759.8 9786.3 9799.0 9632.2 9683.3 9758.3 9767.0 9795.1 8395.4 9654.1 9685.5 9696.8 9714.5 9733.1 9782.8 9838.5 9844.4 9854.8 9719.8 9723.2 9756.2 9769.3 9788.1 34602.5 40268.8 40389.0 40640.0 40774.4 3397.8 3449.8 3465.8 3962.1 4055.4 29645.9 29799.7 30269.8 30502.4 32393.0 3238.9 3245.7 3317.5 3380.6 3438.7 414833.0 503735.0 506823.0 507674.0 507821.0 62352.7 62498.0 62815.0 62907.0 63028.4 64074.7 65574.0 65648.0 66103.3 66177.7 16777.3 16898.8 17111.7 17124.1 17171.8 12847.4 13177.8 13186.5 13197.1 13247.5 16444.8 18000.6 18117.3 18138.7 18294.7 3271.2 5748.6 6449.8 6618.0 6626.4 887.8 957.8 982.3 1050.4 1076.3 29982.7 30433.8 30633.2 30971.0 31282.4 953.4 1032.5 1095.0 1098.3 1163.1 13952.5 15146.9 16051.8 16083.8 16181.4 688926.0 695177.0 696332.0 696408.0 696574.0 49886.0 58367.0 58889.0 58997.0 59002.1 1353.9 1373.3 1399.4 1404.2 1408.4 28613.0 29658.1 29729.0 30550.5 30701.5 49044.5 57703.7 59255.1 59566.0 62319.1 609394.0 613045.0 619321.9 620625.0 621352.8 43809.8 43825.3 44334.9 44405.0 44452.3 47587.0 47926.0 48037.0 48407.8 49177.5 38545.6 39516.0 39707.2 40630.2 40951.0 35891.8 37353.0 37712.2 38000.0 38471.4 38369.4 39317.4 39426.0 39550.6 41202.0 31023.7 34218.0 34914.7 34985.8 35038.8 26355.1 26355.9 26378.0 26622.2 26799.0 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:36126.07 Median:11514.00 stddev:105727.42 (918.3%) stddev-sans-first:105989.79 14:10:10 INFO - PROCESS | 1643 | Values: 303.9 331.7 369.4 403.5 417.5 16500.9 17076.8 19595.5 19990.7 20085.1 19757.5 20433.4 20738.1 20743.4 20950.7 5689.9 5730.9 5841.5 5916.6 5946.1 5641.9 5761.6 5811.8 5818.4 5819.0 5167.5 5515.9 5610.2 5704.3 5714.2 5707.7 5710.9 5784.4 5806.9 5817.8 5036.9 5100.1 5144.5 5151.5 5429.7 13192.5 13247.0 13451.8 13452.0 16175.5 2077.3 2348.0 2496.2 2570.4 2626.8 10146.5 10421.2 12005.2 15271.5 15633.0 1677.0 1758.5 1847.9 1849.6 1855.4 124115.0 126802.4 126954.4 127544.4 132063.0 11568.9 11768.5 11924.4 12039.6 12270.4 14913.2 14984.0 15054.2 15058.0 15072.7 8495.3 8878.7 8891.3 8931.2 8970.8 8819.2 8820.4 8846.6 8979.2 9017.1 4012.3 4077.0 4317.4 4532.4 4621.7 1655.0 2007.7 2009.8 2015.7 2027.2 837.0 888.8 907.9 931.2 953.8 20014.7 21305.5 21319.1 21334.0 21643.9 961.9 972.5 1007.4 1011.1 1033.3 10730.9 11069.7 11202.8 11999.5 12208.7 623870.0 629194.0 635617.0 637498.8 640138.0 119055.0 119442.6 130083.0 135811.6 136782.0 975.9 1009.2 1037.8 1039.0 1044.3 16636.0 18069.0 18510.9 19277.2 19363.2 53955.2 54285.5 54806.2 55478.7 56812.4 80635.6 81072.2 83168.0 83344.6 84181.6 7129.6 7878.4 8012.1 8056.1 8194.2 12036.1 12408.0 12579.4 12607.9 12631.9 10616.7 10711.9 11065.0 11101.9 11169.9 8674.7 10800.4 10902.8 10945.3 11175.9 10895.2 11093.8 11288.3 11304.2 11316.9 6762.9 7009.5 7392.3 7444.7 8054.9 8933.4 10674.4 10765.5 10931.9 11357.4 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5495.50 Median:5006.60 stddev:2994.75 (59.8%) stddev-sans-first:2987.80 14:10:10 INFO - PROCESS | 1643 | Values: 1460.5 1480.6 1705.6 1817.8 1875.5 7689.2 7912.6 8182.4 8636.5 8640.6 8099.9 8392.7 8422.7 8504.1 8534.6 2385.7 2416.1 2416.5 2417.6 2419.0 2389.2 2414.9 2433.4 2434.1 2436.9 2077.6 2382.4 2387.7 2408.5 2419.1 2365.1 2372.9 2380.5 2388.2 2412.3 2364.9 2399.0 2405.7 2412.9 2418.7 8537.8 8583.3 8584.4 8627.4 8642.4 5210.4 5365.2 5375.8 5382.5 5390.8 3140.2 3497.4 3516.5 3523.6 3584.2 1053.6 1066.4 1077.8 1117.1 1129.7 11038.7 11077.4 11078.0 11089.4 11107.6 4517.7 4576.3 4622.8 4628.0 4840.8 9555.4 9580.0 9589.5 9599.1 9607.0 4630.3 5328.0 5334.1 5338.4 5342.7 4379.9 4400.0 4817.4 4878.6 4892.2 3863.2 3915.0 3968.9 4004.6 4022.3 1306.1 1315.7 1318.5 1326.8 1334.3 792.8 798.2 898.5 904.9 922.8 5580.2 5591.2 5601.8 5770.2 5843.8 983.7 1022.9 1036.3 1047.6 1070.0 3795.8 3853.5 3866.3 3936.0 3964.4 9568.7 9612.8 9983.4 10152.2 10367.2 9842.6 10180.7 10284.5 10284.9 10335.7 7606.8 7962.7 7976.1 7987.3 8017.4 5016.5 5506.4 5507.3 5587.9 5768.2 9368.6 9398.5 9463.6 9484.1 9501.6 9552.9 9641.4 9643.3 9739.0 9767.4 6363.7 6451.8 6671.8 6805.3 6903.9 7931.4 8093.9 8127.6 8146.5 8148.1 6053.7 7143.0 7238.6 7321.5 7374.5 7041.8 7118.3 7125.4 7146.1 7250.5 5310.9 5888.8 5912.3 6399.5 6749.1 4718.8 4777.4 4781.6 4826.8 4833.6 4737.7 4831.4 4888.2 4943.9 4996.7 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4508.92 Median:5062.87 stddev:1385.50 (27.4%) stddev-sans-first:1353.02 14:10:10 INFO - PROCESS | 1643 | Values: 307.4 314.8 321.4 324.6 325.4 4578.5 5370.7 5470.7 5512.5 5531.7 5062.2 5249.7 5405.4 5422.9 5450.6 3454.5 3476.7 3893.8 4186.2 4189.9 3518.9 3839.3 4190.4 4204.4 4216.9 3735.3 4041.4 4108.8 4125.8 4126.6 4022.3 4105.7 4129.3 4144.7 4175.9 3150.6 3422.2 3598.1 3607.0 3626.7 4409.5 4970.3 5274.8 5317.5 5371.0 3922.0 4544.9 4707.9 4733.9 4745.0 4597.4 4775.7 4979.6 5069.6 5754.5 3288.3 3423.7 3555.0 3902.6 3962.6 5780.5 5879.2 5976.6 6005.8 6015.6 3974.4 3986.0 4003.0 4004.9 4006.8 3418.7 3688.4 3780.8 3994.7 4025.6 4338.7 4690.5 4694.3 4721.7 4755.6 5056.4 5440.5 5756.6 5792.4 5810.9 1152.4 1255.4 1265.9 1290.0 1323.5 812.3 868.3 890.4 892.0 902.3 4977.6 5103.2 5132.3 5201.5 5245.3 5415.5 5573.1 5636.5 5646.3 5647.9 4389.9 4731.0 5136.5 5167.4 5196.5 2739.5 2880.8 2926.7 2928.5 2945.9 5598.6 5831.9 5845.2 5895.0 5910.9 5466.3 5766.9 5770.7 5793.8 5856.4 4688.9 5238.1 5343.9 5724.6 5923.3 5032.3 5342.9 5435.9 5627.9 5667.4 4780.5 4832.9 5306.4 5502.3 5569.2 5063.6 5444.3 5484.3 5854.5 5873.5 3462.6 3639.9 3641.9 3649.9 3808.1 4405.5 4896.7 5067.7 5445.5 5616.9 5038.9 5533.9 5620.7 5719.7 5885.9 5245.3 5293.4 5302.9 5607.6 5783.7 4396.2 5201.8 5207.2 5648.6 5709.9 5044.6 5443.5 5681.7 5716.8 5759.6 4999.8 5568.7 5621.6 5635.7 5711.9 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20789.20 Median:4513.18 stddev:30793.37 (682.3%) stddev-sans-first:30842.76 14:10:10 INFO - PROCESS | 1643 | Values: 688.8 762.8 779.3 794.5 810.9 14944.9 15574.8 15611.9 15643.3 15646.6 13714.2 13802.7 13811.7 13824.4 13885.0 708.0 749.3 865.7 868.9 869.8 851.0 852.9 853.1 855.2 856.8 773.0 886.0 898.7 901.8 903.0 857.9 863.0 875.6 879.1 893.6 649.0 650.7 658.5 674.1 674.2 12645.2 12726.1 12740.7 12753.7 12926.5 11283.5 11562.9 11996.7 12422.1 12574.7 11953.2 12290.4 12407.1 12533.0 12662.8 3946.5 4506.4 4549.8 4561.2 4795.7 91058.0 93484.5 96551.5 96762.5 97576.0 10354.5 10467.4 10572.4 10591.7 10827.3 19529.9 19606.8 19649.9 19698.7 20013.3 6637.0 6651.5 7489.4 7620.2 7848.2 3851.6 4319.7 4453.0 4520.0 4599.7 3285.9 3349.2 3379.8 3400.5 3403.3 560.8 625.4 631.8 638.7 654.9 535.0 541.9 566.9 580.9 587.2 7355.6 8447.0 8855.8 8859.8 9128.2 588.8 600.3 626.0 639.9 644.4 3931.7 4260.2 4279.2 4348.2 4395.8 80675.6 91452.0 115370.0 118653.0 122538.8 92626.0 103137.0 103496.0 103901.0 103912.5 73535.6 82595.6 92392.1 93369.5 97484.0 9438.1 9731.6 9908.9 9990.6 10029.2 50881.5 51543.7 53128.4 54785.7 55608.0 70258.0 70764.9 71011.6 74881.6 76451.0 11711.7 12552.0 12571.6 12624.0 12738.7 13877.3 14025.4 14034.9 14362.4 14478.4 12716.8 13104.9 13249.2 13251.0 13268.3 12293.8 12825.5 13346.8 13349.8 14000.4 12075.9 12297.5 13074.1 13175.5 13269.1 10681.7 10843.8 10959.0 11063.4 11068.5 9286.6 9649.8 11035.6 11288.3 11411.9 14:10:10 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:10:10 INFO - PROCESS | 1643 | 14:10:10 INFO - TEST-INFO | 1643: exit 0 14:10:10 INFO - TEST-OK | dromaeo_css | took 1115067ms 14:10:10 INFO - TEST-START | kraken 14:10:10 INFO - operating with platform_type : mac_ 14:10:10 INFO - Initialising browser for kraken test... 14:10:10 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpQoSYdj/profile http://localhost:49240/getInfo.html) 14:10:13 INFO - PROCESS | 1655 | 2017-02-23 14:10:13.237 plugin-container[1657:10008] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 14:10:13 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:13 INFO - PROCESS | 1655 | 2017-02-23 14:10:13.237 plugin-container[1657:10008] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 14:10:13 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:13 INFO - PROCESS | 1655 | 2017-02-23 14:10:13.237 plugin-container[1657:10008] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:10:13 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 14:10:13 INFO - PROCESS | 1655 | colorDepth:24 14:10:13 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 14:10:13 INFO - PROCESS | 1655 | __metrics 14:10:13 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:10:14 INFO - TEST-INFO | 1655: exit 0 14:10:14 INFO - Browser initialized. 14:10:14 INFO - Running cycle 1/1 for kraken test... 14:10:14 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpQoSYdj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:16 INFO - PROCESS | 1658 | 2017-02-23 14:10:16.527 plugin-container[1659:10135] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 14:10:16 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:16 INFO - PROCESS | 1658 | 2017-02-23 14:10:16.528 plugin-container[1659:10135] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880b, name = 'com.apple.CFPasteboardClient' 14:10:16 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:16 INFO - PROCESS | 1658 | 2017-02-23 14:10:16.528 plugin-container[1659:10135] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:10:26 INFO - PROCESS | 1658 | RSS: Main: 177770496 14:10:26 INFO - PROCESS | 1658 | 14:10:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:10:30 INFO - PROCESS | 1658 | RSS: Main: 190713856 14:10:30 INFO - PROCESS | 1658 | 14:10:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:10:33 INFO - PROCESS | 1658 | RSS: Main: 198451200 14:10:33 INFO - PROCESS | 1658 | 14:10:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:10:37 INFO - PROCESS | 1658 | RSS: Main: 202207232 14:10:37 INFO - PROCESS | 1658 | 14:10:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:10:39 INFO - PROCESS | 1658 | RSS: Main: 203472896 14:10:39 INFO - PROCESS | 1658 | 14:10:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:10:42 INFO - PROCESS | 1658 | RSS: Main: 203882496 14:10:42 INFO - PROCESS | 1658 | 14:10:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:10:46 INFO - PROCESS | 1658 | RSS: Main: 207716352 14:10:46 INFO - PROCESS | 1658 | 14:10:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:10:49 INFO - PROCESS | 1658 | RSS: Main: 206938112 14:10:49 INFO - PROCESS | 1658 | 14:10:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:10:53 INFO - PROCESS | 1658 | RSS: Main: 207183872 14:10:53 INFO - PROCESS | 1658 | 14:10:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:10:55 INFO - PROCESS | 1658 | RSS: Main: 206307328 14:10:55 INFO - PROCESS | 1658 | 14:10:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:10:57 INFO - PROCESS | 1658 | RSS: Main: 206442496 14:10:57 INFO - PROCESS | 1658 | 14:11:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:00 INFO - PROCESS | 1658 | RSS: Main: 206409728 14:11:00 INFO - PROCESS | 1658 | 14:11:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:04 INFO - PROCESS | 1658 | RSS: Main: 206393344 14:11:04 INFO - PROCESS | 1658 | 14:11:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:07 INFO - PROCESS | 1658 | RSS: Main: 206680064 14:11:07 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:11:09 INFO - PROCESS | 1658 | RSS: Main: 208334848 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | __start_tp_report 14:11:09 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 14:11:09 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 14:11:09 INFO - PROCESS | 1658 | |i|pagename|runs| 14:11:09 INFO - PROCESS | 1658 | |0;ai-astar;108;116;116;115;117;116;117;116;122;96 14:11:09 INFO - PROCESS | 1658 | |1;audio-beat-detection;141;110;114;141;137;134;138;112;159;143 14:11:09 INFO - PROCESS | 1658 | |2;audio-dft;200;194;211;199;198;195;194;200;201;197 14:11:09 INFO - PROCESS | 1658 | |3;audio-fft;81;59;61;105;49;76;78;81;101;65 14:11:09 INFO - PROCESS | 1658 | |4;audio-oscillator;86;91;111;71;68;73;114;90;69;86 14:11:09 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;92;88;77;130;134;87;99;88;89;87 14:11:09 INFO - PROCESS | 1658 | |6;imaging-darkroom;127;171;109;102;100;134;120;102;101;112 14:11:09 INFO - PROCESS | 1658 | |7;imaging-desaturate;89;87;72;70;121;86;141;123;87;94 14:11:09 INFO - PROCESS | 1658 | |8;json-parse-financial;57;56;55;58;60;61;61;60;61;60 14:11:09 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;67;68;75;76;71;67;67;69;70;98 14:11:09 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;83;81;84;82;84;80;83;82;84;81 14:11:09 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;140;145;145;135;140;138;138;144;173;153 14:11:09 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;166;166;162;163;165;161;163;220;213;163 14:11:09 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;66;66;66;68;68;65;67;65;65 14:11:09 INFO - PROCESS | 1658 | __end_tp_report 14:11:09 INFO - PROCESS | 1658 | __start_cc_report 14:11:09 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,934 14:11:09 INFO - PROCESS | 1658 | __end_cc_report 14:11:09 INFO - PROCESS | 1658 | __startTimestamp1487887869645__endTimestamp 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | ------- Summary: start ------- 14:11:09 INFO - PROCESS | 1658 | Number of tests: 14 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:113.90 Median:116.50 stddev:7.14 (6.1%) stddev-sans-first:7.25 14:11:09 INFO - PROCESS | 1658 | Values: 108.0 116.0 116.0 115.0 117.0 116.0 117.0 116.0 122.0 96.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:139.50 stddev:15.91 (11.4%) stddev-sans-first:16.60 14:11:09 INFO - PROCESS | 1658 | Values: 141.0 110.0 114.0 141.0 137.0 134.0 138.0 112.0 159.0 143.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:198.90 Median:199.50 stddev:4.95 (2.5%) stddev-sans-first:5.24 14:11:09 INFO - PROCESS | 1658 | Values: 200.0 194.0 211.0 199.0 198.0 195.0 194.0 200.0 201.0 197.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:75.60 Median:70.50 stddev:17.90 (25.4%) stddev-sans-first:18.87 14:11:09 INFO - PROCESS | 1658 | Values: 81.0 59.0 61.0 105.0 49.0 76.0 78.0 81.0 101.0 65.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:79.50 stddev:16.52 (20.8%) stddev-sans-first:17.52 14:11:09 INFO - PROCESS | 1658 | Values: 86.0 91.0 111.0 71.0 68.0 73.0 114.0 90.0 69.0 86.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:97.10 Median:88.00 stddev:19.19 (21.8%) stddev-sans-first:20.26 14:11:09 INFO - PROCESS | 1658 | Values: 92.0 88.0 77.0 130.0 134.0 87.0 99.0 88.0 89.0 87.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:117.80 Median:116.00 stddev:22.09 (19.0%) stddev-sans-first:23.18 14:11:09 INFO - PROCESS | 1658 | Values: 127.0 171.0 109.0 102.0 100.0 134.0 120.0 102.0 101.0 112.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:86.50 stddev:23.42 (27.1%) stddev-sans-first:24.66 14:11:09 INFO - PROCESS | 1658 | Values: 89.0 87.0 72.0 70.0 121.0 86.0 141.0 123.0 87.0 94.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:60.00 stddev:2.23 (3.7%) stddev-sans-first:2.26 14:11:09 INFO - PROCESS | 1658 | Values: 57.0 56.0 55.0 58.0 60.0 61.0 61.0 60.0 61.0 60.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:70.50 stddev:9.43 (13.4%) stddev-sans-first:9.76 14:11:09 INFO - PROCESS | 1658 | Values: 67.0 68.0 75.0 76.0 71.0 67.0 67.0 69.0 70.0 98.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.43 (1.7%) stddev-sans-first:1.50 14:11:09 INFO - PROCESS | 1658 | Values: 83.0 81.0 84.0 82.0 84.0 80.0 83.0 82.0 84.0 81.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:144.50 stddev:11.04 (7.6%) stddev-sans-first:11.55 14:11:09 INFO - PROCESS | 1658 | Values: 140.0 145.0 145.0 135.0 140.0 138.0 138.0 144.0 173.0 153.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:165.50 stddev:22.41 (13.5%) stddev-sans-first:23.58 14:11:09 INFO - PROCESS | 1658 | Values: 166.0 166.0 162.0 163.0 165.0 161.0 163.0 220.0 213.0 163.0 14:11:09 INFO - PROCESS | 1658 | 14:11:09 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.26 (1.9%) stddev-sans-first:1.20 14:11:09 INFO - PROCESS | 1658 | Values: 68.0 66.0 66.0 66.0 68.0 68.0 65.0 67.0 65.0 65.0 14:11:09 INFO - PROCESS | 1658 | -------- Summary: end -------- 14:11:09 INFO - PROCESS | 1658 | 14:11:10 INFO - TEST-INFO | 1658: exit 0 14:11:10 INFO - TEST-OK | kraken | took 59926ms 14:11:10 INFO - SUITE-END | took 1174s 14:11:10 INFO - Completed test suite (00:19:35) 14:11:10 INFO - javascript benchmark 14:11:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7300.327211096927, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3567.6253993330697, 3579.087332730155, 3579.910502237445, 3607.116256517153, 3642.3625865473537, 5940.88118237635, 5981.162637230791, 5992.011318132503, 6016.879662406749, 6029.246344206974, 4822.107910036646, 5296.364436267643, 5777.306723193223, 5976.252968378953, 6035.456808887199, 4457.398251236074, 5322.893542129155, 5343.599230057742, 5378.569714422856, 5419.403865574804, 5423.728813559326, 5459.69971651559, 5478.506934375905, 5510.366307874586, 5513.50378465938, 5290.418054014055, 5319.0957537218765, 5456.672599644034, 5466.890662186774, 5468.6171967962255, 5340.0, 5343.492368225013, 5383.757730902119, 5415.539679127279, 5461.726913654302, 5249.396319423239, 5371.301730774974, 5379.542738867201, 5391.622586418952, 5394.352677678665, 6033.728482218311, 6038.667873266969, 6061.878762424727, 6096.908546371808, 6131.570790044699, 6193.256809182927, 6217.87564248717, 6229.87540249197, 6233.625982441068, 6264.091706702548, 6219.595726277777, 6275.780347687809, 6282.591631543935, 6296.0, 6296.433321001132, 6049.122877182828, 6077.088436734525, 6090.599162192632, 6091.238595175603, 6094.238220222473, 6359.268684101387, 6373.426391624684, 6437.7103030362805, 6473.320301368382, 6477.805665829938, 6248.250209974832, 6264.843378915563, 6283.7800676976085, 6303.621782693053, 6304.306526282106, 6147.72335244915, 6343.714532846033, 6356.110144579762, 6356.841078973062, 6379.617222966544, 6151.907721384183, 6201.96899015502, 6243.500519958392, 6271.623702577769, 6315.242170939517, 5054.494550544916, 6259.061140828821, 6270.059491076284, 6280.0, 6294.622322660655, 5085.4914508548845, 5098.821541246039, 5111.207762796773, 5112.795488180505, 5119.692818430906, 4499.730016199039, 4503.482099558592, 4528.637708983273, 4531.886702832389, 4587.9082418351445, 5972.223610930551, 6098.054801505774, 6178.62928224308, 6180.4437600615265, 6221.688915554204, 6278.937210627927, 6285.340039295899, 6337.081123237105, 6364.363563643691, 6366.140571022946, 6099.9390006099375, 6102.72537735803, 6113.902014424272, 6146.6004709693725, 6176.227971503562, 5641.943580564224, 5643.463870932255, 5650.152477128464, 5653.123765816305, 5697.601167918288, 6502.577332473374, 6550.8362290943105, 6558.983357579583, 6561.179852518435, 6578.703958321983, 6181.876362472635, 6203.565750397429, 6234.251889773075, 6261.812145635638, 6336.904946425715, 6575.736970521317, 6577.309382514767, 6589.143411356493, 6602.801915942529, 6618.70215840298, 6213.96893015532, 6297.370262973849, 6318.715657795318, 6324.968375158095, 6331.366863313632, 6131.223750760645, 6180.165677633642, 6206.751729930752, 6363.3636636336, 6392.9360706392345, 6141.547378150984, 6223.595466294676, 6248.125262463168, 6248.375162483715, 6255.155554000152, 6231.501479881689, 6233.625982441068, 6238.376162383725, 6238.844028899314, 6251.71867265965, 6086.543509236736, 6090.390960903874, 6111.8956224267595, 6199.256089269316, 6226.62640241587, 6141.570090093651, 6200.503959683305, 6212.844678883064, 6233.501319894307, 6251.4061164189325, 5488.204210389391, 5888.17565540816, 6192.938070619416, 6198.504119670325, 6198.752049917953], "value": 5857.340859414007, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.9832005879794, 546.4699241735518, 547.1109447148382, 577.1717585265142, 577.9683265371314, 38003.61996380035, 39764.0, 40492.39261411081, 40531.79734101329, 40602.98492537688, 36477.45283820745, 36651.4502282466, 41383.58616413835, 42769.78615106928, 42844.0, 8579.056303806576, 9599.136077753019, 9759.75600609987, 9786.266030047775, 9798.951005244999, 9632.181264592518, 9683.322167448247, 9758.316917815755, 9767.0, 9795.06946840049, 8395.370347223952, 9654.13112819846, 9685.515724213761, 9696.75758106046, 9714.465704386255, 9733.07535784103, 9782.755431114208, 9838.458884761336, 9844.409335439897, 9854.753631159207, 9719.757006074835, 9723.173530249936, 9756.170725488342, 9769.316147869651, 9788.119069283728, 34602.48096278558, 40268.79865600653, 40388.99027524306, 40640.0, 40774.388384174265, 3397.8470968806214, 3449.7757645753195, 3465.8380160038055, 3962.056077564465, 4055.3916912463073, 29645.851770741225, 29799.70200297991, 30269.848650756827, 30502.389952200832, 32393.028209153763, 3238.886638967625, 3245.7403407727325, 3317.485789702576, 3380.577427821522, 3438.6905178534053, 414833.0, 503735.0, 506823.0, 507673.99999999633, 507821.0, 62352.688236558526, 62498.0, 62815.0, 62907.0, 63028.36971630317, 64074.679626601566, 65574.0, 65648.01527977084, 66103.33896661068, 66177.67644647177, 16777.328906843588, 16898.83101168997, 17111.74332385015, 17124.14379281031, 17171.828281717022, 12847.421866015864, 13177.802332964822, 13186.472541098441, 13197.076204665582, 13247.536336228186, 16444.76664250186, 18000.639987200182, 18117.275308987755, 18138.727919081226, 18294.725579116322, 3271.198556353661, 5748.5688573357165, 6449.806505804833, 6617.9669101655145, 6626.370494802986, 887.7869311365226, 957.812312732221, 982.3025651787168, 1050.3540322701635, 1076.34343050739, 29982.650780714484, 30433.847830761148, 30633.234169145504, 30971.0, 31282.374352512823, 953.3564843730593, 1032.5456799008412, 1094.956201751921, 1098.3080659184823, 1163.1276542593055, 13952.534983826756, 15146.924265378602, 16051.839481605268, 16083.758743618855, 16181.4336498222, 688926.0, 695177.0, 696332.0, 696408.0, 696574.0, 49886.0, 58367.0, 58889.0, 58997.0, 59002.11496827551, 1353.8781509663982, 1373.2515778900524, 1399.4262352435453, 1404.2206575350574, 1408.3521580073077, 28613.0, 29658.110256692333, 29728.959486417873, 30550.541741873447, 30701.53947690742, 49044.509554905424, 57703.71148144401, 59255.11117333157, 59566.0, 62319.06521402092, 609394.0, 613045.0, 619321.9033904981, 620625.0, 621352.7864721295, 43809.78095109504, 43825.34261986009, 44334.89162770956, 44405.0, 44452.33321500245, 47587.0, 47926.0, 48037.0, 48407.75796121138, 49177.508224918725, 38545.6145438542, 39516.0, 39707.2058558833, 40630.18739625132, 40951.0, 35891.820540897126, 37353.0, 37712.24575508529, 38000.0, 38471.422928655535, 38369.4244586337, 39317.41023884701, 39426.0, 39550.60449395469, 41202.0, 31023.68976310208, 34217.97346079622, 34914.65085349114, 34985.82507087448, 35038.82480587683, 26355.077572285645, 26355.868220658773, 26378.0, 26622.201333959238, 26799.0], "value": 20485.236952865922, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8921182980042, 331.74600011954806, 369.4310761427401, 403.53593367627207, 417.52610786757043, 16500.917495412523, 17076.829231707678, 19595.5101122472, 19990.7001394979, 20085.136998621027, 19757.50606234845, 20433.386998390073, 20738.066786994583, 20743.377698669065, 20950.685739713917, 5689.943100569003, 5730.9426905730825, 5841.474267315941, 5916.556258280624, 5946.108083787445, 5641.858953526174, 5761.596688231825, 5811.796587119452, 5818.359980402152, 5819.0, 5167.4574169712205, 5515.944840551603, 5610.214569960209, 5704.286964129484, 5714.171445140452, 5707.65754054756, 5710.857228569319, 5784.421557844203, 5806.883862322772, 5817.825465236049, 5036.899262014739, 5100.056489549445, 5144.511271429208, 5151.45909679482, 5429.701366424845, 13192.472301107944, 13247.0, 13451.798223026663, 13452.0, 16175.514734557983, 2077.314486219544, 2347.9882600587057, 2496.2012156110054, 2570.3831080540535, 2626.75045870642, 10146.492675366202, 10421.166306695446, 12005.219660722112, 15271.541853744406, 15632.983856049434, 1676.983230167695, 1758.516407987801, 1847.8706490545667, 1849.5561065344355, 1855.4433669898976, 124115.0, 126802.36598816946, 126954.36522817326, 127544.36227818801, 132063.0, 11568.942155289169, 11768.470418831173, 11924.403779811148, 12039.63881083569, 12270.447829847679, 14913.179775112472, 14983.951123421473, 15054.247287635575, 15058.0, 15072.698546029018, 8495.320374370036, 8878.73363799087, 8891.333150013776, 8931.151540603632, 8970.82058358829, 8819.236152769472, 8820.382573219813, 8846.601902914384, 8979.191872731355, 9017.053209413049, 4012.277789997828, 4077.0, 4317.438732964694, 4532.388127602731, 4621.6764826462495, 1654.9503514894573, 2007.6687346587942, 2009.7889721579315, 2015.6976453532088, 2027.2397850805949, 837.0, 888.8089060851947, 907.8728977943093, 931.2038207332633, 953.8125034332162, 20014.69977950332, 21305.467363316042, 21319.147234110773, 21334.03996820147, 21643.891780541, 961.8653388525612, 972.547765289144, 1007.3804610164842, 1011.1405305490422, 1033.266380869576, 10730.946345268223, 11069.667909962714, 11202.775944481065, 11999.520019199133, 12208.694782630328, 623870.0, 629194.0, 635617.0, 637498.8125059438, 640138.0, 119055.0, 119442.61114777655, 130083.0, 135811.6418835799, 136782.0, 975.8877729061107, 1009.2329829329763, 1037.8339465685606, 1039.0285083447002, 1044.300318786415, 16636.0, 18069.006204658344, 18510.907445462686, 19277.22891084341, 19363.225470981568, 53955.190672139164, 54285.45714542962, 54806.177907330624, 55478.72260638671, 56812.43187568237, 80635.59682201552, 81072.18927810647, 83168.0, 83344.58327708322, 84181.57909210415, 7129.607871566906, 7878.369730421668, 8012.118666946515, 8056.11382747909, 8194.22154895284, 12036.097292702907, 12408.0, 12579.433925473559, 12607.873921261036, 12631.93684031574, 10616.681499555025, 10711.94644026775, 11065.004149626573, 11101.888981110409, 11169.888301116885, 8674.696385626472, 10800.351978880977, 10902.781944361226, 10945.288556243819, 11175.888241117485, 10895.237333386587, 11093.833592496281, 11288.322700637988, 11304.152188586053, 11316.94341528287, 6762.8647427052165, 7009.474289428212, 7392.26077392278, 7444.739434119996, 8054.879176812469, 8933.374663773473, 10674.35953842772, 10765.515551800032, 10931.890681093088, 11357.432128393713], "value": 9452.904302023058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.5472303585889, 1480.5706345159904, 1705.5906582420216, 1817.8454831339336, 1875.5311172206948, 7689.231076892308, 7912.6439310231035, 8182.386321025924, 8636.524991125485, 8640.567971601418, 8099.91900080999, 8392.664293428255, 8422.747317580466, 8504.107068757785, 8534.57327133644, 2385.6660067590506, 2416.1301931304715, 2416.504616553611, 2417.576924038295, 2419.0323870451784, 2389.23544465771, 2414.915477958272, 2433.3551608823677, 2434.075051480444, 2436.878156092197, 2077.6156411063926, 2382.404398900275, 2387.6776635154292, 2408.4580969281947, 2419.1170222868614, 2365.077619728307, 2372.9406764830846, 2380.4881950380664, 2388.2118900762707, 2412.2522018174423, 2364.929052128439, 2398.9520209595885, 2405.6511805788236, 2412.915547955831, 2418.709754829432, 8537.829243415097, 8583.270422014137, 8584.442011269248, 8627.40393027292, 8642.395032347738, 5210.374755029383, 5365.222042803772, 5375.758090885881, 5382.4886635769535, 5390.78436862525, 3140.1992491914643, 3497.387957107496, 3516.4901089342156, 3523.6300188480354, 3584.2473080653094, 1053.5733028123545, 1066.4134725900801, 1077.7682798198346, 1117.0672488472135, 1129.728865072385, 11038.724031899186, 11077.446127693584, 11077.99999999992, 11089.445527723663, 11107.611233606785, 4517.728936263835, 4576.313552967015, 4622.791974361162, 4627.9768601156775, 4840.782164802592, 9555.378900371454, 9579.952100239594, 9589.520523973773, 9599.136077753035, 9607.0, 4630.28230624247, 5328.0, 5334.119870221448, 5338.412774594792, 5342.652727572696, 4379.934300985424, 4400.031992961607, 4817.445993710698, 4878.56092951636, 4892.241702536113, 3863.169418574964, 3915.0, 3968.940465893014, 4004.619561141745, 4022.316206244887, 1306.0596370613143, 1315.7302752935816, 1318.5253308809013, 1326.827512423398, 1334.2794890759076, 792.7780221537979, 798.1778767869104, 898.4923518212189, 904.8506996345661, 922.7739203895088, 5580.218769372291, 5591.189277554732, 5601.80393686219, 5770.19217309577, 5843.766249349978, 983.7245571240064, 1022.8721409823772, 1036.3212096077082, 1047.586203449633, 1069.973250668724, 3795.81020948957, 3853.499045124116, 3866.2654095721723, 3935.9606403935595, 3964.4251583520804, 9568.712938611714, 9612.807743845084, 9983.351082179635, 10152.23858210637, 10367.170626349875, 9842.557084931195, 10180.745481362877, 10284.537195826206, 10284.897151028394, 10335.689929302132, 7606.8098297543, 7962.7213047543055, 7976.082750483769, 7987.281144697005, 8017.438779285394, 5016.523430274118, 5506.421825708403, 5507.284053073236, 5587.860303492283, 5768.1636162757, 9368.625254989724, 9398.483083430478, 9463.574139163617, 9484.051594840737, 9501.57242924084, 9552.90447095548, 9641.37331073478, 9643.27675424332, 9739.0, 9767.365121267096, 6363.6818159090935, 6451.806445806634, 6671.799846004627, 6805.319468053155, 6903.896441553481, 7931.444798864024, 8093.919060809317, 8127.634256458356, 8146.511209327459, 8148.103708592169, 6053.727582258721, 7143.0, 7238.6018768968215, 7321.524100933422, 7374.520656157332, 7041.802893508218, 7118.323759242864, 7125.429965602636, 7146.071010768567, 7250.456215783732, 5310.867228319323, 5888.764449422147, 5912.320083190488, 6399.488040956805, 6749.055132281386, 4718.811247550197, 4777.402824646919, 4781.5935645469135, 4826.8069277228515, 4833.564979151894, 4737.692050016875, 4831.371921650163, 4888.193448081027, 4943.925841112315, 4996.675216110941], "value": 4484.826969549371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.3698917219699, 314.7560640503609, 321.3861524488227, 324.57156553349586, 325.38177462820636, 4578.4963653998075, 5370.731463426832, 5470.699111548864, 5512.531434828034, 5531.723413829302, 5062.164742817431, 5249.737513124348, 5405.351357837055, 5422.945770542294, 5450.618456708032, 3454.533637958881, 3476.687098161165, 3893.800002998311, 4186.204621121977, 4189.874303770892, 3518.9443167049913, 3839.34731095713, 4190.434291370657, 4204.432401625787, 4216.873493795176, 3735.2529494101154, 4041.373587094005, 4108.8356465741335, 4125.834966601333, 4126.5667104953845, 4022.3363145081025, 4105.7418419869255, 4129.256733787917, 4144.668426525871, 4175.874723758292, 3150.5979838971666, 3422.161570415264, 3598.1394791141106, 3606.972012976289, 3626.746127771057, 4409.536998615164, 4970.329005584236, 5274.810953454312, 5317.548008419289, 5370.979513892348, 3922.0, 4544.88637784058, 4707.882302942419, 4733.928991065137, 4744.95610965587, 4597.3793537872625, 4775.689580177277, 4979.601631869478, 5069.645124841262, 5754.482096611283, 3288.3094550144497, 3423.7432192585657, 3554.964450355489, 3902.590228026073, 3962.603739626043, 5780.456599096384, 5879.235699359098, 5976.641401515923, 6005.759769609211, 6015.608985415934, 3974.4038394240515, 3985.960140398617, 4002.9799851000557, 4004.8798536043964, 4006.779627120478, 3418.7265018798435, 3688.3914154164263, 3780.773153610792, 3994.7403418777685, 4025.6376926076796, 4338.74176488821, 4690.507496712864, 4694.2958556216845, 4721.693089949211, 4755.57199852008, 5056.418511871108, 5440.537554307928, 5756.597038207369, 5792.391798861059, 5810.941890581124, 1152.4180288954024, 1255.3848614178987, 1265.9050571207197, 1289.954851580209, 1323.4706117552864, 812.321711371, 868.2880038368603, 890.3900827932887, 891.9821603567892, 902.3142411766974, 4977.601791856643, 5103.234514822732, 5132.28148059272, 5201.505856943584, 5245.344331958505, 5415.512603865671, 5573.080441727069, 5636.464535869168, 5646.322441307069, 5647.858803529944, 4389.868303950887, 4731.0, 5136.481510165549, 5167.431582525919, 5196.45437229093, 2739.493193759161, 2880.775670340097, 2926.707329267099, 2928.535732133933, 2945.9247374708507, 5598.58010649203, 5831.94168058314, 5845.18799172258, 5895.027320492157, 5910.940890591125, 5466.316710411199, 5766.855828604318, 5770.740316685759, 5793.768249269982, 5856.443637854397, 4688.929666055012, 5238.109521381298, 5343.931213757186, 5724.570657200643, 5923.289205295392, 5032.295478632921, 5342.893142137058, 5435.945640543544, 5627.8874422512135, 5667.376588575171, 4780.474147843804, 4832.903341933212, 5306.42638320422, 5502.257195278747, 5569.157281475769, 5063.5695965843315, 5444.346678398618, 5484.341878974389, 5854.531637469077, 5873.530117590497, 3462.601800792941, 3639.9272014560092, 3641.9089522761083, 3649.872254471081, 3808.095952023988, 4405.515393306798, 4896.6572339935865, 5067.70599110581, 5445.455454454523, 5616.8715993743745, 5038.908852826036, 5533.889322213453, 5620.74706638194, 5719.655880868076, 5885.881682480315, 5245.344331958505, 5293.391260005149, 5302.859885124717, 5607.579431542732, 5783.681897495678, 4396.153615481441, 5201.765920533509, 5207.1668533034535, 5648.604597678123, 5709.857253568694, 5044.646874718735, 5443.52319694546, 5681.744321505625, 5716.828495145152, 5759.596828221985, 4999.775010124626, 5568.6658800472105, 5621.550275977994, 5635.690037048002, 5711.857203569944], "value": 4067.9638990998433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.8002479281009, 762.7635433015765, 779.3375630713892, 794.4915254237293, 810.8864758933751, 14944.925275373622, 15574.844251557495, 15611.921940390283, 15643.296051677673, 15646.608834779136, 13714.24571648559, 13802.723945521084, 13811.654708632264, 13824.377902994363, 13885.0, 707.9946476004073, 749.3031480722925, 865.709987154304, 868.8827008353854, 869.8477766390888, 851.0340763233743, 852.8592782190931, 853.0616322045731, 855.2260204514924, 856.7729551668813, 772.9690812367498, 886.0032463478586, 898.6944438890775, 901.7520181949951, 902.9683961061364, 857.8756080368343, 863.0032312678866, 875.5797217335682, 879.1340529578392, 893.5710858787753, 649.0134994807913, 650.6909218121402, 658.4929604204735, 674.1404708996021, 674.197704731368, 12645.241285522898, 12726.10917235794, 12740.745185096339, 12753.681157971032, 12926.547570834975, 11283.492242849092, 11562.88437115635, 11996.70008249792, 12422.06834487408, 12574.68563285916, 11953.163278570504, 12290.446929888176, 12407.07103792587, 12533.0, 12662.81005784914, 3946.506686664167, 4506.391637128979, 4549.772511374451, 4561.156186105581, 4795.688280261772, 91058.0, 93484.53257733736, 96551.51724241405, 96762.51618741931, 97576.0, 10354.482275886176, 10467.371957682564, 10572.418516981486, 10591.735206619742, 10827.296225745302, 19529.902350488155, 19606.80393196078, 19649.901750491157, 19698.70451943222, 20013.299534516224, 6636.966815165893, 6651.534392592569, 7489.400847932152, 7620.161782203953, 7848.175941526171, 3851.6340947609933, 4319.719218250803, 4453.0, 4519.9774001130445, 4599.747013914267, 3285.8849940251976, 3349.2296771742635, 3379.7803142795638, 3400.540926974876, 3403.3193361327835, 560.8054843183992, 625.4183609243356, 631.8294060603612, 638.7381173718753, 654.9050387693853, 534.959878009143, 541.9214213939035, 566.8837888232903, 580.9041508151108, 587.2395248153651, 7355.5954422507275, 8447.0, 8855.822883542292, 8859.778505537413, 9128.22410095136, 588.8213165211971, 600.3140716003741, 625.9937400625936, 639.9008153736179, 644.4168027934633, 3931.7051221158526, 4260.211860805761, 4279.186954478639, 4348.195583817004, 4395.802188901507, 80675.59662201651, 91452.0, 115370.0, 118653.0, 122538.77461225452, 92626.0, 103137.0, 103496.0, 103900.96099039064, 103912.48043759733, 73535.63232183804, 82595.5870220645, 92392.07607923969, 93369.53315233381, 97484.0, 9438.087821242558, 9731.562079706571, 9908.900910990798, 9990.600375984879, 10029.197664186993, 50881.47355579338, 51543.74228128835, 53128.399620740485, 54785.72607136939, 55608.0, 70258.0, 70764.93852592318, 71011.64494177702, 74881.62559187169, 76451.0, 11711.707207319885, 12552.0, 12571.622851314476, 12624.0, 12738.745225095261, 13877.306134693426, 14025.438982440995, 14034.859651403356, 14362.425502979764, 14478.420863165355, 12716.809247861105, 13104.934475327944, 13249.1642045373, 13251.0, 13268.27024513661, 12293.83208595182, 12825.486980521047, 13346.799798002843, 13349.799753003519, 14000.369983350978, 12075.879241207476, 12297.508099675913, 13074.09280691816, 13175.538856139989, 13269.137506062076, 10681.732956676145, 10843.837342439712, 10959.0, 11063.446827658423, 11068.501917413574, 9286.582103805209, 9649.758756031155, 11035.613753518588, 11288.322700637988, 11411.942940285246], "value": 7314.373196892318, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 116.0, 115.0, 117.0, 116.0, 117.0, 116.0, 122.0, 96.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 114.0, 141.0, 137.0, 134.0, 138.0, 112.0, 159.0, 143.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 194.0, 211.0, 199.0, 198.0, 195.0, 194.0, 200.0, 201.0, 197.0], "value": 198.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 61.0, 105.0, 49.0, 76.0, 78.0, 81.0, 101.0, 65.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 111.0, 71.0, 68.0, 73.0, 114.0, 90.0, 69.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 77.0, 130.0, 134.0, 87.0, 99.0, 88.0, 89.0, 87.0], "value": 97.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 171.0, 109.0, 102.0, 100.0, 134.0, 120.0, 102.0, 101.0, 112.0], "value": 117.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 72.0, 70.0, 121.0, 86.0, 141.0, 123.0, 87.0, 94.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 58.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 75.0, 76.0, 71.0, 67.0, 67.0, 69.0, 70.0, 98.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 84.0, 82.0, 84.0, 80.0, 83.0, 82.0, 84.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 145.0, 145.0, 135.0, 140.0, 138.0, 138.0, 144.0, 173.0, 153.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 162.0, 163.0, 165.0, 161.0, 163.0, 220.0, 213.0, 163.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 68.0, 68.0, 65.0, 67.0, 65.0, 65.0], "value": 66.4, "unit": "score"}]}]} 14:11:10 INFO - Return code: 0 14:11:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:10 ERROR - # TBPL SUCCESS # 14:11:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:10 INFO - 2017-02-23 14:11:10.990 screenresolution[1663:10514] starting screenresolution argv=screenresolution get 14:11:10 INFO - 2017-02-23 14:11:10.994 screenresolution[1663:10514] Display 0: 1600x1200x32@60 14:11:11 INFO - 2017-02-23 14:11:11.001 screenresolution[1664:10517] starting screenresolution argv=screenresolution list 14:11:11 INFO - Available Modes on Display 0 14:11:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:11 INFO - Intel Iris: 14:11:11 INFO - Chipset Model: Intel Iris 14:11:11 INFO - Type: GPU 14:11:11 INFO - Bus: Built-In 14:11:11 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:11 INFO - Vendor: Intel (0x8086) 14:11:11 INFO - Device ID: 0x0a2e 14:11:11 INFO - Revision ID: 0x0009 14:11:11 INFO - Displays: 14:11:11 INFO - Display: 14:11:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:11 INFO - Display Serial Number: 1600x1200 60 14:11:11 INFO - Main Display: Yes 14:11:11 INFO - Mirror: Off 14:11:11 INFO - Online: Yes 14:11:11 INFO - Rotation: Supported 14:11:11 INFO - Return code: 0 14:11:11 INFO - Running post-action listener: _resource_record_post_action 14:11:11 INFO - [mozharness: 2017-02-23 22:11:11.239234Z] Finished run-tests step (success) 14:11:11 INFO - Running post-run listener: _resource_record_post_run 14:11:11 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 42448896; Write bytes: 503239168; Read time: 417; Write time: 1921 14:11:11 INFO - TinderboxPrint: CPU usage
54.4% 14:11:11 INFO - TinderboxPrint: I/O read bytes / time
42,448,896 / 417 14:11:11 INFO - TinderboxPrint: I/O write bytes / time
503,239,168 / 1,921 14:11:11 INFO - TinderboxPrint: CPU idle
2,186.4 (45.6%) 14:11:11 INFO - TinderboxPrint: CPU system
968.2 (20.2%) 14:11:11 INFO - TinderboxPrint: CPU user
1,635.1 (34.1%) 14:11:11 INFO - TinderboxPrint: Swap in / out
232,742,912 / 0 14:11:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181524992; Write bytes: 174850048; Read time: 16766; Write time: 333 14:11:11 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 41461760; Write bytes: 310653440; Read time: 403; Write time: 1535 14:11:11 INFO - Running post-run listener: _upload_blobber_files 14:11:11 INFO - Blob upload gear active. 14:11:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:11 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 14:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:11:12 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:13 INFO - (blobuploader) - INFO - Done attempting. 14:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:14 INFO - (blobuploader) - INFO - Done attempting. 14:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:11:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:16 INFO - (blobuploader) - INFO - Done attempting. 14:11:16 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:16 INFO - Return code: 0 14:11:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e56611117e1a4135753f05159e51652d40296f254fb4814ecc9adac95ca4fdd3180eed7630317cebe0fedace8281df5bf89c2953f2d0489797e61605ba182794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25f6cb13271ac7846605005ec01c7e6a8b91b7140bbbd458cc2fb5e6fad8daceb559c695c85435f9b76e053855fe9d8d4ac6e618f996502929f01386ca710765", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe752858ee91a5c5e109e48a0c41f6fe740a8e14a0b4f2219716c40c99a8758e68754f1cc2f66398b9cfaf05052feff77ed52fe36da2bddecd73748ee183fc43"} 14:11:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:16 INFO - Contents: 14:11:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e56611117e1a4135753f05159e51652d40296f254fb4814ecc9adac95ca4fdd3180eed7630317cebe0fedace8281df5bf89c2953f2d0489797e61605ba182794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25f6cb13271ac7846605005ec01c7e6a8b91b7140bbbd458cc2fb5e6fad8daceb559c695c85435f9b76e053855fe9d8d4ac6e618f996502929f01386ca710765", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe752858ee91a5c5e109e48a0c41f6fe740a8e14a0b4f2219716c40c99a8758e68754f1cc2f66398b9cfaf05052feff77ed52fe36da2bddecd73748ee183fc43"} 14:11:16 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:16 INFO - Copying logs to upload dir... 14:11:16 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.328517 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-23 14:11:16.887708) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 14:11:16.891340) ========= 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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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/Mozilla-Beta/sha512/e56611117e1a4135753f05159e51652d40296f254fb4814ecc9adac95ca4fdd3180eed7630317cebe0fedace8281df5bf89c2953f2d0489797e61605ba182794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25f6cb13271ac7846605005ec01c7e6a8b91b7140bbbd458cc2fb5e6fad8daceb559c695c85435f9b76e053855fe9d8d4ac6e618f996502929f01386ca710765", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe752858ee91a5c5e109e48a0c41f6fe740a8e14a0b4f2219716c40c99a8758e68754f1cc2f66398b9cfaf05052feff77ed52fe36da2bddecd73748ee183fc43"} build_url:https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010932 build_url: 'https://queue.taskcluster.net/v1/task/IeWcZdpVSNml-s1eCnx8ZQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e56611117e1a4135753f05159e51652d40296f254fb4814ecc9adac95ca4fdd3180eed7630317cebe0fedace8281df5bf89c2953f2d0489797e61605ba182794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25f6cb13271ac7846605005ec01c7e6a8b91b7140bbbd458cc2fb5e6fad8daceb559c695c85435f9b76e053855fe9d8d4ac6e618f996502929f01386ca710765", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe752858ee91a5c5e109e48a0c41f6fe740a8e14a0b4f2219716c40c99a8758e68754f1cc2f66398b9cfaf05052feff77ed52fe36da2bddecd73748ee183fc43"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 14:11:16.929536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:11:16.929892) ========= 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.h6HKdFQo2G/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.pY9mPYdo4w/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.004867 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:11:16.978722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 14:11:16.979051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 14:11:16.979376) ========= ========= Total master_lag: 0.41 =========