builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0281 starttime: 1481220446.81 results: success (0) buildid: 20161208074957 builduid: 291a80d280cf4e98af053aaaebefbe7c revision: d3c8c1a41bd773b1bf5a29b3c8066448d53d8ff5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:26.808571) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:26.808966) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:26.809328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:27.002438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:27.002756) ========= 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.jjpjOBsaN4/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.DEVMof5f0n/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-08 10:07:27-- 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% 18.4M=0.001s 2016-12-08 10:07:27 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.591538 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:27.624507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:27.624843) ========= 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.jjpjOBsaN4/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.DEVMof5f0n/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.024934 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:27.676579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 10:07:27.677403) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d3c8c1a41bd773b1bf5a29b3c8066448d53d8ff5 --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-aurora --rev d3c8c1a41bd773b1bf5a29b3c8066448d53d8ff5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jjpjOBsaN4/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.DEVMof5f0n/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-08 10:07:27,778 truncating revision to first 12 chars 2016-12-08 10:07:27,778 Setting DEBUG logging. 2016-12-08 10:07:27,778 attempt 1/10 2016-12-08 10:07:27,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d3c8c1a41bd7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 10:07:28,563 unpacking tar archive at: mozilla-aurora-d3c8c1a41bd7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.084902 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 10:07:28.791379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:28.792179) ========= script_repo_revision: d3c8c1a41bd773b1bf5a29b3c8066448d53d8ff5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:28.792846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:28.793193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 10:07:28.825831) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-08 10:07:28.826156) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jjpjOBsaN4/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.DEVMof5f0n/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:07:29 INFO - MultiFileLogger online at 20161208 10:07:29 in /builds/slave/test 10:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:29 INFO - {'append_to_log': False, 10:07:29 INFO - 'base_work_dir': '/builds/slave/test', 10:07:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:29 INFO - 'branch': 'Mozilla-Aurora', 10:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:29 INFO - 'config_files': ('talos/mac_config.py',), 10:07:29 INFO - 'default_actions': ('clobber', 10:07:29 INFO - 'read-buildbot-config', 10:07:29 INFO - 'download-and-extract', 10:07:29 INFO - 'populate-webroot', 10:07:29 INFO - 'create-virtualenv', 10:07:29 INFO - 'install', 10:07:29 INFO - 'run-tests'), 10:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:29 INFO - 'download_minidump_stackwalk': True, 10:07:29 INFO - 'download_symbols': 'ondemand', 10:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:29 INFO - 'installer_path': 'installer.exe', 10:07:29 INFO - 'log_level': 'info', 10:07:29 INFO - 'log_name': 'talos', 10:07:29 INFO - 'log_to_console': True, 10:07:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:07:29 INFO - 'opt_config_files': (), 10:07:29 INFO - 'pip_index': False, 10:07:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:29 INFO - 'cmd': ('bash', 10:07:29 INFO - '-c', 10:07:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:29 INFO - 'enabled': True, 10:07:29 INFO - 'halt_on_failure': False, 10:07:29 INFO - 'name': 'check_screen_resolution'},), 10:07:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:29 INFO - 'cmd': ('bash', 10:07:29 INFO - '-c', 10:07:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:29 INFO - 'enabled': True, 10:07:29 INFO - 'halt_on_failure': False, 10:07:29 INFO - 'name': 'check_screen_resolution'},), 10:07:29 INFO - 'run_cmd_checks_enabled': True, 10:07:29 INFO - 'sps_profile': False, 10:07:29 INFO - 'sps_profile_interval': 0, 10:07:29 INFO - 'suite': 'dromaeojs-e10s', 10:07:29 INFO - 'system_bits': '32', 10:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:29 INFO - 'title': 't-yosemite-r7-0281', 10:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:29 INFO - 'use_talos_json': True, 10:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:29 INFO - 'work_dir': 'build'} 10:07:29 INFO - [mozharness: 2016-12-08 18:07:29.028144Z] Running clobber step. 10:07:29 INFO - Running pre-action listener: _resource_record_pre_action 10:07:29 INFO - Running main action method: clobber 10:07:29 INFO - rmtree: /builds/slave/test/build 10:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:31 INFO - Running post-action listener: _resource_record_post_action 10:07:31 INFO - [mozharness: 2016-12-08 18:07:31.136802Z] Finished clobber step (success) 10:07:31 INFO - [mozharness: 2016-12-08 18:07:31.136933Z] Running read-buildbot-config step. 10:07:31 INFO - Running pre-action listener: _resource_record_pre_action 10:07:31 INFO - Running main action method: read_buildbot_config 10:07:31 INFO - Using buildbot properties: 10:07:31 INFO - { 10:07:31 INFO - "project": "", 10:07:31 INFO - "product": "firefox", 10:07:31 INFO - "script_repo_revision": "production", 10:07:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:07:31 INFO - "repository": "", 10:07:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:07:31 INFO - "buildid": "20161208074957", 10:07:31 INFO - "pgo_build": "False", 10:07:31 INFO - "basedir": "/builds/slave/test", 10:07:31 INFO - "buildnumber": 46, 10:07:31 INFO - "slavename": "t-yosemite-r7-0281", 10:07:31 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:07:31 INFO - "platform": "yosemite_r7", 10:07:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:07:31 INFO - "branch": "mozilla-aurora", 10:07:31 INFO - "repo_path": "releases/mozilla-aurora", 10:07:31 INFO - "revision": "d3c8c1a41bd773b1bf5a29b3c8066448d53d8ff5", 10:07:31 INFO - "stage_platform": "macosx64", 10:07:31 INFO - "builduid": "291a80d280cf4e98af053aaaebefbe7c", 10:07:31 INFO - "slavebuilddir": "test" 10:07:31 INFO - } 10:07:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:07:31 INFO - Running post-action listener: _resource_record_post_action 10:07:31 INFO - [mozharness: 2016-12-08 18:07:31.140344Z] Finished read-buildbot-config step (success) 10:07:31 INFO - [mozharness: 2016-12-08 18:07:31.140484Z] Running download-and-extract step. 10:07:31 INFO - Running pre-action listener: _resource_record_pre_action 10:07:31 INFO - Running main action method: download_and_extract 10:07:31 INFO - mkdir: /builds/slave/test/build/tests 10:07:31 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')]} 10:07:31 INFO - trying https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:07:31 INFO - Downloading https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:07:32 INFO - Downloaded 1199 bytes. 10:07:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:07:32 INFO - Using the following test package requirements: 10:07:32 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:07:32 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:07:32 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:07:32 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'jsshell-mac.zip'], 10:07:32 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:07:32 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:07:32 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:07:32 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:07:32 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:07:32 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:07:32 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:07:32 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:07:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:07:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:07:32 INFO - Fetch https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:07:33 INFO - Http code: 200 10:07:33 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 10:07:33 INFO - x-amz-cf-id: BiC6IFZr-XUl8A8pEpbhRt1gkry2zd2RRlchkcr2_LX8mZj-lamAaw== 10:07:33 INFO - x-amz-version-id: 7vtrxKzzgADBW4q7Za4P4fOJmN1X4is4 10:07:33 INFO - Expected file size: 16281198 10:07:33 INFO - Obtained file size: 16281198 10:07:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:07:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:07:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:07:40 INFO - Fetch https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:07:40 INFO - Http code: 200 10:07:40 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 10:07:40 INFO - x-amz-cf-id: md-2IWzXlsbl8phc_S2BEiGuhUbJmTgjt-ib4-vF7lX_BzfsE140NQ== 10:07:40 INFO - x-amz-version-id: 7vtrxKzzgADBW4q7Za4P4fOJmN1X4is4 10:07:41 INFO - Expected file size: 16281198 10:07:41 INFO - Obtained file size: 16281198 10:07:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:07:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:07:47 INFO - Fetch https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:07:47 INFO - Http code: 200 10:07:47 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:07:47 INFO - x-amz-cf-id: Uuc-MxVe2-eY_Z_Mihc_qELHgFBTEvKDQ2hrEhWuDh-IkCSc7xzlfQ== 10:07:47 INFO - x-amz-version-id: uYdSodXy4e2yBO94aCVhbNwhEwhAr5cn 10:07:48 INFO - Expected file size: 14409038 10:07:48 INFO - Obtained file size: 14409038 10:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:07:48 INFO - trying https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:07:48 INFO - Downloading https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:07:51 INFO - Downloaded 109769316 bytes. 10:07:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:07:51 INFO - mkdir: /builds/slave/test/properties 10:07:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:51 INFO - Contents: 10:07:51 INFO - build_url:https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:07:52 INFO - Running post-action listener: _resource_record_post_action 10:07:52 INFO - Running post-action listener: set_extra_try_arguments 10:07:52 INFO - [mozharness: 2016-12-08 18:07:52.172560Z] Finished download-and-extract step (success) 10:07:52 INFO - [mozharness: 2016-12-08 18:07:52.172697Z] Running populate-webroot step. 10:07:52 INFO - Running pre-action listener: _resource_record_pre_action 10:07:52 INFO - Running main action method: populate_webroot 10:07:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:52 INFO - '--tppagecycles', 10:07:52 INFO - '7'], 10:07:52 INFO - 'tests': ['tsvgm']}}, 10:07:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['damp', 'tps']}, 10:07:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'tests': ['damp', 'tps']}, 10:07:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['dromaeo_dom']}, 10:07:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['basic_compositor_video']}, 10:07:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:07:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['a11yr', 10:07:52 INFO - 'ts_paint', 10:07:52 INFO - 'tpaint', 10:07:52 INFO - 'sessionrestore', 10:07:52 INFO - 'sessionrestore_no_auto_restore', 10:07:52 INFO - 'tabpaint']}, 10:07:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:52 INFO - 'ts_paint', 10:07:52 INFO - 'tpaint', 10:07:52 INFO - 'sessionrestore', 10:07:52 INFO - 'sessionrestore_no_auto_restore', 10:07:52 INFO - 'tabpaint']}, 10:07:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:52 INFO - 'ts_paint', 10:07:52 INFO - 'tpaint', 10:07:52 INFO - 'sessionrestore', 10:07:52 INFO - 'sessionrestore_no_auto_restore', 10:07:52 INFO - 'tabpaint']}, 10:07:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:52 INFO - 'ts_paint', 10:07:52 INFO - 'tpaint', 10:07:52 INFO - 'sessionrestore', 10:07:52 INFO - 'sessionrestore_no_auto_restore', 10:07:52 INFO - 'tabpaint']}, 10:07:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['a11yr', 10:07:52 INFO - 'ts_paint', 10:07:52 INFO - 'tpaint', 10:07:52 INFO - 'sessionrestore', 10:07:52 INFO - 'sessionrestore_no_auto_restore', 10:07:52 INFO - 'tabpaint']}, 10:07:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['a11yr', 10:07:52 INFO - 'ts_paint', 10:07:52 INFO - 'tpaint', 10:07:52 INFO - 'sessionrestore', 10:07:52 INFO - 'sessionrestore_no_auto_restore', 10:07:52 INFO - 'tabpaint']}, 10:07:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['tsvgx', 10:07:52 INFO - 'tsvgr_opacity', 10:07:52 INFO - 'tart', 10:07:52 INFO - 'tscrollx', 10:07:52 INFO - 'cart']}, 10:07:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:52 INFO - 'tsvgr_opacity', 10:07:52 INFO - 'tart', 10:07:52 INFO - 'tscrollx', 10:07:52 INFO - 'cart']}, 10:07:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'talos_options': ['--disable-e10s'], 10:07:52 INFO - 'tests': ['tp5o']}, 10:07:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'tests': ['tp5o']}, 10:07:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'talos_options': ['--disable-e10s', 10:07:52 INFO - '--xperf_path', 10:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:52 INFO - 'tests': ['tp5n']}, 10:07:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:52 INFO - 'talos_options': ['--xperf_path', 10:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:52 INFO - 'tests': ['tp5n']}}, 10:07:52 INFO - 'talos.zip': {'path': '', 10:07:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:52 INFO - Running post-action listener: _resource_record_post_action 10:07:52 INFO - [mozharness: 2016-12-08 18:07:52.191372Z] Finished populate-webroot step (success) 10:07:52 INFO - [mozharness: 2016-12-08 18:07:52.191470Z] Running create-virtualenv step. 10:07:52 INFO - Running pre-action listener: _resource_record_pre_action 10:07:52 INFO - Running main action method: create_virtualenv 10:07:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:52 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 10:07:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:52 INFO - Using real prefix '/tools/python27' 10:07:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:55 INFO - Installing pip.................done. 10:07:55 INFO - Return code: 0 10:07:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:07:56 INFO - Reading from file tmpfile_stdout 10:07:56 INFO - Output received: 10:07:56 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) 10:07:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:07: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', 'pip>=1.5'] in /builds/slave/test/build 10:07: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 pip>=1.5 10:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:56 INFO - 'HOME': '/Users/cltbld', 10:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:56 INFO - 'LOGNAME': 'cltbld', 10:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:56 INFO - 'MOZ_NO_REMOTE': '1', 10:07:56 INFO - 'NO_EM_RESTART': '1', 10:07:56 INFO - 'PAGER': '/bin/cat', 10:07:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:56 INFO - 'PWD': '/builds/slave/test', 10:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:56 INFO - 'SHELL': '/bin/bash', 10:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:07:56 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:56 INFO - 'USER': 'cltbld', 10:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:56 INFO - 'XPC_FLAGS': '0x0', 10:07:56 INFO - 'XPC_SERVICE_NAME': '0', 10:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 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 10:07:56 INFO - Cleaning up... 10:07:56 INFO - Return code: 0 10:07:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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', '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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:07: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 psutil>=3.1.1 10:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:07:56 INFO - 'HOME': '/Users/cltbld', 10:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:07:56 INFO - 'LOGNAME': 'cltbld', 10:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:56 INFO - 'MOZ_NO_REMOTE': '1', 10:07:56 INFO - 'NO_EM_RESTART': '1', 10:07:56 INFO - 'PAGER': '/bin/cat', 10:07:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:56 INFO - 'PWD': '/builds/slave/test', 10:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:07:56 INFO - 'SHELL': '/bin/bash', 10:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:07:56 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:07:56 INFO - 'USER': 'cltbld', 10:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:56 INFO - 'XPC_FLAGS': '0x0', 10:07:56 INFO - 'XPC_SERVICE_NAME': '0', 10:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:56 INFO - Downloading/unpacking psutil>=3.1.1 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:00 INFO - Installing collected packages: psutil 10:08:00 INFO - Running setup.py install for psutil 10:08:00 INFO - building 'psutil._psutil_osx' extension 10:08:00 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 10:08:01 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 10:08:01 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 10:08:01 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 10:08:01 INFO - building 'psutil._psutil_posix' extension 10:08:01 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 10:08:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:08:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:08:01 INFO - ^ 10:08:01 INFO - 1 warning generated. 10:08:01 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 10:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:01 INFO - Successfully installed psutil 10:08:01 INFO - Cleaning up... 10:08:01 INFO - Return code: 0 10:08:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:01 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:01 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 10:08:01 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 10:08:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:01 INFO - 'HOME': '/Users/cltbld', 10:08:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:01 INFO - 'LOGNAME': 'cltbld', 10:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:01 INFO - 'MOZ_NO_REMOTE': '1', 10:08:01 INFO - 'NO_EM_RESTART': '1', 10:08:01 INFO - 'PAGER': '/bin/cat', 10:08:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:01 INFO - 'PWD': '/builds/slave/test', 10:08:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:01 INFO - 'SHELL': '/bin/bash', 10:08:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:01 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:01 INFO - 'USER': 'cltbld', 10:08:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:01 INFO - 'XPC_FLAGS': '0x0', 10:08:01 INFO - 'XPC_SERVICE_NAME': '0', 10:08:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:08:01 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 10:08:01 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 10:08:01 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 10:08:01 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 10:08:01 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 10:08:01 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 10:08:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:08:04 INFO - Installing collected packages: mozsystemmonitor 10:08:04 INFO - Running setup.py install for mozsystemmonitor 10:08:04 INFO - Successfully installed mozsystemmonitor 10:08:04 INFO - Cleaning up... 10:08:04 INFO - Return code: 0 10:08:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:04 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:04 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 10:08:04 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 10:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:04 INFO - 'HOME': '/Users/cltbld', 10:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:04 INFO - 'LOGNAME': 'cltbld', 10:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:04 INFO - 'MOZ_NO_REMOTE': '1', 10:08:04 INFO - 'NO_EM_RESTART': '1', 10:08:04 INFO - 'PAGER': '/bin/cat', 10:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:04 INFO - 'PWD': '/builds/slave/test', 10:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:04 INFO - 'SHELL': '/bin/bash', 10:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:04 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:04 INFO - 'USER': 'cltbld', 10:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:04 INFO - 'XPC_FLAGS': '0x0', 10:08:04 INFO - 'XPC_SERVICE_NAME': '0', 10:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:08:05 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 10:08:05 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 10:08:05 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 10:08:05 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 10:08:05 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 10:08:05 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 10:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:08 INFO - warning: no files found matching '*.txt' 10:08:08 INFO - no previously-included directories found matching 'build' 10:08:08 INFO - no previously-included directories found matching 'dist' 10:08:08 INFO - no previously-included directories found matching '.git*' 10:08:08 INFO - Installing collected packages: jsonschema, functools32 10:08:08 INFO - Running setup.py install for functools32 10:08:08 INFO - warning: no files found matching '*.txt' 10:08:08 INFO - no previously-included directories found matching 'build' 10:08:08 INFO - no previously-included directories found matching 'dist' 10:08:08 INFO - no previously-included directories found matching '.git*' 10:08:08 INFO - Successfully installed jsonschema functools32 10:08:08 INFO - Cleaning up... 10:08:08 INFO - Return code: 0 10:08:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:08 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:08 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 10:08:08 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 10:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:08 INFO - 'HOME': '/Users/cltbld', 10:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:08 INFO - 'LOGNAME': 'cltbld', 10:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:08 INFO - 'MOZ_NO_REMOTE': '1', 10:08:08 INFO - 'NO_EM_RESTART': '1', 10:08:08 INFO - 'PAGER': '/bin/cat', 10:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:08 INFO - 'PWD': '/builds/slave/test', 10:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:08 INFO - 'SHELL': '/bin/bash', 10:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:08 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:08 INFO - 'USER': 'cltbld', 10:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:08 INFO - 'XPC_FLAGS': '0x0', 10:08:08 INFO - 'XPC_SERVICE_NAME': '0', 10:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:08:08 INFO - Cleaning up... 10:08:08 INFO - Return code: 0 10:08:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:08 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:08 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 10:08:08 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 10:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:08 INFO - 'HOME': '/Users/cltbld', 10:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:08 INFO - 'LOGNAME': 'cltbld', 10:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:08 INFO - 'MOZ_NO_REMOTE': '1', 10:08:08 INFO - 'NO_EM_RESTART': '1', 10:08:08 INFO - 'PAGER': '/bin/cat', 10:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:08 INFO - 'PWD': '/builds/slave/test', 10:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:08 INFO - 'SHELL': '/bin/bash', 10:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:08 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:08 INFO - 'USER': 'cltbld', 10:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:08 INFO - 'XPC_FLAGS': '0x0', 10:08:08 INFO - 'XPC_SERVICE_NAME': '0', 10:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:09 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:09 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 10:08:09 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 10:08:09 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 10:08:09 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 10:08:09 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 10:08:09 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 10:08:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:11 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 10:08:11 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 10:08:11 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 10:08:11 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 10:08:11 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 10:08:11 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 10:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 INFO - Downloading docopt-0.6.1.tar.gz 10:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:13 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:13 INFO - Running setup.py install for blobuploader 10:08:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:13 INFO - Running setup.py install for requests 10:08:13 INFO - Running setup.py install for docopt 10:08:13 INFO - Successfully installed blobuploader requests docopt 10:08:13 INFO - Cleaning up... 10:08:13 INFO - Return code: 0 10:08:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:13 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:13 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 10:08:13 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 10:08:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:13 INFO - 'HOME': '/Users/cltbld', 10:08:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:13 INFO - 'LOGNAME': 'cltbld', 10:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:13 INFO - 'MOZ_NO_REMOTE': '1', 10:08:13 INFO - 'NO_EM_RESTART': '1', 10:08:13 INFO - 'PAGER': '/bin/cat', 10:08:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:13 INFO - 'PWD': '/builds/slave/test', 10:08:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:13 INFO - 'SHELL': '/bin/bash', 10:08:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:13 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:13 INFO - 'USER': 'cltbld', 10:08:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:13 INFO - 'XPC_FLAGS': '0x0', 10:08:13 INFO - 'XPC_SERVICE_NAME': '0', 10:08:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Y39rt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-aNMmDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-P0aMnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-nVfSfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-QbOc_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-4m2xVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-CoxNK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:14 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-qdNHDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-f7fHnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-w1y9bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-2v9clG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-S6mnPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-5T80Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-7GVcRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-eUHD1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-CwPXAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:15 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-o1hUNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:15 INFO - Running setup.py install for manifestparser 10:08:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:16 INFO - Running setup.py install for mozcrash 10:08:16 INFO - Running setup.py install for mozdebug 10:08:16 INFO - Running setup.py install for mozdevice 10:08:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:16 INFO - Running setup.py install for mozfile 10:08:16 INFO - Running setup.py install for mozhttpd 10:08:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:16 INFO - Running setup.py install for mozinfo 10:08:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:16 INFO - Running setup.py install for mozInstall 10:08:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Running setup.py install for mozleak 10:08:17 INFO - Running setup.py install for mozlog 10:08:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Running setup.py install for moznetwork 10:08:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Running setup.py install for mozprocess 10:08:17 INFO - Running setup.py install for mozprofile 10:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:17 INFO - Running setup.py install for mozrunner 10:08:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Running setup.py install for mozscreenshot 10:08:18 INFO - Running setup.py install for moztest 10:08:18 INFO - Running setup.py install for mozversion 10:08:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:18 INFO - Cleaning up... 10:08:18 INFO - Return code: 0 10:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:18 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:18 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 10:08:18 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 10:08:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:18 INFO - 'HOME': '/Users/cltbld', 10:08:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:18 INFO - 'LOGNAME': 'cltbld', 10:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:18 INFO - 'MOZ_NO_REMOTE': '1', 10:08:18 INFO - 'NO_EM_RESTART': '1', 10:08:18 INFO - 'PAGER': '/bin/cat', 10:08:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:18 INFO - 'PWD': '/builds/slave/test', 10:08:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:18 INFO - 'SHELL': '/bin/bash', 10:08:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:18 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:18 INFO - 'USER': 'cltbld', 10:08:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:18 INFO - 'XPC_FLAGS': '0x0', 10:08:18 INFO - 'XPC_SERVICE_NAME': '0', 10:08:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:18 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-SmCcp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:18 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)) 10:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:18 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-FhVJ99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:18 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)) 10:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:18 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-WJlLzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-jgYrKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-eX1i7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-gDS8uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-OUvst_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ic82lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-CkkvTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ud4Tjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-8eRSmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:19 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)) 10:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:19 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-IKWCLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:20 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ycZbcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:20 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ExLYmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:20 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-sM2whq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:20 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)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:20 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Rp_VSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:20 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-B7Dt9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:20 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)) 10:08:20 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)) 10:08:20 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)) 10:08:20 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)) 10:08:20 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)) 10:08:20 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)) 10:08:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:20 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 10:08:20 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 10:08:20 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 10:08:20 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 10:08:20 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 10:08:20 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 10:08:23 INFO - Downloading blessings-1.6.tar.gz 10:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:23 INFO - Installing collected packages: blessings 10:08:23 INFO - Running setup.py install for blessings 10:08:23 INFO - Successfully installed blessings 10:08:23 INFO - Cleaning up... 10:08:23 INFO - Return code: 0 10:08:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:23 INFO - Reading from file tmpfile_stdout 10:08:23 INFO - Current package versions: 10:08:23 INFO - blessings == 1.6 10:08:23 INFO - blobuploader == 1.2.4 10:08:23 INFO - docopt == 0.6.1 10:08:23 INFO - functools32 == 3.2.3-2 10:08:23 INFO - jsonschema == 2.5.1 10:08:23 INFO - manifestparser == 1.1 10:08:23 INFO - mozInstall == 1.12 10:08:23 INFO - mozcrash == 1.0 10:08:23 INFO - mozdebug == 0.1 10:08:23 INFO - mozdevice == 0.48 10:08:23 INFO - mozfile == 1.2 10:08:23 INFO - mozhttpd == 0.7 10:08:23 INFO - mozinfo == 0.9 10:08:23 INFO - mozleak == 0.1 10:08:23 INFO - mozlog == 3.4 10:08:23 INFO - moznetwork == 0.27 10:08:23 INFO - mozprocess == 0.23 10:08:23 INFO - mozprofile == 0.28 10:08:23 INFO - mozrunner == 6.13 10:08:23 INFO - mozscreenshot == 0.1 10:08:23 INFO - mozsystemmonitor == 0.3 10:08:23 INFO - moztest == 0.7 10:08:23 INFO - mozversion == 1.4 10:08:23 INFO - psutil == 3.1.1 10:08:23 INFO - requests == 1.2.3 10:08:23 INFO - wsgiref == 0.1.2 10:08:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:23 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')]} 10:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:23 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')]} 10:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:23 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:23 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 10:08:23 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 10:08:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:23 INFO - 'HOME': '/Users/cltbld', 10:08:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:23 INFO - 'LOGNAME': 'cltbld', 10:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:23 INFO - 'MOZ_NO_REMOTE': '1', 10:08:23 INFO - 'NO_EM_RESTART': '1', 10:08:23 INFO - 'PAGER': '/bin/cat', 10:08:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:23 INFO - 'PWD': '/builds/slave/test', 10:08:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:23 INFO - 'SHELL': '/bin/bash', 10:08:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:23 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:23 INFO - 'USER': 'cltbld', 10:08:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:23 INFO - 'XPC_FLAGS': '0x0', 10:08:23 INFO - 'XPC_SERVICE_NAME': '0', 10:08:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 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)) 10:08:24 INFO - Cleaning up... 10:08:24 INFO - Return code: 0 10:08:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08:24 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')]} 10:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:24 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')]} 10:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:24 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 0x10080d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100783570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd11ad304f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, '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.jjpjOBsaN4/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.DEVMof5f0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 10:08:24 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 10:08:24 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 10:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:24 INFO - 'HOME': '/Users/cltbld', 10:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:24 INFO - 'LOGNAME': 'cltbld', 10:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:24 INFO - 'MOZ_NO_REMOTE': '1', 10:08:24 INFO - 'NO_EM_RESTART': '1', 10:08:24 INFO - 'PAGER': '/bin/cat', 10:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:24 INFO - 'PWD': '/builds/slave/test', 10:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:24 INFO - 'SHELL': '/bin/bash', 10:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:24 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:24 INFO - 'USER': 'cltbld', 10:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:24 INFO - 'XPC_FLAGS': '0x0', 10:08:24 INFO - 'XPC_SERVICE_NAME': '0', 10:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:08:24 INFO - Cleaning up... 10:08:24 INFO - Return code: 0 10:08:24 INFO - Running post-action listener: _resource_record_post_action 10:08:24 INFO - Running post-action listener: _start_resource_monitoring 10:08:24 INFO - Starting resource monitoring. 10:08:24 INFO - [mozharness: 2016-12-08 18:08:24.373575Z] Finished create-virtualenv step (success) 10:08:24 INFO - [mozharness: 2016-12-08 18:08:24.374544Z] Running install step. 10:08:24 INFO - Running pre-action listener: _resource_record_pre_action 10:08:24 INFO - Running main action method: install 10:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:24 INFO - Reading from file tmpfile_stdout 10:08:24 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:24 INFO - Reading from file tmpfile_stdout 10:08:24 INFO - Output received: 10:08:24 INFO - Usage: mozinstall [options] installer 10:08:24 INFO - Options: 10:08:24 INFO - -h, --help show this help message and exit 10:08:24 INFO - -d DEST, --destination=DEST 10:08:24 INFO - Directory to install application into. [default: 10:08:24 INFO - "/builds/slave/test"] 10:08:24 INFO - --app=APP Application being installed. [default: firefox] 10:08:24 INFO - mkdir: /builds/slave/test/build/application 10:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:08:55 INFO - Reading from file tmpfile_stdout 10:08:55 INFO - Output received: 10:08:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:08:55 INFO - Running post-action listener: _resource_record_post_action 10:08:55 INFO - [mozharness: 2016-12-08 18:08:55.469283Z] Finished install step (success) 10:08:55 INFO - [mozharness: 2016-12-08 18:08:55.469398Z] Running run-tests step. 10:08:55 INFO - Running pre-action listener: _resource_record_pre_action 10:08:55 INFO - Running main action method: run_tests 10:08:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:08:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:08:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:08:55 INFO - 2016-12-08 10:08:55.483 screenresolution[1630:8710] starting screenresolution argv=screenresolution get 10:08:55 INFO - 2016-12-08 10:08:55.486 screenresolution[1630:8710] Display 0: 1600x1200x32@60 10:08:55 INFO - 2016-12-08 10:08:55.492 screenresolution[1631:8712] starting screenresolution argv=screenresolution list 10:08:55 INFO - Available Modes on Display 0 10:08:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:08:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:08:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:08:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:08:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:08:55 INFO - Intel Iris: 10:08:55 INFO - Chipset Model: Intel Iris 10:08:55 INFO - Type: GPU 10:08:55 INFO - Bus: Built-In 10:08:55 INFO - VRAM (Dynamic, Max): 1536 MB 10:08:55 INFO - Vendor: Intel (0x8086) 10:08:55 INFO - Device ID: 0x0a2e 10:08:55 INFO - Revision ID: 0x0009 10:08:55 INFO - Displays: 10:08:55 INFO - Display: 10:08:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:08:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:08:55 INFO - Display Serial Number: 1600x1200 60 10:08:55 INFO - Main Display: Yes 10:08:55 INFO - Mirror: Off 10:08:55 INFO - Online: Yes 10:08:55 INFO - Rotation: Supported 10:08:55 INFO - Return code: 0 10:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:55 INFO - Python 2.7.3 10:08:55 INFO - Return code: 0 10:08:55 INFO - grabbing minidump binary from tooltool 10:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100621d30>, '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 0x100487db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100619b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:08:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:08:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:08:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:55 INFO - Return code: 0 10:08:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:08:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:08:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 10:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0281 --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 10:08:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjpjOBsaN4/Render', 10:08:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:55 INFO - 'HOME': '/Users/cltbld', 10:08:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:55 INFO - 'LOGNAME': 'cltbld', 10:08:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:55 INFO - 'MOZ_NO_REMOTE': '1', 10:08:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:55 INFO - 'NO_EM_RESTART': '1', 10:08:55 INFO - 'PAGER': '/bin/cat', 10:08:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:55 INFO - 'PWD': '/builds/slave/test', 10:08:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:55 INFO - 'SHELL': '/bin/bash', 10:08:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DEVMof5f0n/Listeners', 10:08:55 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 10:08:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:55 INFO - 'USER': 'cltbld', 10:08:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:55 INFO - 'XPC_FLAGS': '0x0', 10:08:55 INFO - 'XPC_SERVICE_NAME': '0', 10:08:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 10:08:56 INFO - mozversion application_buildid: 20161208074957 10:08:56 INFO - mozversion application_changeset: d3c8c1a41bd773b1bf5a29b3c8066448d53d8ff5 10:08:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:08:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:56 INFO - mozversion application_name: Firefox 10:08:56 INFO - mozversion application_remotingname: firefox-dev 10:08:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:08:56 INFO - mozversion application_vendor: Mozilla 10:08:56 INFO - mozversion application_version: 52.0a2 10:08:56 INFO - mozversion platform_buildid: 20161208074957 10:08:56 INFO - mozversion platform_changeset: d3c8c1a41bd773b1bf5a29b3c8066448d53d8ff5 10:08:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:08:56 INFO - mozversion platform_version: 52.0a2 10:08:56 INFO - using testdate: 1481220536 10:08:56 INFO - actual date: 1481220536 10:08:56 INFO - starting webserver on 'localhost:49248' 10:08:56 INFO - SUITE-START | Running 2 tests 10:08:56 INFO - TEST-START | dromaeo_css 10:08:56 INFO - operating with platform_type : mac_ 10:08:56 INFO - Initialising browser for dromaeo_css test... 10:08:56 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpBsixJZ/profile http://localhost:49248/getInfo.html) 10:08:59 INFO - PROCESS | 1641 | 2016-12-08 10:08:59.119 plugin-container[1643:8901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 10:08:59 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:08:59 INFO - PROCESS | 1641 | 2016-12-08 10:08:59.121 plugin-container[1643:8901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 10:08:59 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:08:59 INFO - PROCESS | 1641 | 2016-12-08 10:08:59.121 plugin-container[1643:8901] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:08:59 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 10:08:59 INFO - PROCESS | 1641 | colorDepth:24 10:08:59 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 10:08:59 INFO - PROCESS | 1641 | __metrics 10:08:59 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:09:00 INFO - TEST-INFO | 1641: exit 0 10:09:00 INFO - Browser initialized. 10:09:00 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:00 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpBsixJZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:02 INFO - PROCESS | 1645 | 2016-12-08 10:09:02.668 plugin-container[1646:9034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 10:09:02 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:02 INFO - PROCESS | 1645 | 2016-12-08 10:09:02.669 plugin-container[1646:9034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 10:09:02 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:02 INFO - PROCESS | 1645 | 2016-12-08 10:09:02.669 plugin-container[1646:9034] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:09:12 INFO - PROCESS | 1645 | RSS: Main: 229326848 10:09:12 INFO - PROCESS | 1645 | 10:10:01 INFO - PROCESS | 1645 | 1481220601985 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:12:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 10:12:18 INFO - PROCESS | 1645 | RSS: Main: 234078208 10:12:18 INFO - PROCESS | 1645 | 10:15:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 10:15:21 INFO - PROCESS | 1645 | RSS: Main: 243372032 10:15:21 INFO - PROCESS | 1645 | 10:18:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 10:18:23 INFO - PROCESS | 1645 | RSS: Main: 246312960 10:18:23 INFO - PROCESS | 1645 | 10:21:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 10:21:26 INFO - PROCESS | 1645 | RSS: Main: 245641216 10:21:26 INFO - PROCESS | 1645 | 10:24:29 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:24:29 INFO - PROCESS | 1645 | RSS: Main: 249049088 10:24:29 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:27:32 INFO - PROCESS | 1645 | RSS: Main: 250748928 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | __start_tp_report 10:27:32 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 10:27:32 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 10:27:32 INFO - PROCESS | 1645 | |i|pagename|runs| 10:27:32 INFO - PROCESS | 1645 | |0;dojo.html;3378.645242249562;3384.6615338466154;3405.6083550391713;3415.7267418606516;3419.4186988212;4547.340635607835;4601.95398046019;5520.14437762147;5634.36305146602;5732.942670573293;5667.376588575254;5688.175214593882;5714.342850572186;5754.482096611304;5773.566982476321;4581.358609794632;4789.9462118333995;5227.47725227478;5248.422673505911;5267.473252674721;5211.921821172686;5216.139337009389;5256.894862102756;5280.049591073605;5343.679379237239;5116.053530096944;5145.974270128644;5260.158374660055;5268.288781014571;5269.473052694719;5145.845624631248;5178.689278643255;5210.270562121306;5210.76551555181;5229.320188375525;5130.563902068291;5138.126518491866;5199.064168449678;5218.791248350061;5260.684358938476;5710.371859095538;5710.657360558338;5713.914291285634;5715.228444160027;5758.971205143989;6040.214772079646;6117.388261173892;6154.569180157391;6192.845178870519;6193.318734939153;6129.114290130706;6132.845047373404;6200.379962003809;6210.161628180228;6219.564630475868;5786.71066446676;5790.942090579125;5821.126830975388;5856.443637854397;5860.853478663067;6210.5652604317265;6249.062640603855;6275.811725648238;6297.086922396318;6321.494280457552;6050.273967123885;6062.605930614496;6079.635221886701;6188.947878860605;6189.164462797555;6142.815715528542;6212.409821066992;6215.34738852423;6215.720292586844;6218.284897236786;5678.943210567924;5806.564507661942;6110.877782444326;6183.258009038944;6184.783532576338;6037.818865434044;6110.388961103854;6127.6936153193055;6147.354527774609;6206.534509911684;4181.644560212416;4886.633502487328;4888.560029597354;4909.361782968192;4970.428400733962;3718.925621487609;4375.47494300686;4381.233284175257;4401.9875428651585;4403.273459879084;5787.88424231513;5884.264466941632;5903.291605007426;5904.261967254093;5929.199558059693;6058.606190597597;6118.6191791732535;6121.632702037892;6122.632642041492;6150.630962142286;5920.259967504062;5935.287765468085;5945.197398351167;5959.523238140939;5971.611845230046;5221.530062294336;5288.65623734456;5304.124819404832;5323.893522129536;5411;5377.758000889891;6168.629882207082;6226.066090086523;6299.118123462627;6369.45859601939;5122.641415101056;6141.692915354304;6145.064304743992;6166.013437850102;6222.968885155546;6176.752929882754;6289.716962736779;6312.43188113072;6322.36776322364;6338.112664227104;5425.945740542544;6152.077188421773;6178.073289006685;6178.691065446799;6212.658303793335;5543.61194716366;5743.4256574342235;6164.04225632834;6173;6219.906701399573;5727.713614319351;6027.849303767441;6064.3935606439;6081.209442772411;6152.938470615416;6122.571420000557;6123.877522449615;6144.56988010835;6145.4161854623735;6152.292486364126;4775.283707443911;5744.396838331915;5839.124131380157;5991.490723288569;5996.8800623988145;5934.376890426615;5981.910271345846;6007.30915944672;6026.578139530367;6044.939550604614;4738.431388233434;4871.244957031666;5878.764849405976;5883.176355310346;5887.8233652990475 10:27:32 INFO - PROCESS | 1645 | |1;ext.html;473.31605829576256;479.2523663085587;480.7572425280648;509.08619028843225;533.1496263459783;35340.823295883514;38826.61173388265;38855.61144388555;38884.416733749014;40473.19053618933;39675;40163.99590010251;40236;40310.59689403105;40360.19279614406;9174.40366376185;9343;9355.6434317024;9356.578953947088;9386.155246027856;9306;9323.860142097874;9394.671186508474;9402.858957115648;9456.479893605849;9350.39222450542;9442.19741321985;9459.479728614924;9477.763055923588;9489.335746497747;9377.156055954963;9441.952790236073;9448.716538503855;9454.669086582006;9722.756931076708;9288.582013809328;9367.906320936772;9391.295652826066;9410.90589094114;9417.011213822587;38451.42322865159;38837.80581097076;38863.222735545416;38875.805620971994;39003;3212.791168574035;3282.343531293751;3450.5341778859784;3466.0814884055744;3685.4287585424304;28416.431671366456;28446.28884277889;29549.670264838132;29631.962881299052;30562.54156187659;3094.164575564585;3187.42626327261;3194.0417874637515;3257.0066129830393;3288.704016638514;498323.9999999964;504287;504464;505103;505968;56601.71699141478;56894;56984;57065.14402283886;57199.714001429726;57521;57990;58107;58279.41720582825;58351.832963340494;15257.923710381378;15267.618309542127;15496.845031549765;15530.767038494432;15549.378024878879;12054;12128.63614091561;12152.453139608739;12152.878471215352;12163.695907602203;14715.779263311058;14835.03572267799;14924.850751492564;14938.477153299582;15045.924770376078;2590.9481810363686;6477.838054048687;6735.966320168466;6808.557443766139;6832.555883867532;782.2646712090617;794.4478587381715;915.6905624956377;1052.21609900623;1106.590561492253;25044.499110018063;25322.620160697603;27902.86048569744;29669.703302966693;30072.69927300699;881.6341218394294;982.1308142293979;1015.8780946286345;1103.0128035408266;1121.2187419309962;12474.625761227178;13480.595582132551;14534.255889293352;15352;15407.229638518029;687188.5640571865;692437;695526;696433;698452;55172.448275517534;55890.72054639701;55902;55963.16055259174;56321.43678563244;1360.8366995960548;1372.1698372484502;1383.1700979412271;1391.7146984868077;1394.0799072612028;28708.85645571842;29378.265543361587;29383.55924661089;29439.705602943697;29889.252768680955;42150.36774448447;47960.5203947956;47996.760016199696;48015.75992120017;48214.75892620515;646647;650189;651917;652658;654176;25718.61422078633;25975.870120649277;26026.86986565055;26071.869640651676;26089.73910260873;44393.55606443894;44452.33321500245;44791.55208447874;47368.289475657206;48265.517344826105;37436.625633743315;37535.81232093822;37720.05699857525;37996.24007519779;39148.02129946774;36263.912082637566;36397.272054558234;37126.25747484981;37248.81375593105;37488.62511374961;36697.71557995457;36773;36861.631383686894;37238.25523489569;37244;33054.669453305156;33897.661023390436;34171.65828341685;34184.82907585446;34261.143471413416;22818.771812281666;25156.496870062863;25403.237902862944;25457.745422545537;25883.611745824204 10:27:32 INFO - PROCESS | 1645 | |2;jquery.html;302.74720608292074;366.12496134239166;378.80870160568907;382.06394333881997;395.57278139609224;17945.910270448647;18801.435956921297;19014.71477927832;19498;19764.30824921128;18918.810811891875;19197.616047679072;19349.322773702923;19357.128929198185;19410.902945485253;5833.212516310286;6109.480694141003;6145.754169833202;6153.753849846001;6165.722542485577;5441.537469315113;5710.685912274823;5778.248827652399;5829.154772557977;5846.795362162326;5053.989202159564;5169.974150129244;5490.3411590609185;5792.739326730307;5802.53579713624;6540.542162048659;6630.834229144261;6636.634985075843;6642.734290628369;6646.501512386566;3855.402412626019;4050.6354428101613;4087.7751723655188;5864.76540938362;5902.203202567642;12689;12897.484100635964;12938.935305323508;12952;20552.76683399001;2148.1514801653416;2163.642998905179;2249.1678079110834;2385.689860318165;2710.1869439168368;8577.442466239674;9540.952295238549;9602.471864047475;9648.855267170999;9700.805983880353;1760.4630587670756;1770.5839127804957;1799.8290162434548;1808.5569035586234;1866.7946525882141;120972.39513802463;126877.36561317135;130855.34572327077;132468;133003.33498332542;10312.948435257777;11553.480093395818;11802.291862488279;11857.88142118585;11859.644210673521;14273.214973176575;14425.350859211361;14440.350184241734;14451.78322325166;14471.710565788626;8247.670093196324;8397.538135402488;8424.031236407769;8437.156284371637;8520.360972927056;6883.965580172067;8278.089410164877;8349.123342048997;8481.236688698047;8506.404551681322;3776.33914065043;4365.497967733688;4524.253498172765;4525.977370113128;4546.181687296253;1777.7644537046629;1830.8352248297717;1861.9255229790926;1933.806619338083;1963.3717210492505;839.928606068491;870.8780770692108;884.8672699095188;942.34036174678;955.5270141279972;19444.250017498493;20489.79510204879;20668.79281950739;20764.480887977923;20931.68602470964;906.8186362727349;929.177677755178;937.0488953711988;937.1659223291276;955.7897262602216;7715.768526944201;10387.84418233727;10971.725706857393;10985.340879547253;10989.505472253768;575560;581833;582687;610778;622808;123834.38082809528;125976.74023259833;129957.46040622338;131734.34132829466;134396.29612963498;979.2215188924964;1010.3281317923645;1042.8904964978567;1042.9478526073665;1045.968620941373;18045.368412105512;18197.727034094234;18447.24751148639;18860.05699715036;19074;53758.19362709641;55031.89936201333;55182.448175519334;55700.72149639226;55779.16331255116;62835;70767.64616176886;77484;78651;80256;6941.895871561829;7182.820429489305;7386.630668466448;7882.172371901097;8070.757877263692;12122.636320910387;12741;12923.870761292643;12936.288504132363;13075.411606477921;10783.568657253936;10808.513616887416;10842.837357439486;11090.500927458123;11127.443627818415;10763.730906727395;10931.672049838518;10950.34297942126;10984.670459886216;11034.786173521066;10192.388456692623;10297.897021029994;10335.896641033794;10492.213084018576;10647.988441098083;6985.917182836669;7169.247229041084;7221.494495385273;7322.3775979042375;7428.145763237297;8575.91424085776;10013.749656258651;10045.09594136502;10085.798284034425;10373.481325933522 10:27:32 INFO - PROCESS | 1645 | |3;mootools.html;1371.52682324598;1465.2820118142113;1632.9591760205994;1736.1753167245552;1778.1464896849511;7151.749688760894;7419.480636355457;8005.839153322765;8402.075771665119;8403.579821008949;7147.642617869112;8091.757247282591;8121.959390203041;8197.79505512361;8198.549079800623;2265.048679554591;2288.061894623205;2292.988535057322;2293.3463962770616;2294.9655755163685;2294.816414686821;2327.9883600581975;2349.659299401586;2352.811775058;2360.0205914545527;2293.747687754354;2299.3331933739196;2316.536692661466;2320.5590937721863;2323.59337116004;2269.636858102704;2276.1805749930013;2291.747907730148;2310.838241323108;2316.5945959457194;2294.4149241943196;2315.9305220843403;2316.1661801751357;2318.501522172741;2331.813454923619;8229.341652667772;8238.794030149234;8282.461639993442;8342.249197572188;8370.204830541088;5026.346574945271;5172.250023746536;5182.041322355376;5186.688798672092;5188.844334669966;3241.6434192238835;3445.459344775033;3487.7907325560295;3567.9643203567894;3574.6425357464304;1020.0564477857952;1026.2149455666422;1089.7221208591839;1097.412884106999;1111.5831563163813;10692.411917344543;10786.298890572089;10795.83806242907;10879.945600271947;10891.67324980244;3720.3861362874823;3882.6117388261514;3972.7219094663674;4631.9536804631525;4709.128811169944;9307.06929307064;9368.95315523418;9370.437773733598;9380.8592871107;9409;5126.512981266774;5130.79476820923;5131.923021154686;5144.922826157611;5167;3720.014196237999;4195.223883581547;4623.722576645412;4667.486576476585;4704.529547045268;3812.14226798968;3834.750741201813;3868.6131386861653;3898.493195884517;3930.8820735377985;1084.9077828384518;1097.1716354152563;1257;1263.7093468502112;1285.9742805143844;826.6982551368707;855.3029281135854;860.8880845490171;866.1165611076666;913.2055112052557;5536.75084621193;5610.7194640268635;5808.506276966421;5888.205092312569;5906.49794767441;888.493558671564;914.7850255190025;930.9218214639127;939.5584075484511;985.2708995343394;3655.2689462107683;3819.1788765415567;3874.9031274217805;3921.764694118362;3955.8417663293144;9741.756456088513;10126.443045632413;10149.64476243328;10150.796984060426;10209.38743675382;9401;9648.855267170999;10094.293399461967;10117.747056323651;10176.287659863887;7543.509671871311;7762.728304509315;7777.300042996045;7780.649870755829;7801.4929029612895;5725.16985037159;5738.598298119258;5788.0739081746715;5829.94170058294;5837.124431335334;9193.494357810117;9216.124468175512;9291.581878815605;9352.392094513834;9431.62273509052;7760;9292.674756383494;9299.83752030996;9402.106799854002;9420.717378478657;6541.836454088686;6781.457483401415;6917.584944903322;7053.647317634201;7195.38839198653;7758;7841.529508229524;7920.762377128695;7929.960350198443;7943.801404964922;6995.615241161785;7154.606496642735;7213.3868621167785;7248.0939882514685;7252.948322493315;6968.860622787414;6982.682115429459;7079.610621415872;7125.1093613298335;7221.67502462401;6558.114654521579;6703.4972377070935;6706.960421134732;6712.83217919556;6729.663516824237;4089.5092588889524;4783;4792.257200133985;4870.00164966174;4901.509849015212;4792.3530323407285;4829.227323628203;4850.927236091391;4994.775235114501;5075.6193285502995 10:27:32 INFO - PROCESS | 1645 | |4;prototype.html;301.3100000997715;303.6629341431011;308.2002204279893;310.424163177306;316.53785473209115;4947.7031378117335;5241.371035475749;5461.006732542618;5542.612017158795;5593.244911936888;4724.771559394557;5351.946480535194;5418.913718218485;5434.945650543494;5443.265159203506;4136.5036195656485;4148.3777433385085;4158.08522125132;4171.6036976487185;4190.2248084104385;3698.149425632106;3854.8650797222103;4157.937630935538;4158.9376159357635;4164.625183733463;3396.8811091611797;3716.8141592920247;4012.7993600320015;4023.6982226333;4043.939340909889;3852.6725228355485;4081.55102938678;4101.958980410188;4112.794360281974;4112.794360282004;3017.200441882903;3046.7105624965593;3217.436948533997;3468.739844511672;3553.218291975761;4869.028043642331;5032.245163225545;5277.287566178555;5339.866503337447;5340.706261155635;4612.7924243409125;4613.953860461386;4615.569173556209;4667.15991121598;4675.696079754839;4457.9331310030375;4953.653244272902;5696.715164241813;5713.514351280146;5759.308882934033;3741.2330472253125;3860.6064240170995;3884.864029758945;3887.436321733333;3895.9805200973815;5426.782928682848;5522.692300005961;5957.523398128139;6008.279006519202;6020.789272375489;3902.2585708715255;3907.0623050467684;3911.4523966644692;3919.118198405393;3950.585188555218;3443.1220038889924;3782.583915769263;3868.3810590305416;3966.603339666068;3987.222491614107;3695.6489133532273;3918.3534716771983;4637.976810115928;4642.721436713808;4646.581807637329;5388.622796404293;5702.6293290935955;5758.798442054508;5789.623674461147;5792.594518383673;1204.7952047952049;1225.07506832341;1243.12980913361;1276.7083085860902;1294.1393973007844;743.8140464883779;818.4925346285341;867.7873920889423;868.2966796894535;873.3057219510505;4438.733675979452;4639.118567472169;5178.352705911761;5182.222666600041;5221.13851214553;4423.955760442419;5159.406668233126;5182.497075848038;5282.445343238982;5644.576656750678;4648.581627653527;4857.368542089505;5142.794288228504;5190.766415511235;5197.090509160882;2541.4917016596755;2816.9295667646165;2916.9144061995776;2921.7516511096796;2948.6878339138875;5181.409295352324;5299.019681358961;5813.970930145322;5817.272840894888;5875.649740103907;5219.693752654076;5367.490088441592;5497.285352904097;5635.915461268084;5761.711914404263;4997.7755449915;5267.78928842842;5785.595008349375;5827.1353166986155;5832.854178645653;5520.475554822286;5556.777728890799;5569.632906014846;5636.351819540805;5666.744996475086;4398.626116780109;4656.993731738463;5060.84817455477;5197.870053248548;5495.313085864267;4761.761971873214;5059.898802024012;5444.373897001896;5804.21643078179;5882.7058647066615;3348.2968576599187;3366.562346894888;3713.2759111972905;3726.254749050255;3746.463949780577;5437.537809286255;5600.35595906476;5922;5945.732442040205;5970;5475.370332411823;5602.831915042555;5670.971645141748;5735;5815.127730840239;5763.020286551213;5788.032069096527;5808.796692115756;5812.680302583399;5818.359980402068;5130.820421285237;5317.627766056339;5534.4742249486235;5613.537237895965;5652.85867853307;5055.418626857811;5802.071668533014;5820.420441428576;5824.796132135355;5830;5282.524572788468;5681.602287839812;5718.914216286842;5782.826515204551;5793.884122317614 10:27:32 INFO - PROCESS | 1645 | |5;yui.html;678.5352033856807;678.5894533807043;754.837709892373;764.2472164917559;775.3951917504347;13955;14830.258487075656;14854.588814062647;14855.7028859423;14878.47925322614;12494.81257781134;12506.874931250708;12529.624111276677;12692.11155219135;12826.551070712527;652.455199908075;670.0953712488151;797.7367468735332;810.991890081099;822.0874828939872;811.5455345006785;828.8963879515061;831.7005877883956;835.6072645856437;837.7696133563257;880.8458519759049;881.2465342132481;882.4484697064335;883.1874675298709;885.5041176940933;828.9875651865227;865.645085514939;881.5415983688478;883.7967267528504;884.6549845560204;615.8983767678372;654.1300070905684;660.5739298152664;660.7125900233414;661.1801366305795;11218.214724969255;13695.86304136956;13838.30808459573;13846.723065538734;14121.364538595788;13523.661908452268;13728.519501817389;13886.93056534711;14008.649783755385;14127.219671543437;9475.336726429152;11236.831447528293;11329.263597866113;11498.597549085742;11568.421578921021;3647.6534729200685;3680.9079773005888;3681.1717363593243;3727.1800203955086;3730.309892669865;90235;90770;91147;91306.54346728224;94708.57937130949;10563.47182640865;10753.677389678322;10796.78406431867;10869.728256793644;11000.339979601249;19381.030948452804;19971;21152.78847211539;21219.575608487743;21526.56946861054;7483.32650061497;7560.8487830244185;7566.848663026709;7686.654100565488;7728.690852365955;3875.5736868944396;3966.127451960564;3969.0672691917375;3983.3427484464737;3994.2410941920944;3289.687479689426;3382.6279109297957;3395.3548825723033;3433.0215888471666;3436.8281585920604;489.16597201770895;551.8934536254784;576.953843692512;641.3970867384644;656.3731636287334;570.6433479075578;575.5395683453304;599.0923750517969;621.7202258983475;678.7488629207224;8402.285805706584;8952.641894324153;9067.909320906838;9210.585523651453;9364.765880852898;562.9155626656035;620.5997131850022;631.9494440444753;649.0588646462554;670.1489108831756;3471.3511082235736;3565.3760591896835;4258.829646814154;4414.735115893057;4431.379606855043;69934.65032674804;92835;98106;102434;105690;92091.5395423032;94981.62545936268;96429;97597;99441;83380.58309708534;84135;84833.57583212045;85285.14714852897;88434;8372.41393102477;8480.61837217339;8561.82876342482;8679.218870301704;8804.03155652865;36224.818875905454;54086.72956635192;55321;55381.55407422115;57647.847043058064;74197;77508;77560.61219693866;80303.79544306723;82068;10710;11150.275232109887;11173.776524469302;11214.719632008939;11795.882041179479;11529;11659.18385712992;11824.940875295568;12043.337616431181;12547.24716517012;11661.825072623747;11755.647330580096;11901.345426001653;11950.46222919988;12402.627921162379;9864.85202721974;11329.830052549383;11676.88323116758;12025.45885435175;12115.636530904087;10109.898901010896;10156.187504999434;10259.692209233735;10713.876988450975;10714.035736783728;8583.570821459027;8851.291896648125;8919.241864441336;9724.270679699192;10097.990200979842;9318.394304370195;10600.893991060299;10870.347779133277;11052.944735276273;11092.445377731243 10:27:32 INFO - PROCESS | 1645 | __end_tp_report 10:27:32 INFO - PROCESS | 1645 | __start_cc_report 10:27:32 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,365 10:27:32 INFO - PROCESS | 1645 | __end_cc_report 10:27:32 INFO - PROCESS | 1645 | __startTimestamp1481221652346__endTimestamp 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | ------- Summary: start ------- 10:27:32 INFO - PROCESS | 1645 | Number of tests: 6 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5656.23 Median:5887.82 stddev:663.97 (11.3%) stddev-sans-first:641.51 10:27:32 INFO - PROCESS | 1645 | Values: 3378.6 3384.7 3405.6 3415.7 3419.4 4547.3 4602.0 5520.1 5634.4 5732.9 5667.4 5688.2 5714.3 5754.5 5773.6 4581.4 4789.9 5227.5 5248.4 5267.5 5211.9 5216.1 5256.9 5280.0 5343.7 5116.1 5146.0 5260.2 5268.3 5269.5 5145.8 5178.7 5210.3 5210.8 5229.3 5130.6 5138.1 5199.1 5218.8 5260.7 5710.4 5710.7 5713.9 5715.2 5759.0 6040.2 6117.4 6154.6 6192.8 6193.3 6129.1 6132.8 6200.4 6210.2 6219.6 5786.7 5790.9 5821.1 5856.4 5860.9 6210.6 6249.1 6275.8 6297.1 6321.5 6050.3 6062.6 6079.6 6188.9 6189.2 6142.8 6212.4 6215.3 6215.7 6218.3 5678.9 5806.6 6110.9 6183.3 6184.8 6037.8 6110.4 6127.7 6147.4 6206.5 4181.6 4886.6 4888.6 4909.4 4970.4 3718.9 4375.5 4381.2 4402.0 4403.3 5787.9 5884.3 5903.3 5904.3 5929.2 6058.6 6118.6 6121.6 6122.6 6150.6 5920.3 5935.3 5945.2 5959.5 5971.6 5221.5 5288.7 5304.1 5323.9 5411.0 5377.8 6168.6 6226.1 6299.1 6369.5 5122.6 6141.7 6145.1 6166.0 6223.0 6176.8 6289.7 6312.4 6322.4 6338.1 5425.9 6152.1 6178.1 6178.7 6212.7 5543.6 5743.4 6164.0 6173.0 6219.9 5727.7 6027.8 6064.4 6081.2 6152.9 6122.6 6123.9 6144.6 6145.4 6152.3 4775.3 5744.4 5839.1 5991.5 5996.9 5934.4 5981.9 6007.3 6026.6 6044.9 4738.4 4871.2 5878.8 5883.2 5887.8 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:73131.93 Median:38869.51 stddev:166780.16 (429.1%) stddev-sans-first:167158.80 10:27:32 INFO - PROCESS | 1645 | Values: 473.3 479.3 480.8 509.1 533.1 35340.8 38826.6 38855.6 38884.4 40473.2 39675.0 40164.0 40236.0 40310.6 40360.2 9174.4 9343.0 9355.6 9356.6 9386.2 9306.0 9323.9 9394.7 9402.9 9456.5 9350.4 9442.2 9459.5 9477.8 9489.3 9377.2 9442.0 9448.7 9454.7 9722.8 9288.6 9367.9 9391.3 9410.9 9417.0 38451.4 38837.8 38863.2 38875.8 39003.0 3212.8 3282.3 3450.5 3466.1 3685.4 28416.4 28446.3 29549.7 29632.0 30562.5 3094.2 3187.4 3194.0 3257.0 3288.7 498324.0 504287.0 504464.0 505103.0 505968.0 56601.7 56894.0 56984.0 57065.1 57199.7 57521.0 57990.0 58107.0 58279.4 58351.8 15257.9 15267.6 15496.8 15530.8 15549.4 12054.0 12128.6 12152.5 12152.9 12163.7 14715.8 14835.0 14924.9 14938.5 15045.9 2590.9 6477.8 6736.0 6808.6 6832.6 782.3 794.4 915.7 1052.2 1106.6 25044.5 25322.6 27902.9 29669.7 30072.7 881.6 982.1 1015.9 1103.0 1121.2 12474.6 13480.6 14534.3 15352.0 15407.2 687188.6 692437.0 695526.0 696433.0 698452.0 55172.4 55890.7 55902.0 55963.2 56321.4 1360.8 1372.2 1383.2 1391.7 1394.1 28708.9 29378.3 29383.6 29439.7 29889.3 42150.4 47960.5 47996.8 48015.8 48214.8 646647.0 650189.0 651917.0 652658.0 654176.0 25718.6 25975.9 26026.9 26071.9 26089.7 44393.6 44452.3 44791.6 47368.3 48265.5 37436.6 37535.8 37720.1 37996.2 39148.0 36263.9 36397.3 37126.3 37248.8 37488.6 36697.7 36773.0 36861.6 37238.3 37244.0 33054.7 33897.7 34171.7 34184.8 34261.1 22818.8 25156.5 25403.2 25457.7 25883.6 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:34646.23 Median:2547.94 stddev:99721.94 (3913.8%) stddev-sans-first:99968.34 10:27:32 INFO - PROCESS | 1645 | Values: 302.7 366.1 378.8 382.1 395.6 17945.9 18801.4 19014.7 19498.0 19764.3 18918.8 19197.6 19349.3 19357.1 19410.9 5833.2 6109.5 6145.8 6153.8 6165.7 5441.5 5710.7 5778.2 5829.2 5846.8 5054.0 5170.0 5490.3 5792.7 5802.5 6540.5 6630.8 6636.6 6642.7 6646.5 3855.4 4050.6 4087.8 5864.8 5902.2 12689.0 12897.5 12938.9 12952.0 20552.8 2148.2 2163.6 2249.2 2385.7 2710.2 8577.4 9541.0 9602.5 9648.9 9700.8 1760.5 1770.6 1799.8 1808.6 1866.8 120972.4 126877.4 130855.3 132468.0 133003.3 10312.9 11553.5 11802.3 11857.9 11859.6 14273.2 14425.4 14440.4 14451.8 14471.7 8247.7 8397.5 8424.0 8437.2 8520.4 6884.0 8278.1 8349.1 8481.2 8506.4 3776.3 4365.5 4524.3 4526.0 4546.2 1777.8 1830.8 1861.9 1933.8 1963.4 839.9 870.9 884.9 942.3 955.5 19444.3 20489.8 20668.8 20764.5 20931.7 906.8 929.2 937.0 937.2 955.8 7715.8 10387.8 10971.7 10985.3 10989.5 575560.0 581833.0 582687.0 610778.0 622808.0 123834.4 125976.7 129957.5 131734.3 134396.3 979.2 1010.3 1042.9 1042.9 1046.0 18045.4 18197.7 18447.2 18860.1 19074.0 53758.2 55031.9 55182.4 55700.7 55779.2 62835.0 70767.6 77484.0 78651.0 80256.0 6941.9 7182.8 7386.6 7882.2 8070.8 12122.6 12741.0 12923.9 12936.3 13075.4 10783.6 10808.5 10842.8 11090.5 11127.4 10763.7 10931.7 10950.3 10984.7 11034.8 10192.4 10297.9 10335.9 10492.2 10648.0 6985.9 7169.2 7221.5 7322.4 7428.1 8575.9 10013.7 10045.1 10085.8 10373.5 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5400.02 Median:5138.42 stddev:2946.35 (57.3%) stddev-sans-first:2939.06 10:27:32 INFO - PROCESS | 1645 | Values: 1371.5 1465.3 1633.0 1736.2 1778.1 7151.7 7419.5 8005.8 8402.1 8403.6 7147.6 8091.8 8122.0 8197.8 8198.5 2265.0 2288.1 2293.0 2293.3 2295.0 2294.8 2328.0 2349.7 2352.8 2360.0 2293.7 2299.3 2316.5 2320.6 2323.6 2269.6 2276.2 2291.7 2310.8 2316.6 2294.4 2315.9 2316.2 2318.5 2331.8 8229.3 8238.8 8282.5 8342.2 8370.2 5026.3 5172.3 5182.0 5186.7 5188.8 3241.6 3445.5 3487.8 3568.0 3574.6 1020.1 1026.2 1089.7 1097.4 1111.6 10692.4 10786.3 10795.8 10879.9 10891.7 3720.4 3882.6 3972.7 4632.0 4709.1 9307.1 9369.0 9370.4 9380.9 9409.0 5126.5 5130.8 5131.9 5144.9 5167.0 3720.0 4195.2 4623.7 4667.5 4704.5 3812.1 3834.8 3868.6 3898.5 3930.9 1084.9 1097.2 1257.0 1263.7 1286.0 826.7 855.3 860.9 866.1 913.2 5536.8 5610.7 5808.5 5888.2 5906.5 888.5 914.8 930.9 939.6 985.3 3655.3 3819.2 3874.9 3921.8 3955.8 9741.8 10126.4 10149.6 10150.8 10209.4 9401.0 9648.9 10094.3 10117.7 10176.3 7543.5 7762.7 7777.3 7780.6 7801.5 5725.2 5738.6 5788.1 5829.9 5837.1 9193.5 9216.1 9291.6 9352.4 9431.6 7760.0 9292.7 9299.8 9402.1 9420.7 6541.8 6781.5 6917.6 7053.6 7195.4 7758.0 7841.5 7920.8 7930.0 7943.8 6995.6 7154.6 7213.4 7248.1 7252.9 6968.9 6982.7 7079.6 7125.1 7221.7 6558.1 6703.5 6707.0 6712.8 6729.7 4089.5 4783.0 4792.3 4870.0 4901.5 4792.4 4829.2 4850.9 4994.8 5075.6 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4524.97 Median:5168.88 stddev:1410.24 (27.3%) stddev-sans-first:1378.11 10:27:32 INFO - PROCESS | 1645 | Values: 301.3 303.7 308.2 310.4 316.5 4947.7 5241.4 5461.0 5542.6 5593.2 4724.8 5351.9 5418.9 5434.9 5443.3 4136.5 4148.4 4158.1 4171.6 4190.2 3698.1 3854.9 4157.9 4158.9 4164.6 3396.9 3716.8 4012.8 4023.7 4043.9 3852.7 4081.6 4102.0 4112.8 4112.8 3017.2 3046.7 3217.4 3468.7 3553.2 4869.0 5032.2 5277.3 5339.9 5340.7 4612.8 4614.0 4615.6 4667.2 4675.7 4457.9 4953.7 5696.7 5713.5 5759.3 3741.2 3860.6 3884.9 3887.4 3896.0 5426.8 5522.7 5957.5 6008.3 6020.8 3902.3 3907.1 3911.5 3919.1 3950.6 3443.1 3782.6 3868.4 3966.6 3987.2 3695.6 3918.4 4638.0 4642.7 4646.6 5388.6 5702.6 5758.8 5789.6 5792.6 1204.8 1225.1 1243.1 1276.7 1294.1 743.8 818.5 867.8 868.3 873.3 4438.7 4639.1 5178.4 5182.2 5221.1 4424.0 5159.4 5182.5 5282.4 5644.6 4648.6 4857.4 5142.8 5190.8 5197.1 2541.5 2816.9 2916.9 2921.8 2948.7 5181.4 5299.0 5814.0 5817.3 5875.6 5219.7 5367.5 5497.3 5635.9 5761.7 4997.8 5267.8 5785.6 5827.1 5832.9 5520.5 5556.8 5569.6 5636.4 5666.7 4398.6 4657.0 5060.8 5197.9 5495.3 4761.8 5059.9 5444.4 5804.2 5882.7 3348.3 3366.6 3713.3 3726.3 3746.5 5437.5 5600.4 5922.0 5945.7 5970.0 5475.4 5602.8 5671.0 5735.0 5815.1 5763.0 5788.0 5808.8 5812.7 5818.4 5130.8 5317.6 5534.5 5613.5 5652.9 5055.4 5802.1 5820.4 5824.8 5830.0 5282.5 5681.6 5718.9 5782.8 5793.9 10:27:32 INFO - PROCESS | 1645 | 10:27:32 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:19923.06 Median:27972.23 stddev:29421.86 (105.2%) stddev-sans-first:29468.91 10:27:32 INFO - PROCESS | 1645 | Values: 678.5 678.6 754.8 764.2 775.4 13955.0 14830.3 14854.6 14855.7 14878.5 12494.8 12506.9 12529.6 12692.1 12826.6 652.5 670.1 797.7 811.0 822.1 811.5 828.9 831.7 835.6 837.8 880.8 881.2 882.4 883.2 885.5 829.0 865.6 881.5 883.8 884.7 615.9 654.1 660.6 660.7 661.2 11218.2 13695.9 13838.3 13846.7 14121.4 13523.7 13728.5 13886.9 14008.6 14127.2 9475.3 11236.8 11329.3 11498.6 11568.4 3647.7 3680.9 3681.2 3727.2 3730.3 90235.0 90770.0 91147.0 91306.5 94708.6 10563.5 10753.7 10796.8 10869.7 11000.3 19381.0 19971.0 21152.8 21219.6 21526.6 7483.3 7560.8 7566.8 7686.7 7728.7 3875.6 3966.1 3969.1 3983.3 3994.2 3289.7 3382.6 3395.4 3433.0 3436.8 489.2 551.9 577.0 641.4 656.4 570.6 575.5 599.1 621.7 678.7 8402.3 8952.6 9067.9 9210.6 9364.8 562.9 620.6 631.9 649.1 670.1 3471.4 3565.4 4258.8 4414.7 4431.4 69934.7 92835.0 98106.0 102434.0 105690.0 92091.5 94981.6 96429.0 97597.0 99441.0 83380.6 84135.0 84833.6 85285.1 88434.0 8372.4 8480.6 8561.8 8679.2 8804.0 36224.8 54086.7 55321.0 55381.6 57647.8 74197.0 77508.0 77560.6 80303.8 82068.0 10710.0 11150.3 11173.8 11214.7 11795.9 11529.0 11659.2 11824.9 12043.3 12547.2 11661.8 11755.6 11901.3 11950.5 12402.6 9864.9 11329.8 11676.9 12025.5 12115.6 10109.9 10156.2 10259.7 10713.9 10714.0 8583.6 8851.3 8919.2 9724.3 10098.0 9318.4 10600.9 10870.3 11052.9 11092.4 10:27:32 INFO - PROCESS | 1645 | -------- Summary: end -------- 10:27:32 INFO - PROCESS | 1645 | 10:27:33 INFO - TEST-INFO | 1645: exit 0 10:27:33 INFO - TEST-OK | dromaeo_css | took 1117037ms 10:27:33 INFO - TEST-START | kraken 10:27:33 INFO - operating with platform_type : mac_ 10:27:33 INFO - Initialising browser for kraken test... 10:27:33 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpeYpQRD/profile http://localhost:49248/getInfo.html) 10:27:36 INFO - PROCESS | 1653 | 2016-12-08 10:27:36.075 plugin-container[1654:11389] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:27:36 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:36 INFO - PROCESS | 1653 | 2016-12-08 10:27:36.078 plugin-container[1654:11389] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:27:36 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:36 INFO - PROCESS | 1653 | 2016-12-08 10:27:36.078 plugin-container[1654:11389] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:36 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 10:27:36 INFO - PROCESS | 1653 | colorDepth:24 10:27:36 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 10:27:36 INFO - PROCESS | 1653 | __metrics 10:27:36 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:27:37 INFO - TEST-INFO | 1653: exit 0 10:27:37 INFO - Browser initialized. 10:27:37 INFO - Running cycle 1/1 for kraken test... 10:27:37 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpeYpQRD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:39 INFO - PROCESS | 1655 | 2016-12-08 10:27:39.791 plugin-container[1656:11512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 10:27:39 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:39 INFO - PROCESS | 1655 | 2016-12-08 10:27:39.792 plugin-container[1656:11512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 10:27:39 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:39 INFO - PROCESS | 1655 | 2016-12-08 10:27:39.792 plugin-container[1656:11512] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:49 INFO - PROCESS | 1655 | RSS: Main: 229838848 10:27:49 INFO - PROCESS | 1655 | 10:27:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:53 INFO - PROCESS | 1655 | RSS: Main: 241602560 10:27:53 INFO - PROCESS | 1655 | 10:27:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 10:27:56 INFO - PROCESS | 1655 | RSS: Main: 249212928 10:27:56 INFO - PROCESS | 1655 | 10:27:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 10:28:00 INFO - PROCESS | 1655 | RSS: Main: 252846080 10:28:00 INFO - PROCESS | 1655 | 10:28:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 10:28:03 INFO - PROCESS | 1655 | RSS: Main: 253292544 10:28:03 INFO - PROCESS | 1655 | 10:28:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:05 INFO - PROCESS | 1655 | RSS: Main: 253329408 10:28:05 INFO - PROCESS | 1655 | 10:28:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:09 INFO - PROCESS | 1655 | RSS: Main: 258740224 10:28:09 INFO - PROCESS | 1655 | 10:28:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:12 INFO - PROCESS | 1655 | RSS: Main: 258314240 10:28:12 INFO - PROCESS | 1655 | 10:28:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 10:28:16 INFO - PROCESS | 1655 | RSS: Main: 258732032 10:28:16 INFO - PROCESS | 1655 | 10:28:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:18 INFO - PROCESS | 1655 | RSS: Main: 257327104 10:28:18 INFO - PROCESS | 1655 | 10:28:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:21 INFO - PROCESS | 1655 | RSS: Main: 257470464 10:28:21 INFO - PROCESS | 1655 | 10:28:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:24 INFO - PROCESS | 1655 | RSS: Main: 257257472 10:28:24 INFO - PROCESS | 1655 | 10:28:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:27 INFO - PROCESS | 1655 | RSS: Main: 257380352 10:28:27 INFO - PROCESS | 1655 | 10:28:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:31 INFO - PROCESS | 1655 | RSS: Main: 257560576 10:28:31 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 10:28:33 INFO - PROCESS | 1655 | RSS: Main: 259096576 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | __start_tp_report 10:28:33 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 10:28:33 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 10:28:33 INFO - PROCESS | 1655 | |i|pagename|runs| 10:28:33 INFO - PROCESS | 1655 | |0;ai-astar;115;120;125;168;120;119;118;122;119;122 10:28:33 INFO - PROCESS | 1655 | |1;audio-beat-detection;154;120;114;149;122;132;139;112;182;149 10:28:33 INFO - PROCESS | 1655 | |2;audio-dft;187;233;180;271;274;201;195;194;198;196 10:28:33 INFO - PROCESS | 1655 | |3;audio-fft;86;70;59;84;63;65;84;87;106;59 10:28:33 INFO - PROCESS | 1655 | |4;audio-oscillator;79;64;109;104;92;71;88;71;71;89 10:28:33 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;87;85;89;85;88;97;87;86;88;85 10:28:33 INFO - PROCESS | 1655 | |6;imaging-darkroom;123;95;94;105;95;94;94;113;127;123 10:28:33 INFO - PROCESS | 1655 | |7;imaging-desaturate;87;92;98;135;119;90;90;90;129;139 10:28:33 INFO - PROCESS | 1655 | |8;json-parse-financial;56;57;55;59;59;60;60;57;60;61 10:28:33 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;69;69;92;114;80;75;70;66;76;99 10:28:33 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;89;87;86;92;88;89;87;88;86;85 10:28:33 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;154;159;149;149;154;153;142;165;225;181 10:28:33 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;186;169;169;169;170;168;168;218;234;174 10:28:33 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;71;68;70;71;71;69;84;77;66;80 10:28:33 INFO - PROCESS | 1655 | __end_tp_report 10:28:33 INFO - PROCESS | 1655 | __start_cc_report 10:28:33 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,963 10:28:33 INFO - PROCESS | 1655 | __end_cc_report 10:28:33 INFO - PROCESS | 1655 | __startTimestamp1481221713604__endTimestamp 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | ------- Summary: start ------- 10:28:33 INFO - PROCESS | 1655 | Number of tests: 14 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:124.80 Median:121.00 stddev:15.41 (12.7%) stddev-sans-first:15.93 10:28:33 INFO - PROCESS | 1655 | Values: 115.0 120.0 125.0 168.0 120.0 119.0 118.0 122.0 119.0 122.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:144.00 stddev:21.85 (15.2%) stddev-sans-first:22.33 10:28:33 INFO - PROCESS | 1655 | Values: 154.0 120.0 114.0 149.0 122.0 132.0 139.0 112.0 182.0 149.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:212.90 Median:199.50 stddev:34.31 (17.2%) stddev-sans-first:35.08 10:28:33 INFO - PROCESS | 1655 | Values: 187.0 233.0 180.0 271.0 274.0 201.0 195.0 194.0 198.0 196.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:76.30 Median:77.00 stddev:15.46 (20.1%) stddev-sans-first:16.00 10:28:33 INFO - PROCESS | 1655 | Values: 86.0 70.0 59.0 84.0 63.0 65.0 84.0 87.0 106.0 59.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:75.00 stddev:15.13 (20.2%) stddev-sans-first:15.95 10:28:33 INFO - PROCESS | 1655 | Values: 79.0 64.0 109.0 104.0 92.0 71.0 88.0 71.0 71.0 89.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:87.50 stddev:3.56 (4.1%) stddev-sans-first:3.77 10:28:33 INFO - PROCESS | 1655 | Values: 87.0 85.0 89.0 85.0 88.0 97.0 87.0 86.0 88.0 85.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:94.00 stddev:13.91 (14.8%) stddev-sans-first:13.38 10:28:33 INFO - PROCESS | 1655 | Values: 123.0 95.0 94.0 105.0 95.0 94.0 94.0 113.0 127.0 123.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:106.90 Median:90.00 stddev:21.11 (23.5%) stddev-sans-first:21.12 10:28:33 INFO - PROCESS | 1655 | Values: 87.0 92.0 98.0 135.0 119.0 90.0 90.0 90.0 129.0 139.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.50 stddev:2.01 (3.4%) stddev-sans-first:1.94 10:28:33 INFO - PROCESS | 1655 | Values: 56.0 57.0 55.0 59.0 59.0 60.0 60.0 57.0 60.0 61.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:75.50 stddev:15.74 (20.8%) stddev-sans-first:16.09 10:28:33 INFO - PROCESS | 1655 | Values: 69.0 69.0 92.0 114.0 80.0 75.0 70.0 66.0 76.0 99.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.00 stddev:2.00 (2.3%) stddev-sans-first:2.07 10:28:33 INFO - PROCESS | 1655 | Values: 89.0 87.0 86.0 92.0 88.0 89.0 87.0 88.0 86.0 85.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:163.10 Median:156.50 stddev:24.23 (15.5%) stddev-sans-first:25.47 10:28:33 INFO - PROCESS | 1655 | Values: 154.0 159.0 149.0 149.0 154.0 153.0 142.0 165.0 225.0 181.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:172.00 stddev:23.85 (13.9%) stddev-sans-first:25.27 10:28:33 INFO - PROCESS | 1655 | Values: 186.0 169.0 169.0 169.0 170.0 168.0 168.0 218.0 234.0 174.0 10:28:33 INFO - PROCESS | 1655 | 10:28:33 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:71.00 stddev:5.74 (8.1%) stddev-sans-first:6.05 10:28:33 INFO - PROCESS | 1655 | Values: 71.0 68.0 70.0 71.0 71.0 69.0 84.0 77.0 66.0 80.0 10:28:33 INFO - PROCESS | 1655 | -------- Summary: end -------- 10:28:33 INFO - PROCESS | 1655 | 10:28:34 INFO - TEST-INFO | 1655: exit 0 10:28:34 INFO - TEST-OK | kraken | took 61546ms 10:28:34 INFO - SUITE-END | took 1178s 10:28:34 INFO - Completed test suite (00:19:38) 10:28:34 INFO - javascript benchmark 10:28:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7063.271262561827, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3378.645242249562, 3384.6615338466154, 3405.6083550391713, 3415.7267418606516, 3419.4186988212, 4547.340635607835, 4601.95398046019, 5520.14437762147, 5634.36305146602, 5732.942670573293, 5667.376588575254, 5688.175214593882, 5714.342850572186, 5754.482096611304, 5773.566982476321, 4581.358609794632, 4789.9462118333995, 5227.47725227478, 5248.422673505911, 5267.473252674721, 5211.921821172686, 5216.139337009389, 5256.894862102756, 5280.049591073605, 5343.679379237239, 5116.053530096944, 5145.974270128644, 5260.158374660055, 5268.288781014571, 5269.473052694719, 5145.845624631248, 5178.689278643255, 5210.270562121306, 5210.76551555181, 5229.320188375525, 5130.563902068291, 5138.126518491866, 5199.064168449678, 5218.791248350061, 5260.684358938476, 5710.371859095538, 5710.657360558338, 5713.914291285634, 5715.228444160027, 5758.971205143989, 6040.214772079646, 6117.388261173892, 6154.569180157391, 6192.845178870519, 6193.318734939153, 6129.114290130706, 6132.845047373404, 6200.379962003809, 6210.161628180228, 6219.564630475868, 5786.71066446676, 5790.942090579125, 5821.126830975388, 5856.443637854397, 5860.853478663067, 6210.5652604317265, 6249.062640603855, 6275.811725648238, 6297.086922396318, 6321.494280457552, 6050.273967123885, 6062.605930614496, 6079.635221886701, 6188.947878860605, 6189.164462797555, 6142.815715528542, 6212.409821066992, 6215.34738852423, 6215.720292586844, 6218.284897236786, 5678.943210567924, 5806.564507661942, 6110.877782444326, 6183.258009038944, 6184.783532576338, 6037.818865434044, 6110.388961103854, 6127.6936153193055, 6147.354527774609, 6206.534509911684, 4181.644560212416, 4886.633502487328, 4888.560029597354, 4909.361782968192, 4970.428400733962, 3718.925621487609, 4375.47494300686, 4381.233284175257, 4401.9875428651585, 4403.273459879084, 5787.88424231513, 5884.264466941632, 5903.291605007426, 5904.261967254093, 5929.199558059693, 6058.606190597597, 6118.6191791732535, 6121.632702037892, 6122.632642041492, 6150.630962142286, 5920.259967504062, 5935.287765468085, 5945.197398351167, 5959.523238140939, 5971.611845230046, 5221.530062294336, 5288.65623734456, 5304.124819404832, 5323.893522129536, 5411.0, 5377.758000889891, 6168.629882207082, 6226.066090086523, 6299.118123462627, 6369.45859601939, 5122.641415101056, 6141.692915354304, 6145.064304743992, 6166.013437850102, 6222.968885155546, 6176.752929882754, 6289.716962736779, 6312.43188113072, 6322.36776322364, 6338.112664227104, 5425.945740542544, 6152.077188421773, 6178.073289006685, 6178.691065446799, 6212.658303793335, 5543.61194716366, 5743.4256574342235, 6164.04225632834, 6173.0, 6219.906701399573, 5727.713614319351, 6027.849303767441, 6064.3935606439, 6081.209442772411, 6152.938470615416, 6122.571420000557, 6123.877522449615, 6144.56988010835, 6145.4161854623735, 6152.292486364126, 4775.283707443911, 5744.396838331915, 5839.124131380157, 5991.490723288569, 5996.8800623988145, 5934.376890426615, 5981.910271345846, 6007.30915944672, 6026.578139530367, 6044.939550604614, 4738.431388233434, 4871.244957031666, 5878.764849405976, 5883.176355310346, 5887.8233652990475], "value": 5615.575330735522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.31605829576256, 479.2523663085587, 480.7572425280648, 509.08619028843225, 533.1496263459783, 35340.823295883514, 38826.61173388265, 38855.61144388555, 38884.416733749014, 40473.19053618933, 39675.0, 40163.99590010251, 40236.0, 40310.59689403105, 40360.19279614406, 9174.40366376185, 9343.0, 9355.6434317024, 9356.578953947088, 9386.155246027856, 9306.0, 9323.860142097874, 9394.671186508474, 9402.858957115648, 9456.479893605849, 9350.39222450542, 9442.19741321985, 9459.479728614924, 9477.763055923588, 9489.335746497747, 9377.156055954963, 9441.952790236073, 9448.716538503855, 9454.669086582006, 9722.756931076708, 9288.582013809328, 9367.906320936772, 9391.295652826066, 9410.90589094114, 9417.011213822587, 38451.42322865159, 38837.80581097076, 38863.222735545416, 38875.805620971994, 39003.0, 3212.791168574035, 3282.343531293751, 3450.5341778859784, 3466.0814884055744, 3685.4287585424304, 28416.431671366456, 28446.28884277889, 29549.670264838132, 29631.962881299052, 30562.54156187659, 3094.164575564585, 3187.42626327261, 3194.0417874637515, 3257.0066129830393, 3288.704016638514, 498323.9999999964, 504287.0, 504464.0, 505103.0, 505968.0, 56601.71699141478, 56894.0, 56984.0, 57065.14402283886, 57199.714001429726, 57521.0, 57990.0, 58107.0, 58279.41720582825, 58351.832963340494, 15257.923710381378, 15267.618309542127, 15496.845031549765, 15530.767038494432, 15549.378024878879, 12054.0, 12128.63614091561, 12152.453139608739, 12152.878471215352, 12163.695907602203, 14715.779263311058, 14835.03572267799, 14924.850751492564, 14938.477153299582, 15045.924770376078, 2590.9481810363686, 6477.838054048687, 6735.966320168466, 6808.557443766139, 6832.555883867532, 782.2646712090617, 794.4478587381715, 915.6905624956377, 1052.21609900623, 1106.590561492253, 25044.499110018063, 25322.620160697603, 27902.86048569744, 29669.703302966693, 30072.69927300699, 881.6341218394294, 982.1308142293979, 1015.8780946286345, 1103.0128035408266, 1121.2187419309962, 12474.625761227178, 13480.595582132551, 14534.255889293352, 15352.0, 15407.229638518029, 687188.5640571865, 692437.0, 695526.0, 696433.0, 698452.0, 55172.448275517534, 55890.72054639701, 55902.0, 55963.16055259174, 56321.43678563244, 1360.8366995960548, 1372.1698372484502, 1383.1700979412271, 1391.7146984868077, 1394.0799072612028, 28708.85645571842, 29378.265543361587, 29383.55924661089, 29439.705602943697, 29889.252768680955, 42150.36774448447, 47960.5203947956, 47996.760016199696, 48015.75992120017, 48214.75892620515, 646647.0, 650189.0, 651917.0, 652658.0, 654176.0, 25718.61422078633, 25975.870120649277, 26026.86986565055, 26071.869640651676, 26089.73910260873, 44393.55606443894, 44452.33321500245, 44791.55208447874, 47368.289475657206, 48265.517344826105, 37436.625633743315, 37535.81232093822, 37720.05699857525, 37996.24007519779, 39148.02129946774, 36263.912082637566, 36397.272054558234, 37126.25747484981, 37248.81375593105, 37488.62511374961, 36697.71557995457, 36773.0, 36861.631383686894, 37238.25523489569, 37244.0, 33054.669453305156, 33897.661023390436, 34171.65828341685, 34184.82907585446, 34261.143471413416, 22818.771812281666, 25156.496870062863, 25403.237902862944, 25457.745422545537, 25883.611745824204], "value": 19268.315851772382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.74720608292074, 366.12496134239166, 378.80870160568907, 382.06394333881997, 395.57278139609224, 17945.910270448647, 18801.435956921297, 19014.71477927832, 19498.0, 19764.30824921128, 18918.810811891875, 19197.616047679072, 19349.322773702923, 19357.128929198185, 19410.902945485253, 5833.212516310286, 6109.480694141003, 6145.754169833202, 6153.753849846001, 6165.722542485577, 5441.537469315113, 5710.685912274823, 5778.248827652399, 5829.154772557977, 5846.795362162326, 5053.989202159564, 5169.974150129244, 5490.3411590609185, 5792.739326730307, 5802.53579713624, 6540.542162048659, 6630.834229144261, 6636.634985075843, 6642.734290628369, 6646.501512386566, 3855.402412626019, 4050.6354428101613, 4087.7751723655188, 5864.76540938362, 5902.203202567642, 12689.0, 12897.484100635964, 12938.935305323508, 12952.0, 20552.76683399001, 2148.1514801653416, 2163.642998905179, 2249.1678079110834, 2385.689860318165, 2710.1869439168368, 8577.442466239674, 9540.952295238549, 9602.471864047475, 9648.855267170999, 9700.805983880353, 1760.4630587670756, 1770.5839127804957, 1799.8290162434548, 1808.5569035586234, 1866.7946525882141, 120972.39513802463, 126877.36561317135, 130855.34572327077, 132468.0, 133003.33498332542, 10312.948435257777, 11553.480093395818, 11802.291862488279, 11857.88142118585, 11859.644210673521, 14273.214973176575, 14425.350859211361, 14440.350184241734, 14451.78322325166, 14471.710565788626, 8247.670093196324, 8397.538135402488, 8424.031236407769, 8437.156284371637, 8520.360972927056, 6883.965580172067, 8278.089410164877, 8349.123342048997, 8481.236688698047, 8506.404551681322, 3776.33914065043, 4365.497967733688, 4524.253498172765, 4525.977370113128, 4546.181687296253, 1777.7644537046629, 1830.8352248297717, 1861.9255229790926, 1933.806619338083, 1963.3717210492505, 839.928606068491, 870.8780770692108, 884.8672699095188, 942.34036174678, 955.5270141279972, 19444.250017498493, 20489.79510204879, 20668.79281950739, 20764.480887977923, 20931.68602470964, 906.8186362727349, 929.177677755178, 937.0488953711988, 937.1659223291276, 955.7897262602216, 7715.768526944201, 10387.84418233727, 10971.725706857393, 10985.340879547253, 10989.505472253768, 575560.0, 581833.0, 582687.0, 610778.0, 622808.0, 123834.38082809528, 125976.74023259833, 129957.46040622338, 131734.34132829466, 134396.29612963498, 979.2215188924964, 1010.3281317923645, 1042.8904964978567, 1042.9478526073665, 1045.968620941373, 18045.368412105512, 18197.727034094234, 18447.24751148639, 18860.05699715036, 19074.0, 53758.19362709641, 55031.89936201333, 55182.448175519334, 55700.72149639226, 55779.16331255116, 62835.0, 70767.64616176886, 77484.0, 78651.0, 80256.0, 6941.895871561829, 7182.820429489305, 7386.630668466448, 7882.172371901097, 8070.757877263692, 12122.636320910387, 12741.0, 12923.870761292643, 12936.288504132363, 13075.411606477921, 10783.568657253936, 10808.513616887416, 10842.837357439486, 11090.500927458123, 11127.443627818415, 10763.730906727395, 10931.672049838518, 10950.34297942126, 10984.670459886216, 11034.786173521066, 10192.388456692623, 10297.897021029994, 10335.896641033794, 10492.213084018576, 10647.988441098083, 6985.917182836669, 7169.247229041084, 7221.494495385273, 7322.3775979042375, 7428.145763237297, 8575.91424085776, 10013.749656258651, 10045.09594136502, 10085.798284034425, 10373.481325933522], "value": 9188.030771380289, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.52682324598, 1465.2820118142113, 1632.9591760205994, 1736.1753167245552, 1778.1464896849511, 7151.749688760894, 7419.480636355457, 8005.839153322765, 8402.075771665119, 8403.579821008949, 7147.642617869112, 8091.757247282591, 8121.959390203041, 8197.79505512361, 8198.549079800623, 2265.048679554591, 2288.061894623205, 2292.988535057322, 2293.3463962770616, 2294.9655755163685, 2294.816414686821, 2327.9883600581975, 2349.659299401586, 2352.811775058, 2360.0205914545527, 2293.747687754354, 2299.3331933739196, 2316.536692661466, 2320.5590937721863, 2323.59337116004, 2269.636858102704, 2276.1805749930013, 2291.747907730148, 2310.838241323108, 2316.5945959457194, 2294.4149241943196, 2315.9305220843403, 2316.1661801751357, 2318.501522172741, 2331.813454923619, 8229.341652667772, 8238.794030149234, 8282.461639993442, 8342.249197572188, 8370.204830541088, 5026.346574945271, 5172.250023746536, 5182.041322355376, 5186.688798672092, 5188.844334669966, 3241.6434192238835, 3445.459344775033, 3487.7907325560295, 3567.9643203567894, 3574.6425357464304, 1020.0564477857952, 1026.2149455666422, 1089.7221208591839, 1097.412884106999, 1111.5831563163813, 10692.411917344543, 10786.298890572089, 10795.83806242907, 10879.945600271947, 10891.67324980244, 3720.3861362874823, 3882.6117388261514, 3972.7219094663674, 4631.9536804631525, 4709.128811169944, 9307.06929307064, 9368.95315523418, 9370.437773733598, 9380.8592871107, 9409.0, 5126.512981266774, 5130.79476820923, 5131.923021154686, 5144.922826157611, 5167.0, 3720.014196237999, 4195.223883581547, 4623.722576645412, 4667.486576476585, 4704.529547045268, 3812.14226798968, 3834.750741201813, 3868.6131386861653, 3898.493195884517, 3930.8820735377985, 1084.9077828384518, 1097.1716354152563, 1257.0, 1263.7093468502112, 1285.9742805143844, 826.6982551368707, 855.3029281135854, 860.8880845490171, 866.1165611076666, 913.2055112052557, 5536.75084621193, 5610.7194640268635, 5808.506276966421, 5888.205092312569, 5906.49794767441, 888.493558671564, 914.7850255190025, 930.9218214639127, 939.5584075484511, 985.2708995343394, 3655.2689462107683, 3819.1788765415567, 3874.9031274217805, 3921.764694118362, 3955.8417663293144, 9741.756456088513, 10126.443045632413, 10149.64476243328, 10150.796984060426, 10209.38743675382, 9401.0, 9648.855267170999, 10094.293399461967, 10117.747056323651, 10176.287659863887, 7543.509671871311, 7762.728304509315, 7777.300042996045, 7780.649870755829, 7801.4929029612895, 5725.16985037159, 5738.598298119258, 5788.0739081746715, 5829.94170058294, 5837.124431335334, 9193.494357810117, 9216.124468175512, 9291.581878815605, 9352.392094513834, 9431.62273509052, 7760.0, 9292.674756383494, 9299.83752030996, 9402.106799854002, 9420.717378478657, 6541.836454088686, 6781.457483401415, 6917.584944903322, 7053.647317634201, 7195.38839198653, 7758.0, 7841.529508229524, 7920.762377128695, 7929.960350198443, 7943.801404964922, 6995.615241161785, 7154.606496642735, 7213.3868621167785, 7248.0939882514685, 7252.948322493315, 6968.860622787414, 6982.682115429459, 7079.610621415872, 7125.1093613298335, 7221.67502462401, 6558.114654521579, 6703.4972377070935, 6706.960421134732, 6712.83217919556, 6729.663516824237, 4089.5092588889524, 4783.0, 4792.257200133985, 4870.00164966174, 4901.509849015212, 4792.3530323407285, 4829.227323628203, 4850.927236091391, 4994.775235114501, 5075.6193285502995], "value": 4385.854693741331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3100000997715, 303.6629341431011, 308.2002204279893, 310.424163177306, 316.53785473209115, 4947.7031378117335, 5241.371035475749, 5461.006732542618, 5542.612017158795, 5593.244911936888, 4724.771559394557, 5351.946480535194, 5418.913718218485, 5434.945650543494, 5443.265159203506, 4136.5036195656485, 4148.3777433385085, 4158.08522125132, 4171.6036976487185, 4190.2248084104385, 3698.149425632106, 3854.8650797222103, 4157.937630935538, 4158.9376159357635, 4164.625183733463, 3396.8811091611797, 3716.8141592920247, 4012.7993600320015, 4023.6982226333, 4043.939340909889, 3852.6725228355485, 4081.55102938678, 4101.958980410188, 4112.794360281974, 4112.794360282004, 3017.200441882903, 3046.7105624965593, 3217.436948533997, 3468.739844511672, 3553.218291975761, 4869.028043642331, 5032.245163225545, 5277.287566178555, 5339.866503337447, 5340.706261155635, 4612.7924243409125, 4613.953860461386, 4615.569173556209, 4667.15991121598, 4675.696079754839, 4457.9331310030375, 4953.653244272902, 5696.715164241813, 5713.514351280146, 5759.308882934033, 3741.2330472253125, 3860.6064240170995, 3884.864029758945, 3887.436321733333, 3895.9805200973815, 5426.782928682848, 5522.692300005961, 5957.523398128139, 6008.279006519202, 6020.789272375489, 3902.2585708715255, 3907.0623050467684, 3911.4523966644692, 3919.118198405393, 3950.585188555218, 3443.1220038889924, 3782.583915769263, 3868.3810590305416, 3966.603339666068, 3987.222491614107, 3695.6489133532273, 3918.3534716771983, 4637.976810115928, 4642.721436713808, 4646.581807637329, 5388.622796404293, 5702.6293290935955, 5758.798442054508, 5789.623674461147, 5792.594518383673, 1204.7952047952049, 1225.07506832341, 1243.12980913361, 1276.7083085860902, 1294.1393973007844, 743.8140464883779, 818.4925346285341, 867.7873920889423, 868.2966796894535, 873.3057219510505, 4438.733675979452, 4639.118567472169, 5178.352705911761, 5182.222666600041, 5221.13851214553, 4423.955760442419, 5159.406668233126, 5182.497075848038, 5282.445343238982, 5644.576656750678, 4648.581627653527, 4857.368542089505, 5142.794288228504, 5190.766415511235, 5197.090509160882, 2541.4917016596755, 2816.9295667646165, 2916.9144061995776, 2921.7516511096796, 2948.6878339138875, 5181.409295352324, 5299.019681358961, 5813.970930145322, 5817.272840894888, 5875.649740103907, 5219.693752654076, 5367.490088441592, 5497.285352904097, 5635.915461268084, 5761.711914404263, 4997.7755449915, 5267.78928842842, 5785.595008349375, 5827.1353166986155, 5832.854178645653, 5520.475554822286, 5556.777728890799, 5569.632906014846, 5636.351819540805, 5666.744996475086, 4398.626116780109, 4656.993731738463, 5060.84817455477, 5197.870053248548, 5495.313085864267, 4761.761971873214, 5059.898802024012, 5444.373897001896, 5804.21643078179, 5882.7058647066615, 3348.2968576599187, 3366.562346894888, 3713.2759111972905, 3726.254749050255, 3746.463949780577, 5437.537809286255, 5600.35595906476, 5922.0, 5945.732442040205, 5970.0, 5475.370332411823, 5602.831915042555, 5670.971645141748, 5735.0, 5815.127730840239, 5763.020286551213, 5788.032069096527, 5808.796692115756, 5812.680302583399, 5818.359980402068, 5130.820421285237, 5317.627766056339, 5534.4742249486235, 5613.537237895965, 5652.85867853307, 5055.418626857811, 5802.071668533014, 5820.420441428576, 5824.796132135355, 5830.0, 5282.524572788468, 5681.602287839812, 5718.914216286842, 5782.826515204551, 5793.884122317614], "value": 4068.142091253805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.5352033856807, 678.5894533807043, 754.837709892373, 764.2472164917559, 775.3951917504347, 13955.0, 14830.258487075656, 14854.588814062647, 14855.7028859423, 14878.47925322614, 12494.81257781134, 12506.874931250708, 12529.624111276677, 12692.11155219135, 12826.551070712527, 652.455199908075, 670.0953712488151, 797.7367468735332, 810.991890081099, 822.0874828939872, 811.5455345006785, 828.8963879515061, 831.7005877883956, 835.6072645856437, 837.7696133563257, 880.8458519759049, 881.2465342132481, 882.4484697064335, 883.1874675298709, 885.5041176940933, 828.9875651865227, 865.645085514939, 881.5415983688478, 883.7967267528504, 884.6549845560204, 615.8983767678372, 654.1300070905684, 660.5739298152664, 660.7125900233414, 661.1801366305795, 11218.214724969255, 13695.86304136956, 13838.30808459573, 13846.723065538734, 14121.364538595788, 13523.661908452268, 13728.519501817389, 13886.93056534711, 14008.649783755385, 14127.219671543437, 9475.336726429152, 11236.831447528293, 11329.263597866113, 11498.597549085742, 11568.421578921021, 3647.6534729200685, 3680.9079773005888, 3681.1717363593243, 3727.1800203955086, 3730.309892669865, 90235.0, 90770.0, 91147.0, 91306.54346728224, 94708.57937130949, 10563.47182640865, 10753.677389678322, 10796.78406431867, 10869.728256793644, 11000.339979601249, 19381.030948452804, 19971.0, 21152.78847211539, 21219.575608487743, 21526.56946861054, 7483.32650061497, 7560.8487830244185, 7566.848663026709, 7686.654100565488, 7728.690852365955, 3875.5736868944396, 3966.127451960564, 3969.0672691917375, 3983.3427484464737, 3994.2410941920944, 3289.687479689426, 3382.6279109297957, 3395.3548825723033, 3433.0215888471666, 3436.8281585920604, 489.16597201770895, 551.8934536254784, 576.953843692512, 641.3970867384644, 656.3731636287334, 570.6433479075578, 575.5395683453304, 599.0923750517969, 621.7202258983475, 678.7488629207224, 8402.285805706584, 8952.641894324153, 9067.909320906838, 9210.585523651453, 9364.765880852898, 562.9155626656035, 620.5997131850022, 631.9494440444753, 649.0588646462554, 670.1489108831756, 3471.3511082235736, 3565.3760591896835, 4258.829646814154, 4414.735115893057, 4431.379606855043, 69934.65032674804, 92835.0, 98106.0, 102434.0, 105690.0, 92091.5395423032, 94981.62545936268, 96429.0, 97597.0, 99441.0, 83380.58309708534, 84135.0, 84833.57583212045, 85285.14714852897, 88434.0, 8372.41393102477, 8480.61837217339, 8561.82876342482, 8679.218870301704, 8804.03155652865, 36224.818875905454, 54086.72956635192, 55321.0, 55381.55407422115, 57647.847043058064, 74197.0, 77508.0, 77560.61219693866, 80303.79544306723, 82068.0, 10710.0, 11150.275232109887, 11173.776524469302, 11214.719632008939, 11795.882041179479, 11529.0, 11659.18385712992, 11824.940875295568, 12043.337616431181, 12547.24716517012, 11661.825072623747, 11755.647330580096, 11901.345426001653, 11950.46222919988, 12402.627921162379, 9864.85202721974, 11329.830052549383, 11676.88323116758, 12025.45885435175, 12115.636530904087, 10109.898901010896, 10156.187504999434, 10259.692209233735, 10713.876988450975, 10714.035736783728, 8583.570821459027, 8851.291896648125, 8919.241864441336, 9724.270679699192, 10097.990200979842, 9318.394304370195, 10600.893991060299, 10870.347779133277, 11052.944735276273, 11092.445377731243], "value": 6999.684576906592, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 125.0, 168.0, 120.0, 119.0, 118.0, 122.0, 119.0, 122.0], "value": 124.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 114.0, 149.0, 122.0, 132.0, 139.0, 112.0, 182.0, 149.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 233.0, 180.0, 271.0, 274.0, 201.0, 195.0, 194.0, 198.0, 196.0], "value": 212.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 59.0, 84.0, 63.0, 65.0, 84.0, 87.0, 106.0, 59.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 64.0, 109.0, 104.0, 92.0, 71.0, 88.0, 71.0, 71.0, 89.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 85.0, 88.0, 97.0, 87.0, 86.0, 88.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 95.0, 94.0, 105.0, 95.0, 94.0, 94.0, 113.0, 127.0, 123.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 98.0, 135.0, 119.0, 90.0, 90.0, 90.0, 129.0, 139.0], "value": 106.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 59.0, 59.0, 60.0, 60.0, 57.0, 60.0, 61.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 92.0, 114.0, 80.0, 75.0, 70.0, 66.0, 76.0, 99.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 86.0, 92.0, 88.0, 89.0, 87.0, 88.0, 86.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 159.0, 149.0, 149.0, 154.0, 153.0, 142.0, 165.0, 225.0, 181.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 169.0, 169.0, 169.0, 170.0, 168.0, 168.0, 218.0, 234.0, 174.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 71.0, 71.0, 69.0, 84.0, 77.0, 66.0, 80.0], "value": 72.7, "unit": "score"}]}]} 10:28:34 INFO - Return code: 0 10:28:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:28:34 ERROR - # TBPL SUCCESS # 10:28:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:34 INFO - 2016-12-08 10:28:34.916 screenresolution[1660:11897] starting screenresolution argv=screenresolution get 10:28:34 INFO - 2016-12-08 10:28:34.920 screenresolution[1660:11897] Display 0: 1600x1200x32@60 10:28:34 INFO - 2016-12-08 10:28:34.927 screenresolution[1661:11900] starting screenresolution argv=screenresolution list 10:28:34 INFO - Available Modes on Display 0 10:28:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:35 INFO - Intel Iris: 10:28:35 INFO - Chipset Model: Intel Iris 10:28:35 INFO - Type: GPU 10:28:35 INFO - Bus: Built-In 10:28:35 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:35 INFO - Vendor: Intel (0x8086) 10:28:35 INFO - Device ID: 0x0a2e 10:28:35 INFO - Revision ID: 0x0009 10:28:35 INFO - Displays: 10:28:35 INFO - Display: 10:28:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:35 INFO - Display Serial Number: 1600x1200 60 10:28:35 INFO - Main Display: Yes 10:28:35 INFO - Mirror: Off 10:28:35 INFO - Online: Yes 10:28:35 INFO - Rotation: Supported 10:28:35 INFO - Return code: 0 10:28:35 INFO - Running post-action listener: _resource_record_post_action 10:28:35 INFO - [mozharness: 2016-12-08 18:28:35.171089Z] Finished run-tests step (success) 10:28:35 INFO - Running post-run listener: _resource_record_post_run 10:28:35 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 33178112; Write bytes: 663180800; Read time: 205; Write time: 1972 10:28:35 INFO - TinderboxPrint: CPU usage
54.5% 10:28:35 INFO - TinderboxPrint: I/O read bytes / time
33,178,112 / 205 10:28:35 INFO - TinderboxPrint: I/O write bytes / time
663,180,800 / 1,972 10:28:35 INFO - TinderboxPrint: CPU idle
2,204.6 (45.5%) 10:28:35 INFO - TinderboxPrint: CPU system
977.2 (20.2%) 10:28:35 INFO - TinderboxPrint: CPU user
1,659.9 (34.3%) 10:28:35 INFO - TinderboxPrint: Swap in / out
378,187,776 / 0 10:28:35 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 349676032; Write bytes: 351392256; Read time: 26959; Write time: 782 10:28:35 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30052864; Write bytes: 308669440; Read time: 176; Write time: 1175 10:28:35 INFO - Running post-run listener: _upload_blobber_files 10:28:35 INFO - Blob upload gear active. 10:28:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:35 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 10:28:35 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:28:35 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:28:36 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:37 INFO - (blobuploader) - INFO - Done attempting. 10:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:28:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:28:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:38 INFO - (blobuploader) - INFO - Done attempting. 10:28:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:28:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:41 INFO - (blobuploader) - INFO - Done attempting. 10:28:41 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:41 INFO - Return code: 0 10:28:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72009a5719321ceca54ce1bde155a8d6f14573345a052391aa7549a63e812c952d6534bc3e582645a7ecea1c600c916cd48c27c2cd0040c90f4e94303b2c9e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/384b02a17f53f598525114b64f0ab06a83b36e20e39a48baebce261c3d548e9f592549f6f185b0627b52bfbb24554221995f462d9f65e4a6eb071d675ceb0ff5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc67ee05171e37c022e9aeb91bb74beb99cb28bd89632a7b3b925930321c751f1aebc95d5d3b6043d23c0a2d0c3dd76fab7f2ce69ba0ce0b1816eaf974a65d83"} 10:28:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:41 INFO - Contents: 10:28:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72009a5719321ceca54ce1bde155a8d6f14573345a052391aa7549a63e812c952d6534bc3e582645a7ecea1c600c916cd48c27c2cd0040c90f4e94303b2c9e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/384b02a17f53f598525114b64f0ab06a83b36e20e39a48baebce261c3d548e9f592549f6f185b0627b52bfbb24554221995f462d9f65e4a6eb071d675ceb0ff5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc67ee05171e37c022e9aeb91bb74beb99cb28bd89632a7b3b925930321c751f1aebc95d5d3b6043d23c0a2d0c3dd76fab7f2ce69ba0ce0b1816eaf974a65d83"} 10:28:41 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:41 INFO - Copying logs to upload dir... 10:28:41 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.056653 ========= master_lag: 0.41 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-08 10:28:42.291563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 10:28:42.296354) ========= 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.jjpjOBsaN4/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.DEVMof5f0n/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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-Aurora/sha512/72009a5719321ceca54ce1bde155a8d6f14573345a052391aa7549a63e812c952d6534bc3e582645a7ecea1c600c916cd48c27c2cd0040c90f4e94303b2c9e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/384b02a17f53f598525114b64f0ab06a83b36e20e39a48baebce261c3d548e9f592549f6f185b0627b52bfbb24554221995f462d9f65e4a6eb071d675ceb0ff5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc67ee05171e37c022e9aeb91bb74beb99cb28bd89632a7b3b925930321c751f1aebc95d5d3b6043d23c0a2d0c3dd76fab7f2ce69ba0ce0b1816eaf974a65d83"} build_url:https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011013 build_url: 'https://queue.taskcluster.net/v1/task/a_kGMQvuTG65XOymnPUCUg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72009a5719321ceca54ce1bde155a8d6f14573345a052391aa7549a63e812c952d6534bc3e582645a7ecea1c600c916cd48c27c2cd0040c90f4e94303b2c9e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/384b02a17f53f598525114b64f0ab06a83b36e20e39a48baebce261c3d548e9f592549f6f185b0627b52bfbb24554221995f462d9f65e4a6eb071d675ceb0ff5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fc67ee05171e37c022e9aeb91bb74beb99cb28bd89632a7b3b925930321c751f1aebc95d5d3b6043d23c0a2d0c3dd76fab7f2ce69ba0ce0b1816eaf974a65d83"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 10:28:42.329887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:28:42.333252) ========= 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.jjpjOBsaN4/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.DEVMof5f0n/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.005191 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 10:28:42.381628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 10:28:42.384954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 10:28:42.385269) ========= ========= Total master_lag: 0.56 =========