builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0214 starttime: 1487196481.5 results: success (0) buildid: 20170215120914 builduid: 152312ca3e794437a3d954f93948111a revision: c79b61700177693e486bd968dfd51f38c8781f0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.499494) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.499979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.500291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.527235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.527624) ========= 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.0G1Rh4H49x/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.rjyrwn7ood/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-15 14:08:01-- 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% 211M=0s 2017-02-15 14:08:01 (211 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150572 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.702425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.702802) ========= 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.0G1Rh4H49x/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.rjyrwn7ood/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.027140 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:01.754707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-15 14:08:01.755102) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c79b61700177693e486bd968dfd51f38c8781f0a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c79b61700177693e486bd968dfd51f38c8781f0a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0G1Rh4H49x/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.rjyrwn7ood/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-15 14:08:01,863 truncating revision to first 12 chars 2017-02-15 14:08:01,863 Setting DEBUG logging. 2017-02-15 14:08:01,863 attempt 1/10 2017-02-15 14:08:01,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c79b61700177?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 14:08:03,218 unpacking tar archive at: mozilla-beta-c79b61700177/testing/mozharness/ program finished with exit code 0 elapsedTime=1.640833 ========= master_lag: 1.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-02-15 14:08:04.764452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:04.771845) ========= script_repo_revision: c79b61700177693e486bd968dfd51f38c8781f0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:04.772340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:04.772625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 14:08:04.798364) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-15 14:08:04.798737) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0G1Rh4H49x/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.rjyrwn7ood/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:04 INFO - MultiFileLogger online at 20170215 14:08:04 in /builds/slave/test 14:08:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:08:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:05 INFO - {'append_to_log': False, 14:08:05 INFO - 'base_work_dir': '/builds/slave/test', 14:08:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:08:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:05 INFO - 'branch': 'Mozilla-Beta', 14:08:05 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:05 INFO - 'config_files': ('talos/mac_config.py',), 14:08:05 INFO - 'default_actions': ('clobber', 14:08:05 INFO - 'read-buildbot-config', 14:08:05 INFO - 'download-and-extract', 14:08:05 INFO - 'populate-webroot', 14:08:05 INFO - 'create-virtualenv', 14:08:05 INFO - 'install', 14:08:05 INFO - 'run-tests'), 14:08:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:05 INFO - 'download_minidump_stackwalk': True, 14:08:05 INFO - 'download_symbols': 'ondemand', 14:08:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:05 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:05 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:05 INFO - 'installer_path': 'installer.exe', 14:08:05 INFO - 'log_level': 'info', 14:08:05 INFO - 'log_name': 'talos', 14:08:05 INFO - 'log_to_console': True, 14:08:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:08:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:08:05 INFO - 'opt_config_files': (), 14:08:05 INFO - 'pip_index': False, 14:08:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:05 INFO - 'cmd': ('bash', 14:08:05 INFO - '-c', 14:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:05 INFO - 'enabled': True, 14:08:05 INFO - 'halt_on_failure': False, 14:08:05 INFO - 'name': 'check_screen_resolution'},), 14:08:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:08:05 INFO - 'cmd': ('bash', 14:08:05 INFO - '-c', 14:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:08:05 INFO - 'enabled': True, 14:08:05 INFO - 'halt_on_failure': False, 14:08:05 INFO - 'name': 'check_screen_resolution'},), 14:08:05 INFO - 'run_cmd_checks_enabled': True, 14:08:05 INFO - 'sps_profile': False, 14:08:05 INFO - 'sps_profile_interval': 0, 14:08:05 INFO - 'suite': 'dromaeojs-e10s', 14:08:05 INFO - 'system_bits': '32', 14:08:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:05 INFO - 'title': 't-yosemite-r7-0214', 14:08:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:05 INFO - 'use_talos_json': True, 14:08:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:05 INFO - 'work_dir': 'build'} 14:08:05 INFO - [mozharness: 2017-02-15 22:08:05.009129Z] Running clobber step. 14:08:05 INFO - Running pre-action listener: _resource_record_pre_action 14:08:05 INFO - Running main action method: clobber 14:08:05 INFO - rmtree: /builds/slave/test/build 14:08:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:07 INFO - Running post-action listener: _resource_record_post_action 14:08:07 INFO - [mozharness: 2017-02-15 22:08:07.353653Z] Finished clobber step (success) 14:08:07 INFO - [mozharness: 2017-02-15 22:08:07.353782Z] Running read-buildbot-config step. 14:08:07 INFO - Running pre-action listener: _resource_record_pre_action 14:08:07 INFO - Running main action method: read_buildbot_config 14:08:07 INFO - Using buildbot properties: 14:08:07 INFO - { 14:08:07 INFO - "project": "", 14:08:07 INFO - "product": "firefox", 14:08:07 INFO - "script_repo_revision": "production", 14:08:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:08:07 INFO - "repository": "", 14:08:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:08:07 INFO - "buildid": "20170215120914", 14:08:07 INFO - "pgo_build": "False", 14:08:07 INFO - "basedir": "/builds/slave/test", 14:08:07 INFO - "buildnumber": 16, 14:08:07 INFO - "slavename": "t-yosemite-r7-0214", 14:08:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:08:07 INFO - "platform": "yosemite_r7", 14:08:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:08:07 INFO - "branch": "mozilla-beta", 14:08:07 INFO - "repo_path": "releases/mozilla-beta", 14:08:07 INFO - "revision": "c79b61700177693e486bd968dfd51f38c8781f0a", 14:08:07 INFO - "stage_platform": "macosx64", 14:08:07 INFO - "builduid": "152312ca3e794437a3d954f93948111a", 14:08:07 INFO - "slavebuilddir": "test" 14:08:07 INFO - } 14:08:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 14:08:07 INFO - Running post-action listener: _resource_record_post_action 14:08:07 INFO - [mozharness: 2017-02-15 22:08:07.357254Z] Finished read-buildbot-config step (success) 14:08:07 INFO - [mozharness: 2017-02-15 22:08:07.357363Z] Running download-and-extract step. 14:08:07 INFO - Running pre-action listener: _resource_record_pre_action 14:08:07 INFO - Running main action method: download_and_extract 14:08:07 INFO - mkdir: /builds/slave/test/build/tests 14:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:07 INFO - trying https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 14:08:07 INFO - Downloading https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 14:08:08 INFO - Downloaded 1165 bytes. 14:08:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:08:08 INFO - Using the following test package requirements: 14:08:08 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:08:08 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:08:08 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 14:08:08 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:08:08 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 14:08:08 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:08:08 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:08:08 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 14:08:08 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:08:08 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:08:08 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 14:08:08 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:08:08 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 14:08:08 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:08:08 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 14:08:08 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:08:08 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 14:08:08 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 14:08:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:08:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:08:08 INFO - Fetch https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:08:09 INFO - Http code: 200 14:08:09 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 14:08:09 INFO - x-amz-cf-id: NiY37xHx35V4BvbL6_H4sLy23gBHHYfgF67kB6lcb33SOfAxU7F56A== 14:08:09 INFO - x-amz-version-id: ufa.PV4bN3ICDGcMBoEAvLFjlx8qTl6O 14:08:09 INFO - Expected file size: 16094106 14:08:09 INFO - Obtained file size: 16094106 14:08:16 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:08:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:08:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:08:16 INFO - Fetch https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:08:16 INFO - Http code: 200 14:08:16 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 14:08:16 INFO - x-amz-cf-id: TZ6QbYkpdYmUjgC5tes25wPjQTZJ3J69zzNGx7Ajsb6ehlyJr2EmoA== 14:08:16 INFO - x-amz-version-id: ufa.PV4bN3ICDGcMBoEAvLFjlx8qTl6O 14:08:17 INFO - Expected file size: 16094106 14:08:17 INFO - Obtained file size: 16094106 14:08:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 14:08:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 14:08:23 INFO - Fetch https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 14:08:24 INFO - Http code: 200 14:08:24 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 14:08:24 INFO - x-amz-cf-id: 02S1Hx41DfiadT1U7JdFgFZoR9BPP0A4kwus71symruAGtDuxZ4Ymg== 14:08:24 INFO - x-amz-version-id: AW.Ovq97Vss3gw0.1I8sMrgtZSufiEuu 14:08:24 INFO - Expected file size: 14403005 14:08:24 INFO - Obtained file size: 14403005 14: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')]} 14:08:24 INFO - trying https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:08:24 INFO - Downloading https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 14:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 14:08:26 INFO - Downloaded 82113812 bytes. 14:08:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:08:26 INFO - mkdir: /builds/slave/test/properties 14:08:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:08:26 INFO - Writing to file /builds/slave/test/properties/build_url 14:08:26 INFO - Contents: 14:08:26 INFO - build_url:https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:08:27 INFO - Running post-action listener: _resource_record_post_action 14:08:27 INFO - Running post-action listener: set_extra_try_arguments 14:08:27 INFO - [mozharness: 2017-02-15 22:08:27.574942Z] Finished download-and-extract step (success) 14:08:27 INFO - [mozharness: 2017-02-15 22:08:27.575103Z] Running populate-webroot step. 14:08:27 INFO - Running pre-action listener: _resource_record_pre_action 14:08:27 INFO - Running main action method: populate_webroot 14:08:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:27 INFO - '--tppagecycles', 14:08:27 INFO - '7'], 14:08:27 INFO - 'tests': ['tsvgm']}}, 14:08:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:08:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:08:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['damp', 'tps']}, 14:08:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'tests': ['damp', 'tps']}, 14:08:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['dromaeo_dom']}, 14:08:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['basic_compositor_video']}, 14:08:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:08:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['a11yr', 14:08:27 INFO - 'ts_paint', 14:08:27 INFO - 'tpaint', 14:08:27 INFO - 'sessionrestore', 14:08:27 INFO - 'sessionrestore_no_auto_restore', 14:08:27 INFO - 'tabpaint']}, 14:08:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:08:27 INFO - 'ts_paint', 14:08:27 INFO - 'tpaint', 14:08:27 INFO - 'sessionrestore', 14:08:27 INFO - 'sessionrestore_no_auto_restore', 14:08:27 INFO - 'tabpaint']}, 14:08:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:08:27 INFO - 'ts_paint', 14:08:27 INFO - 'tpaint', 14:08:27 INFO - 'sessionrestore', 14:08:27 INFO - 'sessionrestore_no_auto_restore', 14:08:27 INFO - 'tabpaint']}, 14:08:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:08:27 INFO - 'ts_paint', 14:08:27 INFO - 'tpaint', 14:08:27 INFO - 'sessionrestore', 14:08:27 INFO - 'sessionrestore_no_auto_restore', 14:08:27 INFO - 'tabpaint']}, 14:08:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['a11yr', 14:08:27 INFO - 'ts_paint', 14:08:27 INFO - 'tpaint', 14:08:27 INFO - 'sessionrestore', 14:08:27 INFO - 'sessionrestore_no_auto_restore', 14:08:27 INFO - 'tabpaint']}, 14:08:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['a11yr', 14:08:27 INFO - 'ts_paint', 14:08:27 INFO - 'tpaint', 14:08:27 INFO - 'sessionrestore', 14:08:27 INFO - 'sessionrestore_no_auto_restore', 14:08:27 INFO - 'tabpaint']}, 14:08:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['tsvgx', 14:08:27 INFO - 'tsvgr_opacity', 14:08:27 INFO - 'tart', 14:08:27 INFO - 'tscrollx', 14:08:27 INFO - 'cart']}, 14:08:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:08:27 INFO - 'tsvgr_opacity', 14:08:27 INFO - 'tart', 14:08:27 INFO - 'tscrollx', 14:08:27 INFO - 'cart']}, 14:08:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'talos_options': ['--disable-e10s'], 14:08:27 INFO - 'tests': ['tp5o']}, 14:08:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'tests': ['tp5o']}, 14:08:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'talos_options': ['--disable-e10s', 14:08:27 INFO - '--xperf_path', 14:08:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:27 INFO - 'tests': ['tp5n']}, 14:08:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:27 INFO - 'talos_options': ['--xperf_path', 14:08:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:27 INFO - 'tests': ['tp5n']}}, 14:08:27 INFO - 'talos.zip': {'path': '', 14:08:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:27 INFO - Running post-action listener: _resource_record_post_action 14:08:27 INFO - [mozharness: 2017-02-15 22:08:27.593953Z] Finished populate-webroot step (success) 14:08:27 INFO - [mozharness: 2017-02-15 22:08:27.594063Z] Running create-virtualenv step. 14:08:27 INFO - Running pre-action listener: _resource_record_pre_action 14:08:27 INFO - Running main action method: create_virtualenv 14:08:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:08:27 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 14:08:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:08:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:27 INFO - Using real prefix '/tools/python27' 14:08:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:08:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:31 INFO - Installing pip.................done. 14:08:31 INFO - Return code: 0 14:08:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:08:31 INFO - Reading from file tmpfile_stdout 14:08:31 INFO - Output received: 14:08:31 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) 14:08:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:31 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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:31 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 14:08:31 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 14:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:31 INFO - 'HOME': '/Users/cltbld', 14:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:31 INFO - 'LOGNAME': 'cltbld', 14:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:31 INFO - 'MOZ_NO_REMOTE': '1', 14:08:31 INFO - 'NO_EM_RESTART': '1', 14:08:31 INFO - 'PAGER': '/bin/cat', 14:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:31 INFO - 'PWD': '/builds/slave/test', 14:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:31 INFO - 'SHELL': '/bin/bash', 14:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:31 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:31 INFO - 'USER': 'cltbld', 14:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:31 INFO - 'XPC_FLAGS': '0x0', 14:08:31 INFO - 'XPC_SERVICE_NAME': '0', 14:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:31 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 14:08:31 INFO - Cleaning up... 14:08:31 INFO - Return code: 0 14:08:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:31 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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:31 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 14:08:31 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 14:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:31 INFO - 'HOME': '/Users/cltbld', 14:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:31 INFO - 'LOGNAME': 'cltbld', 14:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:31 INFO - 'MOZ_NO_REMOTE': '1', 14:08:31 INFO - 'NO_EM_RESTART': '1', 14:08:31 INFO - 'PAGER': '/bin/cat', 14:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:31 INFO - 'PWD': '/builds/slave/test', 14:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:31 INFO - 'SHELL': '/bin/bash', 14:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:31 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:31 INFO - 'USER': 'cltbld', 14:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:31 INFO - 'XPC_FLAGS': '0x0', 14:08:31 INFO - 'XPC_SERVICE_NAME': '0', 14:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:32 INFO - Downloading/unpacking psutil>=3.1.1 14:08:32 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 14:08:32 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 14:08:32 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 14:08:32 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 14:08:32 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 14:08:32 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 14:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:35 INFO - Installing collected packages: psutil 14:08:35 INFO - Running setup.py install for psutil 14:08:35 INFO - building 'psutil._psutil_osx' extension 14:08:35 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 14:08:36 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 14:08:36 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 14:08:36 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 14:08:36 INFO - building 'psutil._psutil_posix' extension 14:08:36 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 14:08:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:08:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:08:36 INFO - ^ 14:08:36 INFO - 1 warning generated. 14:08:36 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 14:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:36 INFO - Successfully installed psutil 14:08:36 INFO - Cleaning up... 14:08:36 INFO - Return code: 0 14:08:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:36 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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:36 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 14:08:36 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 14:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:36 INFO - 'HOME': '/Users/cltbld', 14:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:36 INFO - 'LOGNAME': 'cltbld', 14:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:36 INFO - 'MOZ_NO_REMOTE': '1', 14:08:36 INFO - 'NO_EM_RESTART': '1', 14:08:36 INFO - 'PAGER': '/bin/cat', 14:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:36 INFO - 'PWD': '/builds/slave/test', 14:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:36 INFO - 'SHELL': '/bin/bash', 14:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:36 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:36 INFO - 'USER': 'cltbld', 14:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:36 INFO - 'XPC_FLAGS': '0x0', 14:08:36 INFO - 'XPC_SERVICE_NAME': '0', 14:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08:37 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 14:08:37 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 14:08:37 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 14:08:37 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 14:08:37 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 14:08:37 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 14:08:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:39 INFO - Installing collected packages: mozsystemmonitor 14:08:39 INFO - Running setup.py install for mozsystemmonitor 14:08:39 INFO - Successfully installed mozsystemmonitor 14:08:39 INFO - Cleaning up... 14:08:39 INFO - Return code: 0 14:08:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:08:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:39 INFO - 'HOME': '/Users/cltbld', 14:08:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:39 INFO - 'LOGNAME': 'cltbld', 14:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:39 INFO - 'MOZ_NO_REMOTE': '1', 14:08:39 INFO - 'NO_EM_RESTART': '1', 14:08:39 INFO - 'PAGER': '/bin/cat', 14:08:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:39 INFO - 'PWD': '/builds/slave/test', 14:08:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:39 INFO - 'SHELL': '/bin/bash', 14:08:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:39 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:39 INFO - 'USER': 'cltbld', 14:08:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:39 INFO - 'XPC_FLAGS': '0x0', 14:08:39 INFO - 'XPC_SERVICE_NAME': '0', 14:08:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:40 INFO - Downloading/unpacking jsonschema==2.5.1 14:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:08:42 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 14:08:42 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 14:08:42 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 14:08:42 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 14:08:42 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 14:08:42 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 14:08:43 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:43 INFO - warning: no files found matching '*.txt' 14:08:43 INFO - no previously-included directories found matching 'build' 14:08:43 INFO - no previously-included directories found matching 'dist' 14:08:43 INFO - no previously-included directories found matching '.git*' 14:08:43 INFO - Installing collected packages: jsonschema, functools32 14:08:43 INFO - Running setup.py install for functools32 14:08:43 INFO - warning: no files found matching '*.txt' 14:08:43 INFO - no previously-included directories found matching 'build' 14:08:43 INFO - no previously-included directories found matching 'dist' 14:08:43 INFO - no previously-included directories found matching '.git*' 14:08:43 INFO - Successfully installed jsonschema functools32 14:08:43 INFO - Cleaning up... 14:08:43 INFO - Return code: 0 14:08:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:43 INFO - 'HOME': '/Users/cltbld', 14:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:43 INFO - 'LOGNAME': 'cltbld', 14:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:43 INFO - 'MOZ_NO_REMOTE': '1', 14:08:43 INFO - 'NO_EM_RESTART': '1', 14:08:43 INFO - 'PAGER': '/bin/cat', 14:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:43 INFO - 'PWD': '/builds/slave/test', 14:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:43 INFO - 'SHELL': '/bin/bash', 14:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:43 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:43 INFO - 'USER': 'cltbld', 14:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:43 INFO - 'XPC_FLAGS': '0x0', 14:08:43 INFO - 'XPC_SERVICE_NAME': '0', 14:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:08:43 INFO - Cleaning up... 14:08:43 INFO - Return code: 0 14:08:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:43 INFO - 'HOME': '/Users/cltbld', 14:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:43 INFO - 'LOGNAME': 'cltbld', 14:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:43 INFO - 'MOZ_NO_REMOTE': '1', 14:08:43 INFO - 'NO_EM_RESTART': '1', 14:08:43 INFO - 'PAGER': '/bin/cat', 14:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:43 INFO - 'PWD': '/builds/slave/test', 14:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:43 INFO - 'SHELL': '/bin/bash', 14:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:43 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:43 INFO - 'USER': 'cltbld', 14:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:43 INFO - 'XPC_FLAGS': '0x0', 14:08:43 INFO - 'XPC_SERVICE_NAME': '0', 14:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:43 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:43 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 14:08:43 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 14:08:43 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 14:08:43 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 14:08:43 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 14:08:43 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 14:08:46 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:46 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 14:08:46 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 14:08:46 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 14:08:46 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 14:08:46 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 14:08:46 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 14:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:08:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08:47 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 14:08:47 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 14:08:47 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 14:08:47 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 14:08:47 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 14:08:47 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 14:08:47 INFO - Downloading docopt-0.6.1.tar.gz 14:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:48 INFO - Running setup.py install for blobuploader 14:08:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:08:48 INFO - Running setup.py install for requests 14:08:48 INFO - Running setup.py install for docopt 14:08:48 INFO - Successfully installed blobuploader requests docopt 14:08:48 INFO - Cleaning up... 14:08:48 INFO - Return code: 0 14:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:48 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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:48 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 14:08:48 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 14:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:48 INFO - 'HOME': '/Users/cltbld', 14:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:48 INFO - 'LOGNAME': 'cltbld', 14:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:48 INFO - 'MOZ_NO_REMOTE': '1', 14:08:48 INFO - 'NO_EM_RESTART': '1', 14:08:48 INFO - 'PAGER': '/bin/cat', 14:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:48 INFO - 'PWD': '/builds/slave/test', 14:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:48 INFO - 'SHELL': '/bin/bash', 14:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:48 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:48 INFO - 'USER': 'cltbld', 14:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:48 INFO - 'XPC_FLAGS': '0x0', 14:08:48 INFO - 'XPC_SERVICE_NAME': '0', 14:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-gubmcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-wgj_Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-eeR_2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Ub27so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-9sDFdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JgkPCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-nebIq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-VIIRUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-AZDORD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-GP3mGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-hMpLgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-NfxZjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-erihaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-pH4FvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-YSKBe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-_x3OYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Tc8JmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:50 INFO - Running setup.py install for manifestparser 14:08:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:51 INFO - Running setup.py install for mozcrash 14:08:51 INFO - Running setup.py install for mozdebug 14:08:51 INFO - Running setup.py install for mozdevice 14:08:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:08:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:51 INFO - Running setup.py install for mozfile 14:08:51 INFO - Running setup.py install for mozhttpd 14:08:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:51 INFO - Running setup.py install for mozinfo 14:08:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:51 INFO - Running setup.py install for mozInstall 14:08:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Running setup.py install for mozleak 14:08:52 INFO - Running setup.py install for mozlog 14:08:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Running setup.py install for moznetwork 14:08:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Running setup.py install for mozprocess 14:08:52 INFO - Running setup.py install for mozprofile 14:08:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:52 INFO - Running setup.py install for mozrunner 14:08:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:53 INFO - Running setup.py install for mozscreenshot 14:08:53 INFO - Running setup.py install for moztest 14:08:53 INFO - Running setup.py install for mozversion 14:08:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:53 INFO - Cleaning up... 14:08:53 INFO - Return code: 0 14:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:53 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')]} 14:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:53 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')]} 14:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:53 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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:53 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 14:08:53 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 14:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:53 INFO - 'HOME': '/Users/cltbld', 14:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:53 INFO - 'LOGNAME': 'cltbld', 14:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:53 INFO - 'MOZ_NO_REMOTE': '1', 14:08:53 INFO - 'NO_EM_RESTART': '1', 14:08:53 INFO - 'PAGER': '/bin/cat', 14:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:53 INFO - 'PWD': '/builds/slave/test', 14:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:53 INFO - 'SHELL': '/bin/bash', 14:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:53 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:53 INFO - 'USER': 'cltbld', 14:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:53 INFO - 'XPC_FLAGS': '0x0', 14:08:53 INFO - 'XPC_SERVICE_NAME': '0', 14:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:53 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-bcDaNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:53 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)) 14:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:53 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-g4j6vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:53 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)) 14:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:53 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-w6SVQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-PMRgYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-r_4PtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-hdNJ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-MFZH1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-KAGn2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ZyfVJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-OrdGCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-qDT_vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:54 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)) 14:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-tBIQgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:55 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)) 14:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-iBH8I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:55 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)) 14:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-gND_J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:55 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)) 14:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-l_PyhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:55 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)) 14:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JjEbif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-FaHMDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:55 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)) 14:08:55 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)) 14:08:55 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)) 14:08:55 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)) 14:08:55 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)) 14:08:55 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)) 14:08:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:58 INFO - Downloading blessings-1.6.tar.gz 14:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:58 INFO - Installing collected packages: blessings 14:08:58 INFO - Running setup.py install for blessings 14:08:58 INFO - Successfully installed blessings 14:08:58 INFO - Cleaning up... 14:08:58 INFO - Return code: 0 14:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:58 INFO - Reading from file tmpfile_stdout 14:08:58 INFO - Current package versions: 14:08:58 INFO - blessings == 1.6 14:08:58 INFO - blobuploader == 1.2.4 14:08:58 INFO - docopt == 0.6.1 14:08:58 INFO - functools32 == 3.2.3-2 14:08:58 INFO - jsonschema == 2.5.1 14:08:58 INFO - manifestparser == 1.1 14:08:58 INFO - mozInstall == 1.12 14:08:58 INFO - mozcrash == 1.0 14:08:58 INFO - mozdebug == 0.1 14:08:58 INFO - mozdevice == 0.48 14:08:58 INFO - mozfile == 1.2 14:08:58 INFO - mozhttpd == 0.7 14:08:58 INFO - mozinfo == 0.9 14:08:58 INFO - mozleak == 0.1 14:08:58 INFO - mozlog == 3.4 14:08:58 INFO - moznetwork == 0.27 14:08:58 INFO - mozprocess == 0.23 14:08:58 INFO - mozprofile == 0.28 14:08:58 INFO - mozrunner == 6.13 14:08:58 INFO - mozscreenshot == 0.1 14:08:58 INFO - mozsystemmonitor == 0.3 14:08:58 INFO - moztest == 0.8 14:08:58 INFO - mozversion == 1.4 14:08:58 INFO - psutil == 3.1.1 14:08:58 INFO - requests == 1.2.3 14:08:58 INFO - wsgiref == 0.1.2 14:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:58 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')]} 14:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:59 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')]} 14:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:59 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 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:08:59 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 14:08:59 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 14:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:59 INFO - 'HOME': '/Users/cltbld', 14:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:59 INFO - 'LOGNAME': 'cltbld', 14:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:59 INFO - 'MOZ_NO_REMOTE': '1', 14:08:59 INFO - 'NO_EM_RESTART': '1', 14:08:59 INFO - 'PAGER': '/bin/cat', 14:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:59 INFO - 'PWD': '/builds/slave/test', 14:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:59 INFO - 'SHELL': '/bin/bash', 14:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:08:59 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:59 INFO - 'USER': 'cltbld', 14:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:59 INFO - 'XPC_FLAGS': '0x0', 14:08:59 INFO - 'XPC_SERVICE_NAME': '0', 14:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 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)) 14:08:59 INFO - Cleaning up... 14:08:59 INFO - Return code: 0 14:08:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08:59 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')]} 14:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:59 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')]} 14:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bac4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba3a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b592f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, '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.0G1Rh4H49x/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.rjyrwn7ood/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 14:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:09:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:09:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:00 INFO - 'HOME': '/Users/cltbld', 14:09:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:00 INFO - 'LOGNAME': 'cltbld', 14:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:00 INFO - 'MOZ_NO_REMOTE': '1', 14:09:00 INFO - 'NO_EM_RESTART': '1', 14:09:00 INFO - 'PAGER': '/bin/cat', 14:09:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:00 INFO - 'PWD': '/builds/slave/test', 14:09:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:00 INFO - 'SHELL': '/bin/bash', 14:09:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:09:00 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:09:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:00 INFO - 'USER': 'cltbld', 14:09:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:00 INFO - 'XPC_FLAGS': '0x0', 14:09:00 INFO - 'XPC_SERVICE_NAME': '0', 14:09:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:00 INFO - Cleaning up... 14:09:00 INFO - Return code: 0 14:09:00 INFO - Running post-action listener: _resource_record_post_action 14:09:00 INFO - Running post-action listener: _start_resource_monitoring 14:09:00 INFO - Starting resource monitoring. 14:09:00 INFO - [mozharness: 2017-02-15 22:09:00.449253Z] Finished create-virtualenv step (success) 14:09:00 INFO - [mozharness: 2017-02-15 22:09:00.450220Z] Running install step. 14:09:00 INFO - Running pre-action listener: _resource_record_pre_action 14:09:00 INFO - Running main action method: install 14:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:00 INFO - Reading from file tmpfile_stdout 14:09:00 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:00 INFO - Reading from file tmpfile_stdout 14:09:00 INFO - Output received: 14:09:00 INFO - Usage: mozinstall [options] installer 14:09:00 INFO - Options: 14:09:00 INFO - -h, --help show this help message and exit 14:09:00 INFO - -d DEST, --destination=DEST 14:09:00 INFO - Directory to install application into. [default: 14:09:00 INFO - "/builds/slave/test"] 14:09:00 INFO - --app=APP Application being installed. [default: firefox] 14:09:00 INFO - mkdir: /builds/slave/test/build/application 14:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:09:22 INFO - Reading from file tmpfile_stdout 14:09:22 INFO - Output received: 14:09:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:09:22 INFO - Running post-action listener: _resource_record_post_action 14:09:22 INFO - [mozharness: 2017-02-15 22:09:22.113212Z] Finished install step (success) 14:09:22 INFO - [mozharness: 2017-02-15 22:09:22.113355Z] Running run-tests step. 14:09:22 INFO - Running pre-action listener: _resource_record_pre_action 14:09:22 INFO - Running main action method: run_tests 14:09:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:22 INFO - 2017-02-15 14:09:22.127 screenresolution[1626:7278] starting screenresolution argv=screenresolution get 14:09:22 INFO - 2017-02-15 14:09:22.130 screenresolution[1626:7278] Display 0: 1600x1200x32@60 14:09:22 INFO - 2017-02-15 14:09:22.136 screenresolution[1627:7281] starting screenresolution argv=screenresolution list 14:09:22 INFO - Available Modes on Display 0 14:09:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:22 INFO - Intel Iris: 14:09:22 INFO - Chipset Model: Intel Iris 14:09:22 INFO - Type: GPU 14:09:22 INFO - Bus: Built-In 14:09:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:22 INFO - Vendor: Intel (0x8086) 14:09:22 INFO - Device ID: 0x0a2e 14:09:22 INFO - Revision ID: 0x0009 14:09:22 INFO - Displays: 14:09:22 INFO - Display: 14:09:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:22 INFO - Display Serial Number: 1600x1200 60 14:09:22 INFO - Main Display: Yes 14:09:22 INFO - Mirror: Off 14:09:22 INFO - Online: Yes 14:09:22 INFO - Rotation: Supported 14:09:22 INFO - Return code: 0 14:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:09:22 INFO - Python 2.7.3 14:09:22 INFO - Return code: 0 14:09:22 INFO - grabbing minidump binary from tooltool 14:09:22 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')]} 14:09:22 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 0x10b8d8d30>, '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 0x10b73edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:09:22 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 14:09:22 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 14:09:22 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 14:09:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:22 INFO - Return code: 0 14:09:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:09:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:09:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:09:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:09:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 14:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 14:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0G1Rh4H49x/Render', 14:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:22 INFO - 'HOME': '/Users/cltbld', 14:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:22 INFO - 'LOGNAME': 'cltbld', 14:09:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:22 INFO - 'MOZ_NO_REMOTE': '1', 14:09:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:22 INFO - 'NO_EM_RESTART': '1', 14:09:22 INFO - 'PAGER': '/bin/cat', 14:09:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:22 INFO - 'PWD': '/builds/slave/test', 14:09:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:22 INFO - 'SHELL': '/bin/bash', 14:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rjyrwn7ood/Listeners', 14:09:22 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 14:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:22 INFO - 'USER': 'cltbld', 14:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:22 INFO - 'XPC_FLAGS': '0x0', 14:09:22 INFO - 'XPC_SERVICE_NAME': '0', 14:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 14:09:22 INFO - mozversion application_buildid: 20170215120914 14:09:22 INFO - mozversion application_changeset: c79b61700177693e486bd968dfd51f38c8781f0a 14:09:22 INFO - mozversion application_display_name: Firefox 14:09:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:22 INFO - mozversion application_name: Firefox 14:09:22 INFO - mozversion application_remotingname: firefox 14:09:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:09:22 INFO - mozversion application_vendor: Mozilla 14:09:22 INFO - mozversion application_version: 52.0 14:09:22 INFO - mozversion platform_buildid: 20170215120914 14:09:22 INFO - mozversion platform_changeset: c79b61700177693e486bd968dfd51f38c8781f0a 14:09:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:09:22 INFO - mozversion platform_version: 52.0 14:09:22 INFO - using testdate: 1487196562 14:09:22 INFO - actual date: 1487196562 14:09:22 INFO - starting webserver on 'localhost:49242' 14:09:22 INFO - SUITE-START | Running 2 tests 14:09:22 INFO - TEST-START | dromaeo_css 14:09:22 INFO - operating with platform_type : mac_ 14:09:22 INFO - Initialising browser for dromaeo_css test... 14:09:22 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmppEiOQG/profile http://localhost:49242/getInfo.html) 14:09:25 INFO - PROCESS | 1637 | 2017-02-15 14:09:25.826 plugin-container[1640:7461] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 14:09:25 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:25 INFO - PROCESS | 1637 | 2017-02-15 14:09:25.827 plugin-container[1640:7461] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 14:09:25 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:25 INFO - PROCESS | 1637 | 2017-02-15 14:09:25.827 plugin-container[1640:7461] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:09:25 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 14:09:25 INFO - PROCESS | 1637 | colorDepth:24 14:09:25 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 14:09:25 INFO - PROCESS | 1637 | __metrics 14:09:26 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:09:26 INFO - TEST-INFO | 1637: exit 0 14:09:26 INFO - Browser initialized. 14:09:26 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:26 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmppEiOQG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:29 INFO - PROCESS | 1641 | 2017-02-15 14:09:29.287 plugin-container[1642:7589] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833b, name = 'com.apple.tsm.portname' 14:09:29 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:29 INFO - PROCESS | 1641 | 2017-02-15 14:09:29.288 plugin-container[1642:7589] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 14:09:29 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:29 INFO - PROCESS | 1641 | 2017-02-15 14:09:29.288 plugin-container[1642:7589] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:09:38 INFO - PROCESS | 1641 | RSS: Main: 177180672 14:09:38 INFO - PROCESS | 1641 | 14:12:40 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 14:12:42 INFO - PROCESS | 1641 | RSS: Main: 182747136 14:12:42 INFO - PROCESS | 1641 | 14:15:44 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 14:15:44 INFO - PROCESS | 1641 | RSS: Main: 191885312 14:15:44 INFO - PROCESS | 1641 | 14:18:46 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 14:18:47 INFO - PROCESS | 1641 | RSS: Main: 195670016 14:18:47 INFO - PROCESS | 1641 | 14:21:49 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 14:21:49 INFO - PROCESS | 1641 | RSS: Main: 199852032 14:21:49 INFO - PROCESS | 1641 | 14:24:52 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 14:24:53 INFO - PROCESS | 1641 | RSS: Main: 201187328 14:24:53 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 14:27:55 INFO - PROCESS | 1641 | RSS: Main: 201469952 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | __start_tp_report 14:27:55 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 14:27:55 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 14:27:55 INFO - PROCESS | 1641 | |i|pagename|runs| 14:27:55 INFO - PROCESS | 1641 | |0;dojo.html;3548.042028652264;3563.590187128481;3580.892573222801;3583.2475180212164;3585.336712708149;5859.121131830222;5935.347111817702;5946.583739138262;5958.285005799299;6013.729382177801;5938;5993.160957465958;5999.400059993998;6005.969970150154;6019;4139.317012692917;5184.403793563751;5320.255164276995;5400.189971504286;5410.48600382963;5455.454454554552;5481.424450432707;5499.670019798805;5505.064139096363;5507.614466987313;4434.955650443502;5309.814156504523;5437.075697131478;5490.945090549103;5523.861903452425;5382.703951282678;5386.838394848141;5419.943111093338;5455.890882182373;5525.502704756551;5325.547328477084;5421.915616876601;5426.21319908615;5445.346558412976;5468.589855760833;5260.00059988601;5448;5863.032599621058;5953.1070339449;5974.731137098841;5931.673757943311;6203.658798766066;6204.317525072239;6236.469900058501;6254.812355629293;6298.559100862942;6302.1177035215105;6322.304546499881;6338.080978258173;6385.074164246204;6056.364081771439;6065.878682426327;6068.241469816273;6077.453029227347;6083;6234.532410069263;6269.937300627026;6274.215723034621;6295.96852015737;6312.968435157794;5244.370675518962;6201.131841542187;6277.7175027123885;6284.811455656338;6285.59143655661;6254.186955695731;6268;6287.088372186099;6293.181886354836;6296.087067375205;6141.731496609903;6162.22972128484;6168.444839964424;6199.9770037943235;6207.937920620826;6217.580330818032;6248.125262463259;6254.9687251563455;6256.280527739277;6262.2172228471445;5113.795448182105;5114.616403769732;5116.104681680766;5120.92318615221;5145.588352931756;4470.754108523997;4501.977490112594;4513.796879140446;4608.539146085364;4635.559621835921;4697.835575754901;5985.581009329392;6077.088436734437;6106.755729770848;6128.785492507741;5201.687898726089;6333.936660633427;6345.555811093272;6345.90481142774;6368.840778980562;5815.389384114692;5862.794802181903;5942.970285148546;5988.4909782668965;5999.100134979788;5607.467290607386;5624.493795558419;5625.46558076982;5634.971825140848;5651.971740141273;6495.772647957298;6503.089567460559;6504.284528701934;6508.349165083643;6510.21877374718;6143.143438301211;6197.504199664107;6199.814005579839;6214.658193799384;6323;6487.286398496256;6495;6520.869582608416;6523.31505191967;6529.640869752019;6263.342349053284;6271.278802937721;6293.402126797947;6308.747650093945;6311.147995020613;6191.628502289877;6214.036824292242;6226.470749986121;6275.6862156892885;6305.747770089145;5430.321209848769;5748.798792042258;6212.161358216583;6237.4698150657705;6260.154879091447;6230.532710046855;6232.314445410911;6237.002079667232;6250.906236406367;6268.028455589391;6009.909851352146;6052.061930400619;6121.602095863755;6155.384461553809;6194.690265486617;6159.5688301818445;6173.104899789416;6175.536834737323;6229.657368844757;6230.096635987847;5154;6147.139400484025;6161.260648722182;6168.444839964424;6177.907331389943 14:27:55 INFO - PROCESS | 1641 | |1;ext.html;492.6305271046714;499.7101681025006;513.1430511046552;582.3477704970434;602.7016626769749;37908.05229869251;40562.59437405625;40569.59430405695;40636.187276254495;40697.982550436216;42184.15631687372;42994.570054299445;43025.56974430255;43083.35374969378;43121.35317970233;8914.955425222865;9449.196818270455;9502.097300756433;9810.018998100204;9857.260705447085;9683.176929960962;9715.659951901685;9800.41197528147;9806.411615303068;9813.165880900133;9721.951390243039;9728.416295022322;9803.264755143357;9823.852642210373;9872.60509579616;9704.126628603424;9745.853812192823;9766.804663906752;9820.459874706889;9837.360571562825;9576.377535460173;9673.70978870635;9687.467189304585;9698.078682525149;9701.757456063584;39812.402813957815;40195.39706904399;40317.59682403168;40418.39372409416;40511.594884051075;3167.319026409333;3296.2583418730833;3590.7127429805555;3863.2273545290773;4024.839006439739;30285.394292114033;31029.534556981664;31303.37393252145;31417.37165256705;31795.205119871956;3257.2833976525126;3280.0815771583993;3299.5215693724517;3369.2082360645227;3468.323676883009;513246;518561;518866;520479.3976030133;521892;62306.688466558284;62668.05997910035;62784;62841.057384139276;62862.057069144;65125.67437162879;65147;65152.34847651463;65406.01890971639;65486.345136548975;17091.401800936907;17180.31278748836;17260.482185534453;17317.653646926992;17358.65282694339;13203.603891883258;13231.801522977163;13346.733065338638;13348.199108053548;13356.73286534264;16957.067361295;17410.564735881704;17594;17623.942563445977;17670.0281484517;5513.531349835229;6283.183186185766;6569.901451478232;6581.473482121419;6581.86836263272;823.0288259853311;893.6916763716507;896.5114012863005;918.5040078357746;1028.2956175020136;27389.589156162274;27826.443471130868;28748;29274.121776346743;29400;952.618952419024;1016.4765145949842;1019.9439030853226;1093.8906109388997;1097.5280629329466;14610.561683149523;14827.332770025374;14847.331870065873;15079;15098.39606415731;146416;179252.20747792616;183617;183626;183868;59563.702181488814;60083.699581501816;60402;60450.79098418007;60528.69735651294;1230.6615680688062;1391.6033930330009;1393.9233342166076;1423.3737155651481;1423.871851533367;28079.298017549725;28640.997565085123;28676.42647147087;29210.56184157197;29447.558286625288;56644;57769;58387.70806145942;61052.77894441997;61590.076148856904;498483;577552;579459;579595;581048;26216.606750899133;26421.73578264193;26675.733242667324;26761.732382675924;26764.19707408781;47403.525964739914;47844.76077619589;48037.75981120072;48990.75504622597;49192;37904.810475947445;39197.41203882001;39292.60707393004;39887;40676.59323406728;39131;39687.60312396839;40117.19765604613;40390.15318161839;40544.391834123104;31691.2955667982;31904.88332908337;33455.66544334526;36680;38079.80960095182;34460.65539344575;35604;35710.8214458926;35724.64275357213;35778.821105894305;24604;24839.254822355357;24846.130385436423;25167.496650067264;25412 14:27:55 INFO - PROCESS | 1641 | |2;jquery.html;378.80491546853375;384.5723215024605;386.530365605789;391.75319548684314;413.16128259632956;19260.940648264357;19903.601927961434;20389.898050509746;20458.897705511452;20506.89746551267;19007.714884276746;19662;19706.211751529958;19773.209071637117;19843.900780496115;4938.407391113072;5135.922961155586;5414.91877621835;5492.148716948879;5566.137248726433;5479.671219726809;5488.396276409611;5529.142982837667;5557.305336832896;5604.747786349603;5517.889642207174;5567.109262517998;5802.854928626776;5852.736626851781;5930.406959304079;5678.949394362056;5762.049261871807;5832.2418085649015;5896.911546326808;5929.762809487615;5590.18942253375;5639.605227634067;5688.691600931809;5724.8282551523525;5728.140778883159;13003.414846331843;13086.672833179151;13097.934510327388;13160.60518184456;13305.933470332586;1745.973810392845;2287.2109122352763;2366.396568874943;2509.034021901581;2962.896298629538;9972;10010.399376037461;10089.848652270222;10267.948660256725;10643.627473038407;1723.3365154415515;1814.8003719590965;1925.4801203674929;1936.663702045584;1974.4076776966851;124642;128236.99999999907;130227;134526.32736836254;135759;9938.850917236246;11840.171188016757;12076;12175;12285.877141228651;15072.54782356531;15134.318955647022;15150.621234469227;15177.392904283926;15187.240637968058;7913.446058775946;8519.446235994641;8864.955675221583;8971.372003959661;8998.955005224932;8925.152110549487;8937.240334571505;8960.05919378469;9007.459552426875;9079.636814527345;4644.117617652635;4699.95300047002;4708.105459962596;4718.4809670936165;4742.715437073786;1985.7914918933304;2017.5258814178655;2025.544252543166;2032.24806821477;2073.315805784118;852.8336974289954;884.9955750221336;906.2568693671258;907.020417948614;928.8792456980684;19894.403167904988;19898.50253743668;20870.165193392397;20933.581328373653;21175.57648847045;820.2003047029218;821.9383546234056;889.4929889962659;905.5019739143445;955.3360414511848;10286.588536458608;10962.629671291088;10993.34039957589;11018.669439916815;11034.282771619819;605105;615621;628200;629374;630004.8499757564;82840.58579707063;83941.16058839456;83975.580122099;120996.3950180261;126702;974.5273542331963;1018.3177271228295;1034.2139973620103;1034.6947650442987;1036.580185025051;18149.90925045419;18339.174737137128;18603.534911626775;18866.811331886507;19220.903895480435;54176.64558386072;59178;59559;59666.70166649139;60134.19597412085;82933.17066829254;83309;83658;84701;87509;5867.471927526543;7923.85104159882;8182;8316.708915187939;8327.6668933242;12450.128491005542;12632.978723404578;12750;12926.418311176209;12927.5475358362;9855.605775768889;10084.84872726895;10369;10399.48002599882;10448.164146868081;5124.282600435868;8074.869518267565;10495.527701253615;10729.839052414063;10753.408562528823;8620.956895215484;10038.799224015625;10065.144462720751;10135.442550659785;10227.488625568543;5901.498372638373;7300.379467745089;7318.34134927859;7540.208278130717;7734.99445072137;10096.79806403853;10203;10352.171826254033;10382.013708697661;10542.947285263524 14:27:55 INFO - PROCESS | 1641 | |3;mootools.html;1513.6972605478907;1548.4348212902291;1752.553098959765;1807.3854889337622;1862.2550979608147;7708.421868359867;7931.881021784663;8391;8755.824883502326;8782.780430489232;8214.342852571795;8495.235428811406;8506.02180749214;8601.354898382615;8608.311335093193;2341.9297421077354;2377.6076947303673;2391.330427480308;2394.0663141374876;2403.170906037414;2391.6173412254043;2400.135951057618;2405.1341517053847;2439.889850118192;2441.377448750575;2370.5021945391404;2373.92878213653;2389.880505974703;2400.2679182849224;2409.289259668402;2348.424635964191;2360.2683168217823;2362.5274945011065;2364.5152743687504;2364.574376612209;2088.592724418739;2341.6955795746444;2350.8354415190943;2398.760123987587;2407.3018824541036;8518.020427650776;8574.185452382013;8612.569371531461;8622.267107295887;8640.481571105754;5186.636935414523;5351.518363347279;5376.354837419495;5376.462353764592;5379.112446446332;2917.5769513420646;3477.3045390921666;3611.494390785292;3649.3613617617075;3670.229251857113;966.2801213096218;1082.242430298786;1083.737445875554;1121.697141771717;1129.7966366054106;10960.177986651033;11049.889501104966;11123.610673626465;11127.554897804079;11133.443327833576;4560.771961401917;4667.346571479996;4747.620190384761;4757.666963312604;4846.781894814671;9729.513524323755;9736.95131524338;9746.658866939622;9750;9752.414855108716;5295.364556253197;5315.176147697113;5324.574034077342;5332.866678333073;5342.210359529523;4407.294832826732;4446.444194475691;4898.681585696918;4924.8276310328965;4976.751162441863;3248.635573059321;3521.436570148764;3921.098147426108;4037.051292946155;4051.2707712612014;1125.7298248420484;1287.993560032194;1304.9151805132826;1308.718625495523;1322.616441232032;776.7436745873848;820.306840719591;832.8417600655856;843.3927572148043;852.5225873510853;4613.538646135359;5266.526012658879;5313.707746073926;5329.54698850602;5581.3302403711;855.5935930432995;874.5059041641452;913.2191975860676;913.7578541686458;913.9908600914039;3237.963851567476;3447.1209841490763;3499.160201551609;3550.3254381667402;3595.964040359563;9586.616535338648;10318.535665895053;10327.793444131226;10370.948145259226;10403.167746580255;10197.082262596401;10266.486675666187;10273.845892311621;10328.173746100294;10330.431826249629;7666.156722760492;8155.469894456842;8165.63254653542;8166.591670416456;8195.508269503849;4802;5249.2126181073145;5283.181106928432;5336.786528538815;5466.699331536804;9389.201917837061;9569.712908612753;9594.376365536218;9664.710058697969;9714.902850971683;9462.952685236805;9500.239980801382;9691.709248722267;9717.805643887225;9854.556544955638;6581.80254592363;6774.729010839511;6949.930500695131;7055.118110236221;7243.45674074436;7932.56370899583;8100.797480063045;8115.513069215866;8127.106018338096;8138.267555919995;7218;7332.743353982585;7382.6677799498075;7421.3320801126;7496.362809161283;7155.069840920647;7255.165655949422;7264.309890560388;7266.1280646322775;7305.671244794104;6523.543351965317;6548.901766473602;6552.24649165333;6584.572002819801;6633.336666333328;4624.930626040679;4636.698614590041;4643.326717625993;4720.079584481131;4728.101660684459;3656.2870240302886;4391.780410979502;4693.882652933704;4758.928616070831;4801.063792560417 14:27:55 INFO - PROCESS | 1641 | |4;prototype.html;274.649821477616;309.90911989795916;319.99200019999495;325.56374458225974;326.5933912279213;4594;4686.968866849292;5112.872178195547;5697.259356283683;5707.229524014257;4839.370881785372;5472;5540.750666220019;5570.86072848179;5598.580106492009;3484.61669216386;3553.769005014679;3650.7444478886487;4213.567387088389;4243.915121697564;3694.4827724118645;3703.777773333595;3728.459373390857;4234.9364759528635;4315.180115777992;4047.170330082326;4271.63691086258;4278.871633850989;4278.957210427902;4287.849925252617;3310.4372256716415;3457.579694214035;3846.519185101862;3865.207632435344;4289.785510724467;3595.8741444049333;3599.208174201671;3604.4052731299303;3605.0712868615165;3617.3488772021024;4765.28520721891;4773.737444440554;4977.701337919736;5485;5499.945000549983;3818.59904710007;4487.461504619434;4591.793369298356;4818.518148185189;4823.083614113342;5680.608250978496;5839.649621022752;5861.736221870026;5902.911456328158;5905.468507834273;3184.5700830388064;3823.9617603823885;3961.4946320398353;3987.7806720630356;3997.920041599152;5632.3804381518;5918.852028699274;6004.729787159545;6213.285472170713;6228.346023667495;3972.411035585789;4015.5382131055303;4028.4964379452567;4045.2718510667773;4061.9796901015307;3930.3121953657997;3945.4870866787132;4102.021039591651;4117.949922769734;4135.793210339471;3687.870924517629;4738.062401311209;4821.493743156918;4833.830815921426;4834.903301933941;4890.437599676083;5615.5507559395965;5669.343273588513;5975.40245975399;5999.700014999233;1319.4194554396036;1337.9264140472173;1340.2025794652166;1350.980010092374;1360.3538319298452;757.7802437293234;848.2747251100344;896.6682327538853;904.9411788233743;912.7763697894059;4826.95173048265;4971.875703107379;5314.893702125936;5628.380878103405;5662.68855212959;6139.4781443577795;6141.170941922784;6141.539384546177;6176.536759743038;6184.443400094013;4839.636452665363;5517.227588137664;5566.582506312043;5573.331200255995;5644.266245388073;2638.8416694998364;3031.7119873611973;3054.801437906529;3067.2178594458715;3096.4362996686527;5124.9743751281;5968.880622387528;5980.385295970151;6101.3459145271945;6154.307415550634;5651.886962260814;5911.645301281937;6422.935770642327;6442.680634971406;6444.355564443518;5603.495685388416;6009.459148676553;6328.778492752732;6402.551821372553;6457.773977910751;5021.84934451967;5320.882614650966;5750.396208398058;6192.473639740672;6242.563020588515;5395.030813752874;6152.815415537541;6165.167702360303;6213.316535181217;6217.533684973736;5888;6079.422454866781;6208.161898143873;6431.228252609717;6467.773627923;3281.0320955318716;3753.099256178552;3962.9498182980956;4064.7967601620394;4067;6141.109539116893;6151.108089327112;6161.7843375483435;6215.782447614311;6231.9688401557705;5833.300003999547;5946.851328716817;5994.67029313392;6006.639601623741;6055.5458340623745;5238.5547228486;5697.834822767322;5941.881162376641;5976.073708575004;6000.639961602318;4908.656394052382;5885.646861188342;5899.852503687443;5927.673977931255;5937.317208520903;5167.6641018333685;5250.632455728062;5875.383084776037;5910.261217347832;5937.9406205937385;5095.898082038412;5469.589780766379;5810.970945145247;5824.213731146241;5834.766609335579 14:27:55 INFO - PROCESS | 1641 | |5;yui.html;705.0481849503175;717.5802155738893;777.3392616276166;813.6257321632049;813.9552324622147;15111.395544178233;15385;15770;15796;15802.525924222264;14161.29193540324;14172.71654566908;14240.71518569628;14268.500602478915;14280.143191408522;714.3713532091765;866.0516734176067;871.8038441350709;872.5593575244493;875.6935072724559;852.5566705313233;853.1937319233327;853.4964371021097;857.9056303806608;860.7589874835056;886.7118186589352;894.5214310343968;925.1072714830187;928.2295694573521;929.2705226397279;885.6014793342957;886.7960369115108;914.9889372243641;918.1002617434917;918.17823048372;693.9653017349112;694.3160986428364;694.5173104692241;696.6273043921528;697.1459961547064;12478.81281780774;12648.304343261118;12737.617871463872;12892.097553171281;13661.453541858315;11795.823062654066;11897;11994.520219191221;12017.579384721581;12162.452689628988;10721.678349649523;10809.78380432387;10818.783624327469;10842.403667798268;10849.186311026626;3587.4798154267746;3685.6130106338715;3748.6251374862295;3770.9057273568105;3823.388257878726;71880;76444;102985;106515.46742266239;107238.46380768124;10669.689035827838;10700.625478108228;10815.080718138888;10823.29648572856;10922.781544369069;20352.084156213004;20421.387358379274;20508;20622.58754824895;20667.27664531764;7510.211427800112;7720.53676779395;7909;8064.072631647436;8158.469699469515;4243.7029407941145;4293.6715924150485;4356.978215108904;4441.267190913528;4459.754713490789;3353.2622822978906;3361.4957756336744;3426.331865286295;3438.2263990601914;3463.8094904779973;669.718718138383;682.205230905989;683.4737252315689;709.8331892005375;716.8458781362032;620.4849974521137;639.2233436374734;669.6317025635881;670.1020632352671;672.922613899398;8781.956090219635;8931.598078086501;8953.507557084424;9085.227755640844;9175.724728258163;537.6182910133771;555.6194007105146;630.2061589232793;639.3414782773658;686.5503095472474;3890.5525864525375;4288.871333859989;4299.401731854949;4573.245414506636;4590.88522786933;84671;95878;96386;96972;101973.49013254886;69727.65136174287;99948.5002574997;104387.95612043783;104393;108139.91860081299;68509;91104;92710;94620.52689736507;97539;9220.815583688423;9695.175910047443;9753.51232438361;9926;9960.850587241051;33931.83034084814;42459;55744.44255557392;56142.719286403306;58622.41377586169;68719;83803.86034347185;85542;86419.1358086411;86768;12456.501739930301;12474.937625311815;12745.872541274468;13053.412596432994;13175.2753598553;14386.928065359607;14388.424463021362;14637.88377056609;15143.924280378527;15485.84514154844;13030;13039.543615973396;13726.382312796148;13790.862091378958;13835.515756948862;11397.30773826101;13135.605931822061;13932.30338483092;13986;14162.433502659778;10717.648341410817;12853.678658033625;12934.805977910151;13113.08208425401;13394.665133371744;10799.946000269949;10872.456377181268;11031.889681103086;11596.188266821242;11960.162788604714;10826.729331766768;11100.833487497855;11213.215074944676;11264.60573879943;11297.548098076313 14:27:55 INFO - PROCESS | 1641 | __end_tp_report 14:27:55 INFO - PROCESS | 1641 | __start_cc_report 14:27:55 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,359 14:27:55 INFO - PROCESS | 1641 | __end_cc_report 14:27:55 INFO - PROCESS | 1641 | __startTimestamp1487197675903__endTimestamp 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | ------- Summary: start ------- 14:27:55 INFO - PROCESS | 1641 | Number of tests: 6 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5844.47 Median:6121.60 stddev:636.61 (10.4%) stddev-sans-first:612.54 14:27:55 INFO - PROCESS | 1641 | Values: 3548.0 3563.6 3580.9 3583.2 3585.3 5859.1 5935.3 5946.6 5958.3 6013.7 5938.0 5993.2 5999.4 6006.0 6019.0 4139.3 5184.4 5320.3 5400.2 5410.5 5455.5 5481.4 5499.7 5505.1 5507.6 4435.0 5309.8 5437.1 5490.9 5523.9 5382.7 5386.8 5419.9 5455.9 5525.5 5325.5 5421.9 5426.2 5445.3 5468.6 5260.0 5448.0 5863.0 5953.1 5974.7 5931.7 6203.7 6204.3 6236.5 6254.8 6298.6 6302.1 6322.3 6338.1 6385.1 6056.4 6065.9 6068.2 6077.5 6083.0 6234.5 6269.9 6274.2 6296.0 6313.0 5244.4 6201.1 6277.7 6284.8 6285.6 6254.2 6268.0 6287.1 6293.2 6296.1 6141.7 6162.2 6168.4 6200.0 6207.9 6217.6 6248.1 6255.0 6256.3 6262.2 5113.8 5114.6 5116.1 5120.9 5145.6 4470.8 4502.0 4513.8 4608.5 4635.6 4697.8 5985.6 6077.1 6106.8 6128.8 5201.7 6333.9 6345.6 6345.9 6368.8 5815.4 5862.8 5943.0 5988.5 5999.1 5607.5 5624.5 5625.5 5635.0 5652.0 6495.8 6503.1 6504.3 6508.3 6510.2 6143.1 6197.5 6199.8 6214.7 6323.0 6487.3 6495.0 6520.9 6523.3 6529.6 6263.3 6271.3 6293.4 6308.7 6311.1 6191.6 6214.0 6226.5 6275.7 6305.7 5430.3 5748.8 6212.2 6237.5 6260.2 6230.5 6232.3 6237.0 6250.9 6268.0 6009.9 6052.1 6121.6 6155.4 6194.7 6159.6 6173.1 6175.5 6229.7 6230.1 5154.0 6147.1 6161.3 6168.4 6177.9 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:58156.90 Median:40353.88 stddev:121699.99 (301.6%) stddev-sans-first:121964.38 14:27:55 INFO - PROCESS | 1641 | Values: 492.6 499.7 513.1 582.3 602.7 37908.1 40562.6 40569.6 40636.2 40698.0 42184.2 42994.6 43025.6 43083.4 43121.4 8915.0 9449.2 9502.1 9810.0 9857.3 9683.2 9715.7 9800.4 9806.4 9813.2 9722.0 9728.4 9803.3 9823.9 9872.6 9704.1 9745.9 9766.8 9820.5 9837.4 9576.4 9673.7 9687.5 9698.1 9701.8 39812.4 40195.4 40317.6 40418.4 40511.6 3167.3 3296.3 3590.7 3863.2 4024.8 30285.4 31029.5 31303.4 31417.4 31795.2 3257.3 3280.1 3299.5 3369.2 3468.3 513246.0 518561.0 518866.0 520479.4 521892.0 62306.7 62668.1 62784.0 62841.1 62862.1 65125.7 65147.0 65152.3 65406.0 65486.3 17091.4 17180.3 17260.5 17317.7 17358.7 13203.6 13231.8 13346.7 13348.2 13356.7 16957.1 17410.6 17594.0 17623.9 17670.0 5513.5 6283.2 6569.9 6581.5 6581.9 823.0 893.7 896.5 918.5 1028.3 27389.6 27826.4 28748.0 29274.1 29400.0 952.6 1016.5 1019.9 1093.9 1097.5 14610.6 14827.3 14847.3 15079.0 15098.4 146416.0 179252.2 183617.0 183626.0 183868.0 59563.7 60083.7 60402.0 60450.8 60528.7 1230.7 1391.6 1393.9 1423.4 1423.9 28079.3 28641.0 28676.4 29210.6 29447.6 56644.0 57769.0 58387.7 61052.8 61590.1 498483.0 577552.0 579459.0 579595.0 581048.0 26216.6 26421.7 26675.7 26761.7 26764.2 47403.5 47844.8 48037.8 48990.8 49192.0 37904.8 39197.4 39292.6 39887.0 40676.6 39131.0 39687.6 40117.2 40390.2 40544.4 31691.3 31904.9 33455.7 36680.0 38079.8 34460.7 35604.0 35710.8 35724.6 35778.8 24604.0 24839.3 24846.1 25167.5 25412.0 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:35049.23 Median:381.69 stddev:103521.94 (27122.1%) stddev-sans-first:103779.61 14:27:55 INFO - PROCESS | 1641 | Values: 378.8 384.6 386.5 391.8 413.2 19260.9 19903.6 20389.9 20458.9 20506.9 19007.7 19662.0 19706.2 19773.2 19843.9 4938.4 5135.9 5414.9 5492.1 5566.1 5479.7 5488.4 5529.1 5557.3 5604.7 5517.9 5567.1 5802.9 5852.7 5930.4 5678.9 5762.0 5832.2 5896.9 5929.8 5590.2 5639.6 5688.7 5724.8 5728.1 13003.4 13086.7 13097.9 13160.6 13305.9 1746.0 2287.2 2366.4 2509.0 2962.9 9972.0 10010.4 10089.8 10267.9 10643.6 1723.3 1814.8 1925.5 1936.7 1974.4 124642.0 128237.0 130227.0 134526.3 135759.0 9938.9 11840.2 12076.0 12175.0 12285.9 15072.5 15134.3 15150.6 15177.4 15187.2 7913.4 8519.4 8865.0 8971.4 8999.0 8925.2 8937.2 8960.1 9007.5 9079.6 4644.1 4700.0 4708.1 4718.5 4742.7 1985.8 2017.5 2025.5 2032.2 2073.3 852.8 885.0 906.3 907.0 928.9 19894.4 19898.5 20870.2 20933.6 21175.6 820.2 821.9 889.5 905.5 955.3 10286.6 10962.6 10993.3 11018.7 11034.3 605105.0 615621.0 628200.0 629374.0 630004.8 82840.6 83941.2 83975.6 120996.4 126702.0 974.5 1018.3 1034.2 1034.7 1036.6 18149.9 18339.2 18603.5 18866.8 19220.9 54176.6 59178.0 59559.0 59666.7 60134.2 82933.2 83309.0 83658.0 84701.0 87509.0 5867.5 7923.9 8182.0 8316.7 8327.7 12450.1 12633.0 12750.0 12926.4 12927.5 9855.6 10084.8 10369.0 10399.5 10448.2 5124.3 8074.9 10495.5 10729.8 10753.4 8621.0 10038.8 10065.1 10135.4 10227.5 5901.5 7300.4 7318.3 7540.2 7735.0 10096.8 10203.0 10352.2 10382.0 10542.9 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5505.14 Median:5217.92 stddev:3067.50 (58.8%) stddev-sans-first:3061.44 14:27:55 INFO - PROCESS | 1641 | Values: 1513.7 1548.4 1752.6 1807.4 1862.3 7708.4 7931.9 8391.0 8755.8 8782.8 8214.3 8495.2 8506.0 8601.4 8608.3 2341.9 2377.6 2391.3 2394.1 2403.2 2391.6 2400.1 2405.1 2439.9 2441.4 2370.5 2373.9 2389.9 2400.3 2409.3 2348.4 2360.3 2362.5 2364.5 2364.6 2088.6 2341.7 2350.8 2398.8 2407.3 8518.0 8574.2 8612.6 8622.3 8640.5 5186.6 5351.5 5376.4 5376.5 5379.1 2917.6 3477.3 3611.5 3649.4 3670.2 966.3 1082.2 1083.7 1121.7 1129.8 10960.2 11049.9 11123.6 11127.6 11133.4 4560.8 4667.3 4747.6 4757.7 4846.8 9729.5 9737.0 9746.7 9750.0 9752.4 5295.4 5315.2 5324.6 5332.9 5342.2 4407.3 4446.4 4898.7 4924.8 4976.8 3248.6 3521.4 3921.1 4037.1 4051.3 1125.7 1288.0 1304.9 1308.7 1322.6 776.7 820.3 832.8 843.4 852.5 4613.5 5266.5 5313.7 5329.5 5581.3 855.6 874.5 913.2 913.8 914.0 3238.0 3447.1 3499.2 3550.3 3596.0 9586.6 10318.5 10327.8 10370.9 10403.2 10197.1 10266.5 10273.8 10328.2 10330.4 7666.2 8155.5 8165.6 8166.6 8195.5 4802.0 5249.2 5283.2 5336.8 5466.7 9389.2 9569.7 9594.4 9664.7 9714.9 9463.0 9500.2 9691.7 9717.8 9854.6 6581.8 6774.7 6949.9 7055.1 7243.5 7932.6 8100.8 8115.5 8127.1 8138.3 7218.0 7332.7 7382.7 7421.3 7496.4 7155.1 7255.2 7264.3 7266.1 7305.7 6523.5 6548.9 6552.2 6584.6 6633.3 4624.9 4636.7 4643.3 4720.1 4728.1 3656.3 4391.8 4693.9 4758.9 4801.1 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4740.12 Median:5432.31 stddev:1525.71 (28.1%) stddev-sans-first:1492.72 14:27:55 INFO - PROCESS | 1641 | Values: 274.6 309.9 320.0 325.6 326.6 4594.0 4687.0 5112.9 5697.3 5707.2 4839.4 5472.0 5540.8 5570.9 5598.6 3484.6 3553.8 3650.7 4213.6 4243.9 3694.5 3703.8 3728.5 4234.9 4315.2 4047.2 4271.6 4278.9 4279.0 4287.8 3310.4 3457.6 3846.5 3865.2 4289.8 3595.9 3599.2 3604.4 3605.1 3617.3 4765.3 4773.7 4977.7 5485.0 5499.9 3818.6 4487.5 4591.8 4818.5 4823.1 5680.6 5839.6 5861.7 5902.9 5905.5 3184.6 3824.0 3961.5 3987.8 3997.9 5632.4 5918.9 6004.7 6213.3 6228.3 3972.4 4015.5 4028.5 4045.3 4062.0 3930.3 3945.5 4102.0 4117.9 4135.8 3687.9 4738.1 4821.5 4833.8 4834.9 4890.4 5615.6 5669.3 5975.4 5999.7 1319.4 1337.9 1340.2 1351.0 1360.4 757.8 848.3 896.7 904.9 912.8 4827.0 4971.9 5314.9 5628.4 5662.7 6139.5 6141.2 6141.5 6176.5 6184.4 4839.6 5517.2 5566.6 5573.3 5644.3 2638.8 3031.7 3054.8 3067.2 3096.4 5125.0 5968.9 5980.4 6101.3 6154.3 5651.9 5911.6 6422.9 6442.7 6444.4 5603.5 6009.5 6328.8 6402.6 6457.8 5021.8 5320.9 5750.4 6192.5 6242.6 5395.0 6152.8 6165.2 6213.3 6217.5 5888.0 6079.4 6208.2 6431.2 6467.8 3281.0 3753.1 3962.9 4064.8 4067.0 6141.1 6151.1 6161.8 6215.8 6232.0 5833.3 5946.9 5994.7 6006.6 6055.5 5238.6 5697.8 5941.9 5976.1 6000.6 4908.7 5885.6 5899.9 5927.7 5937.3 5167.7 5250.6 5875.4 5910.3 5937.9 5095.9 5469.6 5811.0 5824.2 5834.8 14:27:55 INFO - PROCESS | 1641 | 14:27:55 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20597.52 Median:23373.94 stddev:30176.26 (129.1%) stddev-sans-first:30223.95 14:27:55 INFO - PROCESS | 1641 | Values: 705.0 717.6 777.3 813.6 814.0 15111.4 15385.0 15770.0 15796.0 15802.5 14161.3 14172.7 14240.7 14268.5 14280.1 714.4 866.1 871.8 872.6 875.7 852.6 853.2 853.5 857.9 860.8 886.7 894.5 925.1 928.2 929.3 885.6 886.8 915.0 918.1 918.2 694.0 694.3 694.5 696.6 697.1 12478.8 12648.3 12737.6 12892.1 13661.5 11795.8 11897.0 11994.5 12017.6 12162.5 10721.7 10809.8 10818.8 10842.4 10849.2 3587.5 3685.6 3748.6 3770.9 3823.4 71880.0 76444.0 102985.0 106515.5 107238.5 10669.7 10700.6 10815.1 10823.3 10922.8 20352.1 20421.4 20508.0 20622.6 20667.3 7510.2 7720.5 7909.0 8064.1 8158.5 4243.7 4293.7 4357.0 4441.3 4459.8 3353.3 3361.5 3426.3 3438.2 3463.8 669.7 682.2 683.5 709.8 716.8 620.5 639.2 669.6 670.1 672.9 8782.0 8931.6 8953.5 9085.2 9175.7 537.6 555.6 630.2 639.3 686.6 3890.6 4288.9 4299.4 4573.2 4590.9 84671.0 95878.0 96386.0 96972.0 101973.5 69727.7 99948.5 104388.0 104393.0 108139.9 68509.0 91104.0 92710.0 94620.5 97539.0 9220.8 9695.2 9753.5 9926.0 9960.9 33931.8 42459.0 55744.4 56142.7 58622.4 68719.0 83803.9 85542.0 86419.1 86768.0 12456.5 12474.9 12745.9 13053.4 13175.3 14386.9 14388.4 14637.9 15143.9 15485.8 13030.0 13039.5 13726.4 13790.9 13835.5 11397.3 13135.6 13932.3 13986.0 14162.4 10717.6 12853.7 12934.8 13113.1 13394.7 10799.9 10872.5 11031.9 11596.2 11960.2 10826.7 11100.8 11213.2 11264.6 11297.5 14:27:55 INFO - PROCESS | 1641 | -------- Summary: end -------- 14:27:55 INFO - PROCESS | 1641 | 14:27:56 INFO - TEST-INFO | 1641: exit 0 14:27:56 INFO - TEST-OK | dromaeo_css | took 1113771ms 14:27:56 INFO - TEST-START | kraken 14:27:56 INFO - operating with platform_type : mac_ 14:27:56 INFO - Initialising browser for kraken test... 14:27:56 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpJNXygN/profile http://localhost:49242/getInfo.html) 14:27:59 INFO - PROCESS | 1653 | 2017-02-15 14:27:59.209 plugin-container[1655:9874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8747, name = 'com.apple.tsm.portname' 14:27:59 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:27:59 INFO - PROCESS | 1653 | 2017-02-15 14:27:59.209 plugin-container[1655:9874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8547, name = 'com.apple.CFPasteboardClient' 14:27:59 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:27:59 INFO - PROCESS | 1653 | 2017-02-15 14:27:59.209 plugin-container[1655:9874] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:27:59 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 14:27:59 INFO - PROCESS | 1653 | colorDepth:24 14:27:59 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 14:27:59 INFO - PROCESS | 1653 | __metrics 14:27:59 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:28:00 INFO - TEST-INFO | 1653: exit 0 14:28:00 INFO - Browser initialized. 14:28:00 INFO - Running cycle 1/1 for kraken test... 14:28:00 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpJNXygN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:02 INFO - PROCESS | 1656 | 2017-02-15 14:28:02.446 plugin-container[1657:9997] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 14:28:02 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:28:02 INFO - PROCESS | 1656 | 2017-02-15 14:28:02.446 plugin-container[1657:9997] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 14:28:02 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:28:02 INFO - PROCESS | 1656 | 2017-02-15 14:28:02.446 plugin-container[1657:9997] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:28:12 INFO - PROCESS | 1656 | RSS: Main: 177328128 14:28:12 INFO - PROCESS | 1656 | 14:28:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:16 INFO - PROCESS | 1656 | RSS: Main: 190181376 14:28:16 INFO - PROCESS | 1656 | 14:28:18 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 14:28:19 INFO - PROCESS | 1656 | RSS: Main: 198991872 14:28:19 INFO - PROCESS | 1656 | 14:28:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 14:28:23 INFO - PROCESS | 1656 | RSS: Main: 202174464 14:28:23 INFO - PROCESS | 1656 | 14:28:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 14:28:25 INFO - PROCESS | 1656 | RSS: Main: 203509760 14:28:25 INFO - PROCESS | 1656 | 14:28:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:28 INFO - PROCESS | 1656 | RSS: Main: 203554816 14:28:28 INFO - PROCESS | 1656 | 14:28:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:31 INFO - PROCESS | 1656 | RSS: Main: 207470592 14:28:31 INFO - PROCESS | 1656 | 14:28:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:35 INFO - PROCESS | 1656 | RSS: Main: 207626240 14:28:35 INFO - PROCESS | 1656 | 14:28:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 14:28:39 INFO - PROCESS | 1656 | RSS: Main: 206811136 14:28:39 INFO - PROCESS | 1656 | 14:28:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:41 INFO - PROCESS | 1656 | RSS: Main: 205959168 14:28:41 INFO - PROCESS | 1656 | 14:28:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:44 INFO - PROCESS | 1656 | RSS: Main: 206082048 14:28:44 INFO - PROCESS | 1656 | 14:28:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:46 INFO - PROCESS | 1656 | RSS: Main: 206065664 14:28:46 INFO - PROCESS | 1656 | 14:28:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:50 INFO - PROCESS | 1656 | RSS: Main: 206094336 14:28:50 INFO - PROCESS | 1656 | 14:28:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:53 INFO - PROCESS | 1656 | RSS: Main: 206471168 14:28:53 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 14:28:55 INFO - PROCESS | 1656 | RSS: Main: 207937536 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | __start_tp_report 14:28:55 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 14:28:55 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 14:28:55 INFO - PROCESS | 1656 | |i|pagename|runs| 14:28:55 INFO - PROCESS | 1656 | |0;ai-astar;106;118;165;173;95;164;171;172;95;169 14:28:55 INFO - PROCESS | 1656 | |1;audio-beat-detection;146;131;111;136;107;111;107;114;119;126 14:28:55 INFO - PROCESS | 1656 | |2;audio-dft;199;198;195;196;197;194;198;193;199;190 14:28:55 INFO - PROCESS | 1656 | |3;audio-fft;81;61;60;84;64;51;75;81;72;70 14:28:55 INFO - PROCESS | 1656 | |4;audio-oscillator;83;71;88;71;69;70;84;70;70;89 14:28:55 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;90;87;89;88;89;91;127;133;89;100 14:28:55 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;126;148;99;97;150;126;95;95;95 14:28:55 INFO - PROCESS | 1656 | |7;imaging-desaturate;121;89;106;132;89;117;79;99;71;124 14:28:55 INFO - PROCESS | 1656 | |8;json-parse-financial;56;55;54;58;61;80;89;86;47;48 14:28:55 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;65;72;82;73;64;63;68;69;68;69 14:28:55 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;82;83;84;81;84;82;86;84;85;82 14:28:55 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;136;137;149;139;152;160;167;161;208;153 14:28:55 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;205;164;161;163;166;162;164;166;161;166 14:28:55 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;69;67;65;67;65;67;66;72;64;65 14:28:55 INFO - PROCESS | 1656 | __end_tp_report 14:28:55 INFO - PROCESS | 1656 | __start_cc_report 14:28:55 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,908 14:28:55 INFO - PROCESS | 1656 | __end_cc_report 14:28:55 INFO - PROCESS | 1656 | __startTimestamp1487197735781__endTimestamp 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | ------- Summary: start ------- 14:28:55 INFO - PROCESS | 1656 | Number of tests: 14 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:142.80 Median:171.50 stddev:34.52 (20.1%) stddev-sans-first:33.95 14:28:55 INFO - PROCESS | 1656 | Values: 106.0 118.0 165.0 173.0 95.0 164.0 171.0 172.0 95.0 169.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:122.50 stddev:13.41 (11.0%) stddev-sans-first:10.69 14:28:55 INFO - PROCESS | 1656 | Values: 146.0 131.0 111.0 136.0 107.0 111.0 107.0 114.0 119.0 126.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:195.90 Median:197.50 stddev:2.92 (1.5%) stddev-sans-first:2.88 14:28:55 INFO - PROCESS | 1656 | Values: 199.0 198.0 195.0 196.0 197.0 194.0 198.0 193.0 199.0 190.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:69.90 Median:73.50 stddev:10.77 (14.7%) stddev-sans-first:10.65 14:28:55 INFO - PROCESS | 1656 | Values: 81.0 61.0 60.0 84.0 64.0 51.0 75.0 81.0 72.0 70.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.00 stddev:8.37 (10.9%) stddev-sans-first:8.54 14:28:55 INFO - PROCESS | 1656 | Values: 83.0 71.0 88.0 71.0 69.0 70.0 84.0 70.0 70.0 89.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:89.00 stddev:17.15 (19.3%) stddev-sans-first:17.92 14:28:55 INFO - PROCESS | 1656 | Values: 90.0 87.0 89.0 88.0 89.0 91.0 127.0 133.0 89.0 100.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:112.60 Median:95.00 stddev:22.80 (24.0%) stddev-sans-first:23.28 14:28:55 INFO - PROCESS | 1656 | Values: 95.0 126.0 148.0 99.0 97.0 150.0 126.0 95.0 95.0 95.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:102.70 Median:75.00 stddev:20.60 (27.5%) stddev-sans-first:20.75 14:28:55 INFO - PROCESS | 1656 | Values: 121.0 89.0 106.0 132.0 89.0 117.0 79.0 99.0 71.0 124.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:59.50 stddev:15.62 (26.3%) stddev-sans-first:16.34 14:28:55 INFO - PROCESS | 1656 | Values: 56.0 55.0 54.0 58.0 61.0 80.0 89.0 86.0 47.0 48.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:5.50 (8.0%) stddev-sans-first:5.61 14:28:55 INFO - PROCESS | 1656 | Values: 65.0 72.0 82.0 73.0 64.0 63.0 68.0 69.0 68.0 69.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.57 (1.9%) stddev-sans-first:1.59 14:28:55 INFO - PROCESS | 1656 | Values: 82.0 83.0 84.0 81.0 84.0 82.0 86.0 84.0 85.0 82.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:156.50 stddev:21.05 (13.5%) stddev-sans-first:21.02 14:28:55 INFO - PROCESS | 1656 | Values: 136.0 137.0 149.0 139.0 152.0 160.0 167.0 161.0 208.0 153.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:165.00 stddev:13.21 (8.0%) stddev-sans-first:2.06 14:28:55 INFO - PROCESS | 1656 | Values: 205.0 164.0 161.0 163.0 166.0 162.0 164.0 166.0 161.0 166.0 14:28:55 INFO - PROCESS | 1656 | 14:28:55 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.36 (3.5%) stddev-sans-first:2.35 14:28:55 INFO - PROCESS | 1656 | Values: 69.0 67.0 65.0 67.0 65.0 67.0 66.0 72.0 64.0 65.0 14:28:55 INFO - PROCESS | 1656 | -------- Summary: end -------- 14:28:55 INFO - PROCESS | 1656 | 14:28:56 INFO - TEST-INFO | 1656: exit 0 14:28:56 INFO - TEST-OK | kraken | took 60305ms 14:28:56 INFO - SUITE-END | took 1174s 14:28:56 INFO - Completed test suite (00:19:34) 14:28:56 INFO - javascript benchmark 14:28:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7251.85397491099, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3548.042028652264, 3563.590187128481, 3580.892573222801, 3583.2475180212164, 3585.336712708149, 5859.121131830222, 5935.347111817702, 5946.583739138262, 5958.285005799299, 6013.729382177801, 5938.0, 5993.160957465958, 5999.400059993998, 6005.969970150154, 6019.0, 4139.317012692917, 5184.403793563751, 5320.255164276995, 5400.189971504286, 5410.48600382963, 5455.454454554552, 5481.424450432707, 5499.670019798805, 5505.064139096363, 5507.614466987313, 4434.955650443502, 5309.814156504523, 5437.075697131478, 5490.945090549103, 5523.861903452425, 5382.703951282678, 5386.838394848141, 5419.943111093338, 5455.890882182373, 5525.502704756551, 5325.547328477084, 5421.915616876601, 5426.21319908615, 5445.346558412976, 5468.589855760833, 5260.00059988601, 5448.0, 5863.032599621058, 5953.1070339449, 5974.731137098841, 5931.673757943311, 6203.658798766066, 6204.317525072239, 6236.469900058501, 6254.812355629293, 6298.559100862942, 6302.1177035215105, 6322.304546499881, 6338.080978258173, 6385.074164246204, 6056.364081771439, 6065.878682426327, 6068.241469816273, 6077.453029227347, 6083.0, 6234.532410069263, 6269.937300627026, 6274.215723034621, 6295.96852015737, 6312.968435157794, 5244.370675518962, 6201.131841542187, 6277.7175027123885, 6284.811455656338, 6285.59143655661, 6254.186955695731, 6268.0, 6287.088372186099, 6293.181886354836, 6296.087067375205, 6141.731496609903, 6162.22972128484, 6168.444839964424, 6199.9770037943235, 6207.937920620826, 6217.580330818032, 6248.125262463259, 6254.9687251563455, 6256.280527739277, 6262.2172228471445, 5113.795448182105, 5114.616403769732, 5116.104681680766, 5120.92318615221, 5145.588352931756, 4470.754108523997, 4501.977490112594, 4513.796879140446, 4608.539146085364, 4635.559621835921, 4697.835575754901, 5985.581009329392, 6077.088436734437, 6106.755729770848, 6128.785492507741, 5201.687898726089, 6333.936660633427, 6345.555811093272, 6345.90481142774, 6368.840778980562, 5815.389384114692, 5862.794802181903, 5942.970285148546, 5988.4909782668965, 5999.100134979788, 5607.467290607386, 5624.493795558419, 5625.46558076982, 5634.971825140848, 5651.971740141273, 6495.772647957298, 6503.089567460559, 6504.284528701934, 6508.349165083643, 6510.21877374718, 6143.143438301211, 6197.504199664107, 6199.814005579839, 6214.658193799384, 6323.0, 6487.286398496256, 6495.0, 6520.869582608416, 6523.31505191967, 6529.640869752019, 6263.342349053284, 6271.278802937721, 6293.402126797947, 6308.747650093945, 6311.147995020613, 6191.628502289877, 6214.036824292242, 6226.470749986121, 6275.6862156892885, 6305.747770089145, 5430.321209848769, 5748.798792042258, 6212.161358216583, 6237.4698150657705, 6260.154879091447, 6230.532710046855, 6232.314445410911, 6237.002079667232, 6250.906236406367, 6268.028455589391, 6009.909851352146, 6052.061930400619, 6121.602095863755, 6155.384461553809, 6194.690265486617, 6159.5688301818445, 6173.104899789416, 6175.536834737323, 6229.657368844757, 6230.096635987847, 5154.0, 6147.139400484025, 6161.260648722182, 6168.444839964424, 6177.907331389943], "value": 5808.242355518699, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.6305271046714, 499.7101681025006, 513.1430511046552, 582.3477704970434, 602.7016626769749, 37908.05229869251, 40562.59437405625, 40569.59430405695, 40636.187276254495, 40697.982550436216, 42184.15631687372, 42994.570054299445, 43025.56974430255, 43083.35374969378, 43121.35317970233, 8914.955425222865, 9449.196818270455, 9502.097300756433, 9810.018998100204, 9857.260705447085, 9683.176929960962, 9715.659951901685, 9800.41197528147, 9806.411615303068, 9813.165880900133, 9721.951390243039, 9728.416295022322, 9803.264755143357, 9823.852642210373, 9872.60509579616, 9704.126628603424, 9745.853812192823, 9766.804663906752, 9820.459874706889, 9837.360571562825, 9576.377535460173, 9673.70978870635, 9687.467189304585, 9698.078682525149, 9701.757456063584, 39812.402813957815, 40195.39706904399, 40317.59682403168, 40418.39372409416, 40511.594884051075, 3167.319026409333, 3296.2583418730833, 3590.7127429805555, 3863.2273545290773, 4024.839006439739, 30285.394292114033, 31029.534556981664, 31303.37393252145, 31417.37165256705, 31795.205119871956, 3257.2833976525126, 3280.0815771583993, 3299.5215693724517, 3369.2082360645227, 3468.323676883009, 513246.0, 518561.0, 518866.0, 520479.3976030133, 521892.0, 62306.688466558284, 62668.05997910035, 62784.0, 62841.057384139276, 62862.057069144, 65125.67437162879, 65147.0, 65152.34847651463, 65406.01890971639, 65486.345136548975, 17091.401800936907, 17180.31278748836, 17260.482185534453, 17317.653646926992, 17358.65282694339, 13203.603891883258, 13231.801522977163, 13346.733065338638, 13348.199108053548, 13356.73286534264, 16957.067361295, 17410.564735881704, 17594.0, 17623.942563445977, 17670.0281484517, 5513.531349835229, 6283.183186185766, 6569.901451478232, 6581.473482121419, 6581.86836263272, 823.0288259853311, 893.6916763716507, 896.5114012863005, 918.5040078357746, 1028.2956175020136, 27389.589156162274, 27826.443471130868, 28748.0, 29274.121776346743, 29400.0, 952.618952419024, 1016.4765145949842, 1019.9439030853226, 1093.8906109388997, 1097.5280629329466, 14610.561683149523, 14827.332770025374, 14847.331870065873, 15079.0, 15098.39606415731, 146416.0, 179252.20747792616, 183617.0, 183626.0, 183868.0, 59563.702181488814, 60083.699581501816, 60402.0, 60450.79098418007, 60528.69735651294, 1230.6615680688062, 1391.6033930330009, 1393.9233342166076, 1423.3737155651481, 1423.871851533367, 28079.298017549725, 28640.997565085123, 28676.42647147087, 29210.56184157197, 29447.558286625288, 56644.0, 57769.0, 58387.70806145942, 61052.77894441997, 61590.076148856904, 498483.0, 577552.0, 579459.0, 579595.0, 581048.0, 26216.606750899133, 26421.73578264193, 26675.733242667324, 26761.732382675924, 26764.19707408781, 47403.525964739914, 47844.76077619589, 48037.75981120072, 48990.75504622597, 49192.0, 37904.810475947445, 39197.41203882001, 39292.60707393004, 39887.0, 40676.59323406728, 39131.0, 39687.60312396839, 40117.19765604613, 40390.15318161839, 40544.391834123104, 31691.2955667982, 31904.88332908337, 33455.66544334526, 36680.0, 38079.80960095182, 34460.65539344575, 35604.0, 35710.8214458926, 35724.64275357213, 35778.821105894305, 24604.0, 24839.254822355357, 24846.130385436423, 25167.496650067264, 25412.0], "value": 19376.8917303605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.80491546853375, 384.5723215024605, 386.530365605789, 391.75319548684314, 413.16128259632956, 19260.940648264357, 19903.601927961434, 20389.898050509746, 20458.897705511452, 20506.89746551267, 19007.714884276746, 19662.0, 19706.211751529958, 19773.209071637117, 19843.900780496115, 4938.407391113072, 5135.922961155586, 5414.91877621835, 5492.148716948879, 5566.137248726433, 5479.671219726809, 5488.396276409611, 5529.142982837667, 5557.305336832896, 5604.747786349603, 5517.889642207174, 5567.109262517998, 5802.854928626776, 5852.736626851781, 5930.406959304079, 5678.949394362056, 5762.049261871807, 5832.2418085649015, 5896.911546326808, 5929.762809487615, 5590.18942253375, 5639.605227634067, 5688.691600931809, 5724.8282551523525, 5728.140778883159, 13003.414846331843, 13086.672833179151, 13097.934510327388, 13160.60518184456, 13305.933470332586, 1745.973810392845, 2287.2109122352763, 2366.396568874943, 2509.034021901581, 2962.896298629538, 9972.0, 10010.399376037461, 10089.848652270222, 10267.948660256725, 10643.627473038407, 1723.3365154415515, 1814.8003719590965, 1925.4801203674929, 1936.663702045584, 1974.4076776966851, 124642.0, 128236.99999999907, 130227.0, 134526.32736836254, 135759.0, 9938.850917236246, 11840.171188016757, 12076.0, 12175.0, 12285.877141228651, 15072.54782356531, 15134.318955647022, 15150.621234469227, 15177.392904283926, 15187.240637968058, 7913.446058775946, 8519.446235994641, 8864.955675221583, 8971.372003959661, 8998.955005224932, 8925.152110549487, 8937.240334571505, 8960.05919378469, 9007.459552426875, 9079.636814527345, 4644.117617652635, 4699.95300047002, 4708.105459962596, 4718.4809670936165, 4742.715437073786, 1985.7914918933304, 2017.5258814178655, 2025.544252543166, 2032.24806821477, 2073.315805784118, 852.8336974289954, 884.9955750221336, 906.2568693671258, 907.020417948614, 928.8792456980684, 19894.403167904988, 19898.50253743668, 20870.165193392397, 20933.581328373653, 21175.57648847045, 820.2003047029218, 821.9383546234056, 889.4929889962659, 905.5019739143445, 955.3360414511848, 10286.588536458608, 10962.629671291088, 10993.34039957589, 11018.669439916815, 11034.282771619819, 605105.0, 615621.0, 628200.0, 629374.0, 630004.8499757564, 82840.58579707063, 83941.16058839456, 83975.580122099, 120996.3950180261, 126702.0, 974.5273542331963, 1018.3177271228295, 1034.2139973620103, 1034.6947650442987, 1036.580185025051, 18149.90925045419, 18339.174737137128, 18603.534911626775, 18866.811331886507, 19220.903895480435, 54176.64558386072, 59178.0, 59559.0, 59666.70166649139, 60134.19597412085, 82933.17066829254, 83309.0, 83658.0, 84701.0, 87509.0, 5867.471927526543, 7923.85104159882, 8182.0, 8316.708915187939, 8327.6668933242, 12450.128491005542, 12632.978723404578, 12750.0, 12926.418311176209, 12927.5475358362, 9855.605775768889, 10084.84872726895, 10369.0, 10399.48002599882, 10448.164146868081, 5124.282600435868, 8074.869518267565, 10495.527701253615, 10729.839052414063, 10753.408562528823, 8620.956895215484, 10038.799224015625, 10065.144462720751, 10135.442550659785, 10227.488625568543, 5901.498372638373, 7300.379467745089, 7318.34134927859, 7540.208278130717, 7734.99445072137, 10096.79806403853, 10203.0, 10352.171826254033, 10382.013708697661, 10542.947285263524], "value": 9245.002886783312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.6972605478907, 1548.4348212902291, 1752.553098959765, 1807.3854889337622, 1862.2550979608147, 7708.421868359867, 7931.881021784663, 8391.0, 8755.824883502326, 8782.780430489232, 8214.342852571795, 8495.235428811406, 8506.02180749214, 8601.354898382615, 8608.311335093193, 2341.9297421077354, 2377.6076947303673, 2391.330427480308, 2394.0663141374876, 2403.170906037414, 2391.6173412254043, 2400.135951057618, 2405.1341517053847, 2439.889850118192, 2441.377448750575, 2370.5021945391404, 2373.92878213653, 2389.880505974703, 2400.2679182849224, 2409.289259668402, 2348.424635964191, 2360.2683168217823, 2362.5274945011065, 2364.5152743687504, 2364.574376612209, 2088.592724418739, 2341.6955795746444, 2350.8354415190943, 2398.760123987587, 2407.3018824541036, 8518.020427650776, 8574.185452382013, 8612.569371531461, 8622.267107295887, 8640.481571105754, 5186.636935414523, 5351.518363347279, 5376.354837419495, 5376.462353764592, 5379.112446446332, 2917.5769513420646, 3477.3045390921666, 3611.494390785292, 3649.3613617617075, 3670.229251857113, 966.2801213096218, 1082.242430298786, 1083.737445875554, 1121.697141771717, 1129.7966366054106, 10960.177986651033, 11049.889501104966, 11123.610673626465, 11127.554897804079, 11133.443327833576, 4560.771961401917, 4667.346571479996, 4747.620190384761, 4757.666963312604, 4846.781894814671, 9729.513524323755, 9736.95131524338, 9746.658866939622, 9750.0, 9752.414855108716, 5295.364556253197, 5315.176147697113, 5324.574034077342, 5332.866678333073, 5342.210359529523, 4407.294832826732, 4446.444194475691, 4898.681585696918, 4924.8276310328965, 4976.751162441863, 3248.635573059321, 3521.436570148764, 3921.098147426108, 4037.051292946155, 4051.2707712612014, 1125.7298248420484, 1287.993560032194, 1304.9151805132826, 1308.718625495523, 1322.616441232032, 776.7436745873848, 820.306840719591, 832.8417600655856, 843.3927572148043, 852.5225873510853, 4613.538646135359, 5266.526012658879, 5313.707746073926, 5329.54698850602, 5581.3302403711, 855.5935930432995, 874.5059041641452, 913.2191975860676, 913.7578541686458, 913.9908600914039, 3237.963851567476, 3447.1209841490763, 3499.160201551609, 3550.3254381667402, 3595.964040359563, 9586.616535338648, 10318.535665895053, 10327.793444131226, 10370.948145259226, 10403.167746580255, 10197.082262596401, 10266.486675666187, 10273.845892311621, 10328.173746100294, 10330.431826249629, 7666.156722760492, 8155.469894456842, 8165.63254653542, 8166.591670416456, 8195.508269503849, 4802.0, 5249.2126181073145, 5283.181106928432, 5336.786528538815, 5466.699331536804, 9389.201917837061, 9569.712908612753, 9594.376365536218, 9664.710058697969, 9714.902850971683, 9462.952685236805, 9500.239980801382, 9691.709248722267, 9717.805643887225, 9854.556544955638, 6581.80254592363, 6774.729010839511, 6949.930500695131, 7055.118110236221, 7243.45674074436, 7932.56370899583, 8100.797480063045, 8115.513069215866, 8127.106018338096, 8138.267555919995, 7218.0, 7332.743353982585, 7382.6677799498075, 7421.3320801126, 7496.362809161283, 7155.069840920647, 7255.165655949422, 7264.309890560388, 7266.1280646322775, 7305.671244794104, 6523.543351965317, 6548.901766473602, 6552.24649165333, 6584.572002819801, 6633.336666333328, 4624.930626040679, 4636.698614590041, 4643.326717625993, 4720.079584481131, 4728.101660684459, 3656.2870240302886, 4391.780410979502, 4693.882652933704, 4758.928616070831, 4801.063792560417], "value": 4445.119683258542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.649821477616, 309.90911989795916, 319.99200019999495, 325.56374458225974, 326.5933912279213, 4594.0, 4686.968866849292, 5112.872178195547, 5697.259356283683, 5707.229524014257, 4839.370881785372, 5472.0, 5540.750666220019, 5570.86072848179, 5598.580106492009, 3484.61669216386, 3553.769005014679, 3650.7444478886487, 4213.567387088389, 4243.915121697564, 3694.4827724118645, 3703.777773333595, 3728.459373390857, 4234.9364759528635, 4315.180115777992, 4047.170330082326, 4271.63691086258, 4278.871633850989, 4278.957210427902, 4287.849925252617, 3310.4372256716415, 3457.579694214035, 3846.519185101862, 3865.207632435344, 4289.785510724467, 3595.8741444049333, 3599.208174201671, 3604.4052731299303, 3605.0712868615165, 3617.3488772021024, 4765.28520721891, 4773.737444440554, 4977.701337919736, 5485.0, 5499.945000549983, 3818.59904710007, 4487.461504619434, 4591.793369298356, 4818.518148185189, 4823.083614113342, 5680.608250978496, 5839.649621022752, 5861.736221870026, 5902.911456328158, 5905.468507834273, 3184.5700830388064, 3823.9617603823885, 3961.4946320398353, 3987.7806720630356, 3997.920041599152, 5632.3804381518, 5918.852028699274, 6004.729787159545, 6213.285472170713, 6228.346023667495, 3972.411035585789, 4015.5382131055303, 4028.4964379452567, 4045.2718510667773, 4061.9796901015307, 3930.3121953657997, 3945.4870866787132, 4102.021039591651, 4117.949922769734, 4135.793210339471, 3687.870924517629, 4738.062401311209, 4821.493743156918, 4833.830815921426, 4834.903301933941, 4890.437599676083, 5615.5507559395965, 5669.343273588513, 5975.40245975399, 5999.700014999233, 1319.4194554396036, 1337.9264140472173, 1340.2025794652166, 1350.980010092374, 1360.3538319298452, 757.7802437293234, 848.2747251100344, 896.6682327538853, 904.9411788233743, 912.7763697894059, 4826.95173048265, 4971.875703107379, 5314.893702125936, 5628.380878103405, 5662.68855212959, 6139.4781443577795, 6141.170941922784, 6141.539384546177, 6176.536759743038, 6184.443400094013, 4839.636452665363, 5517.227588137664, 5566.582506312043, 5573.331200255995, 5644.266245388073, 2638.8416694998364, 3031.7119873611973, 3054.801437906529, 3067.2178594458715, 3096.4362996686527, 5124.9743751281, 5968.880622387528, 5980.385295970151, 6101.3459145271945, 6154.307415550634, 5651.886962260814, 5911.645301281937, 6422.935770642327, 6442.680634971406, 6444.355564443518, 5603.495685388416, 6009.459148676553, 6328.778492752732, 6402.551821372553, 6457.773977910751, 5021.84934451967, 5320.882614650966, 5750.396208398058, 6192.473639740672, 6242.563020588515, 5395.030813752874, 6152.815415537541, 6165.167702360303, 6213.316535181217, 6217.533684973736, 5888.0, 6079.422454866781, 6208.161898143873, 6431.228252609717, 6467.773627923, 3281.0320955318716, 3753.099256178552, 3962.9498182980956, 4064.7967601620394, 4067.0, 6141.109539116893, 6151.108089327112, 6161.7843375483435, 6215.782447614311, 6231.9688401557705, 5833.300003999547, 5946.851328716817, 5994.67029313392, 6006.639601623741, 6055.5458340623745, 5238.5547228486, 5697.834822767322, 5941.881162376641, 5976.073708575004, 6000.639961602318, 4908.656394052382, 5885.646861188342, 5899.852503687443, 5927.673977931255, 5937.317208520903, 5167.6641018333685, 5250.632455728062, 5875.383084776037, 5910.261217347832, 5937.9406205937385, 5095.898082038412, 5469.589780766379, 5810.970945145247, 5824.213731146241, 5834.766609335579], "value": 4247.930211339589, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.0481849503175, 717.5802155738893, 777.3392616276166, 813.6257321632049, 813.9552324622147, 15111.395544178233, 15385.0, 15770.0, 15796.0, 15802.525924222264, 14161.29193540324, 14172.71654566908, 14240.71518569628, 14268.500602478915, 14280.143191408522, 714.3713532091765, 866.0516734176067, 871.8038441350709, 872.5593575244493, 875.6935072724559, 852.5566705313233, 853.1937319233327, 853.4964371021097, 857.9056303806608, 860.7589874835056, 886.7118186589352, 894.5214310343968, 925.1072714830187, 928.2295694573521, 929.2705226397279, 885.6014793342957, 886.7960369115108, 914.9889372243641, 918.1002617434917, 918.17823048372, 693.9653017349112, 694.3160986428364, 694.5173104692241, 696.6273043921528, 697.1459961547064, 12478.81281780774, 12648.304343261118, 12737.617871463872, 12892.097553171281, 13661.453541858315, 11795.823062654066, 11897.0, 11994.520219191221, 12017.579384721581, 12162.452689628988, 10721.678349649523, 10809.78380432387, 10818.783624327469, 10842.403667798268, 10849.186311026626, 3587.4798154267746, 3685.6130106338715, 3748.6251374862295, 3770.9057273568105, 3823.388257878726, 71880.0, 76444.0, 102985.0, 106515.46742266239, 107238.46380768124, 10669.689035827838, 10700.625478108228, 10815.080718138888, 10823.29648572856, 10922.781544369069, 20352.084156213004, 20421.387358379274, 20508.0, 20622.58754824895, 20667.27664531764, 7510.211427800112, 7720.53676779395, 7909.0, 8064.072631647436, 8158.469699469515, 4243.7029407941145, 4293.6715924150485, 4356.978215108904, 4441.267190913528, 4459.754713490789, 3353.2622822978906, 3361.4957756336744, 3426.331865286295, 3438.2263990601914, 3463.8094904779973, 669.718718138383, 682.205230905989, 683.4737252315689, 709.8331892005375, 716.8458781362032, 620.4849974521137, 639.2233436374734, 669.6317025635881, 670.1020632352671, 672.922613899398, 8781.956090219635, 8931.598078086501, 8953.507557084424, 9085.227755640844, 9175.724728258163, 537.6182910133771, 555.6194007105146, 630.2061589232793, 639.3414782773658, 686.5503095472474, 3890.5525864525375, 4288.871333859989, 4299.401731854949, 4573.245414506636, 4590.88522786933, 84671.0, 95878.0, 96386.0, 96972.0, 101973.49013254886, 69727.65136174287, 99948.5002574997, 104387.95612043783, 104393.0, 108139.91860081299, 68509.0, 91104.0, 92710.0, 94620.52689736507, 97539.0, 9220.815583688423, 9695.175910047443, 9753.51232438361, 9926.0, 9960.850587241051, 33931.83034084814, 42459.0, 55744.44255557392, 56142.719286403306, 58622.41377586169, 68719.0, 83803.86034347185, 85542.0, 86419.1358086411, 86768.0, 12456.501739930301, 12474.937625311815, 12745.872541274468, 13053.412596432994, 13175.2753598553, 14386.928065359607, 14388.424463021362, 14637.88377056609, 15143.924280378527, 15485.84514154844, 13030.0, 13039.543615973396, 13726.382312796148, 13790.862091378958, 13835.515756948862, 11397.30773826101, 13135.605931822061, 13932.30338483092, 13986.0, 14162.433502659778, 10717.648341410817, 12853.678658033625, 12934.805977910151, 13113.08208425401, 13394.665133371744, 10799.946000269949, 10872.456377181268, 11031.889681103086, 11596.188266821242, 11960.162788604714, 10826.729331766768, 11100.833487497855, 11213.215074944676, 11264.60573879943, 11297.548098076313], "value": 7402.086268851634, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 165.0, 173.0, 95.0, 164.0, 171.0, 172.0, 95.0, 169.0], "value": 142.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 131.0, 111.0, 136.0, 107.0, 111.0, 107.0, 114.0, 119.0, 126.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 198.0, 195.0, 196.0, 197.0, 194.0, 198.0, 193.0, 199.0, 190.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 60.0, 84.0, 64.0, 51.0, 75.0, 81.0, 72.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 88.0, 71.0, 69.0, 70.0, 84.0, 70.0, 70.0, 89.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 88.0, 89.0, 91.0, 127.0, 133.0, 89.0, 100.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 126.0, 148.0, 99.0, 97.0, 150.0, 126.0, 95.0, 95.0, 95.0], "value": 112.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 89.0, 106.0, 132.0, 89.0, 117.0, 79.0, 99.0, 71.0, 124.0], "value": 102.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 58.0, 61.0, 80.0, 89.0, 86.0, 47.0, 48.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 82.0, 73.0, 64.0, 63.0, 68.0, 69.0, 68.0, 69.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 81.0, 84.0, 82.0, 86.0, 84.0, 85.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 149.0, 139.0, 152.0, 160.0, 167.0, 161.0, 208.0, 153.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 164.0, 161.0, 163.0, 166.0, 162.0, 164.0, 166.0, 161.0, 166.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 67.0, 65.0, 67.0, 66.0, 72.0, 64.0, 65.0], "value": 66.7, "unit": "score"}]}]} 14:28:57 INFO - Return code: 0 14:28:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:28:57 ERROR - # TBPL SUCCESS # 14:28:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:28:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:28:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:28:57 INFO - 2017-02-15 14:28:57.116 screenresolution[1661:10386] starting screenresolution argv=screenresolution get 14:28:57 INFO - 2017-02-15 14:28:57.119 screenresolution[1661:10386] Display 0: 1600x1200x32@60 14:28:57 INFO - 2017-02-15 14:28:57.126 screenresolution[1662:10389] starting screenresolution argv=screenresolution list 14:28:57 INFO - Available Modes on Display 0 14:28:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:28:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:28:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:28:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:28:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:28:57 INFO - Intel Iris: 14:28:57 INFO - Chipset Model: Intel Iris 14:28:57 INFO - Type: GPU 14:28:57 INFO - Bus: Built-In 14:28:57 INFO - VRAM (Dynamic, Max): 1536 MB 14:28:57 INFO - Vendor: Intel (0x8086) 14:28:57 INFO - Device ID: 0x0a2e 14:28:57 INFO - Revision ID: 0x0009 14:28:57 INFO - Displays: 14:28:57 INFO - Display: 14:28:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:28:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:28:57 INFO - Display Serial Number: 1600x1200 60 14:28:57 INFO - Main Display: Yes 14:28:57 INFO - Mirror: Off 14:28:57 INFO - Online: Yes 14:28:57 INFO - Rotation: Supported 14:28:57 INFO - Return code: 0 14:28:57 INFO - Running post-action listener: _resource_record_post_action 14:28:57 INFO - [mozharness: 2017-02-15 22:28:57.363209Z] Finished run-tests step (success) 14:28:57 INFO - Running post-run listener: _resource_record_post_run 14:28:57 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 44754944; Write bytes: 506528768; Read time: 392; Write time: 1620 14:28:57 INFO - TinderboxPrint: CPU usage
54.1% 14:28:57 INFO - TinderboxPrint: I/O read bytes / time
44,754,944 / 392 14:28:57 INFO - TinderboxPrint: I/O write bytes / time
506,528,768 / 1,620 14:28:57 INFO - TinderboxPrint: CPU idle
2,197.3 (45.9%) 14:28:57 INFO - TinderboxPrint: CPU system
966.2 (20.2%) 14:28:57 INFO - TinderboxPrint: CPU user
1,622.1 (33.9%) 14:28:57 INFO - TinderboxPrint: Swap in / out
236,494,848 / 0 14:28:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185635328; Write bytes: 181917696; Read time: 16919; Write time: 414 14:28:57 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 42960896; Write bytes: 309156864; Read time: 377; Write time: 1159 14:28:57 INFO - Running post-run listener: _upload_blobber_files 14:28:57 INFO - Blob upload gear active. 14:28:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:28:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:59 INFO - (blobuploader) - INFO - Done attempting. 14:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:00 INFO - (blobuploader) - INFO - Done attempting. 14:29:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:02 INFO - (blobuploader) - INFO - Done attempting. 14:29:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:02 INFO - Return code: 0 14:29:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28271cfa96a086e0e54c8f0ebec276a1fc76ef43da5acf734ecfa37d7bd03f516700c23d67cfaf7203208d82c41b73c268f07fbb5a2aa2739cb59733966278e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee3a1394468b83548bbd4b6bfc13647be1d2529a6bfe5f2c5905f57d470d01e2b966ea68fd97e73a1a5411a9b5b188ce75659286f077c3673136ebc97bdb34da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e654897fcf603d4e5fc24a99e7fee804ec235a67add0e71f3e228944454a46c61f5a4a76a253904eabb01943513402359898e7664a63d0509c68b5ed469b202f"} 14:29:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:02 INFO - Contents: 14:29:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28271cfa96a086e0e54c8f0ebec276a1fc76ef43da5acf734ecfa37d7bd03f516700c23d67cfaf7203208d82c41b73c268f07fbb5a2aa2739cb59733966278e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee3a1394468b83548bbd4b6bfc13647be1d2529a6bfe5f2c5905f57d470d01e2b966ea68fd97e73a1a5411a9b5b188ce75659286f077c3673136ebc97bdb34da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e654897fcf603d4e5fc24a99e7fee804ec235a67add0e71f3e228944454a46c61f5a4a76a253904eabb01943513402359898e7664a63d0509c68b5ed469b202f"} 14:29:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:02 INFO - Copying logs to upload dir... 14:29:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.086431 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-15 14:29:02.928863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 14:29:02.932399) ========= 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.0G1Rh4H49x/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.rjyrwn7ood/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28271cfa96a086e0e54c8f0ebec276a1fc76ef43da5acf734ecfa37d7bd03f516700c23d67cfaf7203208d82c41b73c268f07fbb5a2aa2739cb59733966278e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee3a1394468b83548bbd4b6bfc13647be1d2529a6bfe5f2c5905f57d470d01e2b966ea68fd97e73a1a5411a9b5b188ce75659286f077c3673136ebc97bdb34da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e654897fcf603d4e5fc24a99e7fee804ec235a67add0e71f3e228944454a46c61f5a4a76a253904eabb01943513402359898e7664a63d0509c68b5ed469b202f"} build_url:https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/GD0kyKWQSnGZVLpzCjY4Kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28271cfa96a086e0e54c8f0ebec276a1fc76ef43da5acf734ecfa37d7bd03f516700c23d67cfaf7203208d82c41b73c268f07fbb5a2aa2739cb59733966278e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee3a1394468b83548bbd4b6bfc13647be1d2529a6bfe5f2c5905f57d470d01e2b966ea68fd97e73a1a5411a9b5b188ce75659286f077c3673136ebc97bdb34da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e654897fcf603d4e5fc24a99e7fee804ec235a67add0e71f3e228944454a46c61f5a4a76a253904eabb01943513402359898e7664a63d0509c68b5ed469b202f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 14:29:02.971271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:29:02.971633) ========= 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.0G1Rh4H49x/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.rjyrwn7ood/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 14:29:03.021196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 14:29:03.021555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 14:29:03.021952) ========= ========= Total master_lag: 1.53 =========