builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0264 starttime: 1484605944.9 results: success (0) buildid: 20170116131921 builduid: f7b025b2748a45a7abf124da4142242e revision: 88030580b14bb253a55bc174c987a9fa43c3fb55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:24.899305) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:24.899691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:24.899990) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:24.929756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:24.930084) ========= 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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-01-16 14:32:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 197M=0s 2017-01-16 14:32:25 (197 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120722 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:25.077867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:25.078185) ========= 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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.023903 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:25.126186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 14:32:25.126502) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 88030580b14bb253a55bc174c987a9fa43c3fb55 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 88030580b14bb253a55bc174c987a9fa43c3fb55 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BQyqU62juQ/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.lyJUKAwuNZ/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-01-16 14:32:25,227 truncating revision to first 12 chars 2017-01-16 14:32:25,227 Setting DEBUG logging. 2017-01-16 14:32:25,227 attempt 1/10 2017-01-16 14:32:25,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/88030580b14b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 14:32:26,727 unpacking tar archive at: mozilla-central-88030580b14b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.774164 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 14:32:26.930120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:26.930446) ========= script_repo_revision: 88030580b14bb253a55bc174c987a9fa43c3fb55 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:26.930848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:26.931160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:32:26.951371) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-16 14:32:26.951771) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BQyqU62juQ/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.lyJUKAwuNZ/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:32:27 INFO - MultiFileLogger online at 20170116 14:32:27 in /builds/slave/test 14:32:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:32:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:27 INFO - {'append_to_log': False, 14:32:27 INFO - 'base_work_dir': '/builds/slave/test', 14:32:27 INFO - 'blob_upload_branch': 'Firefox', 14:32:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:27 INFO - 'branch': 'Firefox', 14:32:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:27 INFO - 'config_files': ('talos/mac_config.py',), 14:32:27 INFO - 'default_actions': ('clobber', 14:32:27 INFO - 'read-buildbot-config', 14:32:27 INFO - 'download-and-extract', 14:32:27 INFO - 'populate-webroot', 14:32:27 INFO - 'create-virtualenv', 14:32:27 INFO - 'install', 14:32:27 INFO - 'run-tests'), 14:32:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:27 INFO - 'download_minidump_stackwalk': True, 14:32:27 INFO - 'download_symbols': 'ondemand', 14:32:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:27 INFO - 'installer_path': 'installer.exe', 14:32:27 INFO - 'log_level': 'info', 14:32:27 INFO - 'log_name': 'talos', 14:32:27 INFO - 'log_to_console': True, 14:32:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:27 INFO - 'opt_config_files': (), 14:32:27 INFO - 'pip_index': False, 14:32:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:27 INFO - 'cmd': ('bash', 14:32:27 INFO - '-c', 14:32:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:27 INFO - 'enabled': True, 14:32:27 INFO - 'halt_on_failure': False, 14:32:27 INFO - 'name': 'check_screen_resolution'},), 14:32:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:27 INFO - 'cmd': ('bash', 14:32:27 INFO - '-c', 14:32:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:27 INFO - 'enabled': True, 14:32:27 INFO - 'halt_on_failure': False, 14:32:27 INFO - 'name': 'check_screen_resolution'},), 14:32:27 INFO - 'run_cmd_checks_enabled': True, 14:32:27 INFO - 'sps_profile': False, 14:32:27 INFO - 'sps_profile_interval': 0, 14:32:27 INFO - 'suite': 'dromaeojs-e10s', 14:32:27 INFO - 'system_bits': '32', 14:32:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:27 INFO - 'title': 't-yosemite-r7-0264', 14:32:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:27 INFO - 'use_talos_json': True, 14:32:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:27 INFO - 'work_dir': 'build'} 14:32:27 INFO - [mozharness: 2017-01-16 22:32:27.155621Z] Running clobber step. 14:32:27 INFO - Running pre-action listener: _resource_record_pre_action 14:32:27 INFO - Running main action method: clobber 14:32:27 INFO - rmtree: /builds/slave/test/build 14:32:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:29 INFO - Running post-action listener: _resource_record_post_action 14:32:29 INFO - [mozharness: 2017-01-16 22:32:29.639491Z] Finished clobber step (success) 14:32:29 INFO - [mozharness: 2017-01-16 22:32:29.639625Z] Running read-buildbot-config step. 14:32:29 INFO - Running pre-action listener: _resource_record_pre_action 14:32:29 INFO - Running main action method: read_buildbot_config 14:32:29 INFO - Using buildbot properties: 14:32:29 INFO - { 14:32:29 INFO - "project": "", 14:32:29 INFO - "product": "firefox", 14:32:29 INFO - "script_repo_revision": "production", 14:32:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:32:29 INFO - "repository": "", 14:32:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:32:29 INFO - "buildid": "20170116131921", 14:32:29 INFO - "pgo_build": "False", 14:32:29 INFO - "basedir": "/builds/slave/test", 14:32:29 INFO - "buildnumber": 15, 14:32:29 INFO - "slavename": "t-yosemite-r7-0264", 14:32:29 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:32:29 INFO - "platform": "yosemite_r7", 14:32:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:32:29 INFO - "branch": "mozilla-central", 14:32:29 INFO - "repo_path": "mozilla-central", 14:32:29 INFO - "revision": "88030580b14bb253a55bc174c987a9fa43c3fb55", 14:32:29 INFO - "stage_platform": "macosx64", 14:32:29 INFO - "builduid": "f7b025b2748a45a7abf124da4142242e", 14:32:29 INFO - "slavebuilddir": "test" 14:32:29 INFO - } 14:32:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:32:29 INFO - Running post-action listener: _resource_record_post_action 14:32:29 INFO - [mozharness: 2017-01-16 22:32:29.642979Z] Finished read-buildbot-config step (success) 14:32:29 INFO - [mozharness: 2017-01-16 22:32:29.643078Z] Running download-and-extract step. 14:32:29 INFO - Running pre-action listener: _resource_record_pre_action 14:32:29 INFO - Running main action method: download_and_extract 14:32:29 INFO - mkdir: /builds/slave/test/build/tests 14:32:29 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:32:29 INFO - trying https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:32:29 INFO - Downloading https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:32:30 INFO - Downloaded 1199 bytes. 14:32:30 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:32:30 INFO - Using the following test package requirements: 14:32:30 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:32:30 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:32:30 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:32:30 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'jsshell-mac.zip'], 14:32:30 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:32:30 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:32:30 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:32:30 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:32:30 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:32:30 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:32:30 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:32:30 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:32:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:32:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:30 INFO - Fetch https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:32:31 INFO - Expected file size: 16326595 14:32:31 INFO - Obtained file size: 16326595 14:32:37 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:32:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:32:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:37 INFO - Fetch https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:32:38 INFO - Expected file size: 16326595 14:32:38 INFO - Obtained file size: 16326595 14:32:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:32:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:32:44 INFO - Fetch https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:32:45 INFO - Expected file size: 14403463 14:32:45 INFO - Obtained file size: 14403463 14:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:46 INFO - trying https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:32:48 INFO - Downloaded 70186189 bytes. 14:32:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:32:48 INFO - mkdir: /builds/slave/test/properties 14:32:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:48 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:48 INFO - Contents: 14:32:48 INFO - build_url:https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:32:49 INFO - Running post-action listener: _resource_record_post_action 14:32:49 INFO - Running post-action listener: set_extra_try_arguments 14:32:49 INFO - [mozharness: 2017-01-16 22:32:49.164836Z] Finished download-and-extract step (success) 14:32:49 INFO - [mozharness: 2017-01-16 22:32:49.164990Z] Running populate-webroot step. 14:32:49 INFO - Running pre-action listener: _resource_record_pre_action 14:32:49 INFO - Running main action method: populate_webroot 14:32:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:49 INFO - '--tppagecycles', 14:32:49 INFO - '7'], 14:32:49 INFO - 'tests': ['tsvgm']}}, 14:32:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:32:49 INFO - 'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:32:49 INFO - 'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['damp', 'tps']}, 14:32:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:32:49 INFO - 'tests': ['damp', 'tps']}, 14:32:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['dromaeo_dom']}, 14:32:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['basic_compositor_video']}, 14:32:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:32:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['a11yr', 14:32:49 INFO - 'ts_paint', 14:32:49 INFO - 'tpaint', 14:32:49 INFO - 'sessionrestore', 14:32:49 INFO - 'sessionrestore_no_auto_restore', 14:32:49 INFO - 'tabpaint']}, 14:32:49 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:49 INFO - 'ts_paint', 14:32:49 INFO - 'tpaint', 14:32:49 INFO - 'sessionrestore', 14:32:49 INFO - 'sessionrestore_no_auto_restore', 14:32:49 INFO - 'tabpaint']}, 14:32:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:49 INFO - 'ts_paint', 14:32:49 INFO - 'tpaint', 14:32:49 INFO - 'sessionrestore', 14:32:49 INFO - 'sessionrestore_no_auto_restore', 14:32:49 INFO - 'tabpaint']}, 14:32:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:49 INFO - 'ts_paint', 14:32:49 INFO - 'tpaint', 14:32:49 INFO - 'sessionrestore', 14:32:49 INFO - 'sessionrestore_no_auto_restore', 14:32:49 INFO - 'tabpaint']}, 14:32:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['a11yr', 14:32:49 INFO - 'ts_paint', 14:32:49 INFO - 'tpaint', 14:32:49 INFO - 'sessionrestore', 14:32:49 INFO - 'sessionrestore_no_auto_restore', 14:32:49 INFO - 'tabpaint']}, 14:32:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['a11yr', 14:32:49 INFO - 'ts_paint', 14:32:49 INFO - 'tpaint', 14:32:49 INFO - 'sessionrestore', 14:32:49 INFO - 'sessionrestore_no_auto_restore', 14:32:49 INFO - 'tabpaint']}, 14:32:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['tsvgx', 14:32:49 INFO - 'tsvgr_opacity', 14:32:49 INFO - 'tart', 14:32:49 INFO - 'tscrollx', 14:32:49 INFO - 'cart', 14:32:49 INFO - 'tsvg_static']}, 14:32:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:49 INFO - 'tsvgr_opacity', 14:32:49 INFO - 'tart', 14:32:49 INFO - 'tscrollx', 14:32:49 INFO - 'cart', 14:32:49 INFO - 'tsvg_static']}, 14:32:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:32:49 INFO - 'talos_options': ['--disable-e10s'], 14:32:49 INFO - 'tests': ['tp5o']}, 14:32:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:32:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:32:49 INFO - 'talos_options': ['--disable-e10s', 14:32:49 INFO - '--xperf_path', 14:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:49 INFO - 'tests': ['tp5n']}, 14:32:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:32:49 INFO - 'talos_options': ['--xperf_path', 14:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:49 INFO - 'tests': ['tp5n']}}, 14:32:49 INFO - 'talos.zip': {'path': '', 14:32:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:49 INFO - Running post-action listener: _resource_record_post_action 14:32:49 INFO - [mozharness: 2017-01-16 22:32:49.183344Z] Finished populate-webroot step (success) 14:32:49 INFO - [mozharness: 2017-01-16 22:32:49.183480Z] Running create-virtualenv step. 14:32:49 INFO - Running pre-action listener: _resource_record_pre_action 14:32:49 INFO - Running main action method: create_virtualenv 14:32:49 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:49 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:32:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:49 INFO - Using real prefix '/tools/python27' 14:32:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:50 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:52 INFO - Installing pip.................done. 14:32:52 INFO - Return code: 0 14:32:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:32:53 INFO - Reading from file tmpfile_stdout 14:32:53 INFO - Output received: 14:32:53 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:32:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32: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:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:53 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:32:53 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:32:53 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:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:53 INFO - 'HOME': '/Users/cltbld', 14:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:53 INFO - 'LOGNAME': 'cltbld', 14:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:53 INFO - 'MOZ_NO_REMOTE': '1', 14:32:53 INFO - 'NO_EM_RESTART': '1', 14:32:53 INFO - 'PAGER': '/bin/cat', 14:32:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:53 INFO - 'PWD': '/builds/slave/test', 14:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:53 INFO - 'SHELL': '/bin/bash', 14:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:32:53 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:53 INFO - 'USER': 'cltbld', 14:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:53 INFO - 'XPC_FLAGS': '0x0', 14:32:53 INFO - 'XPC_SERVICE_NAME': '0', 14:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:53 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:32:53 INFO - Cleaning up... 14:32:53 INFO - Return code: 0 14:32:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32: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:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:53 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:32:53 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:32:53 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:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:53 INFO - 'HOME': '/Users/cltbld', 14:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:53 INFO - 'LOGNAME': 'cltbld', 14:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:53 INFO - 'MOZ_NO_REMOTE': '1', 14:32:53 INFO - 'NO_EM_RESTART': '1', 14:32:53 INFO - 'PAGER': '/bin/cat', 14:32:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:53 INFO - 'PWD': '/builds/slave/test', 14:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:53 INFO - 'SHELL': '/bin/bash', 14:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:32:53 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:53 INFO - 'USER': 'cltbld', 14:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:53 INFO - 'XPC_FLAGS': '0x0', 14:32:53 INFO - 'XPC_SERVICE_NAME': '0', 14:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:53 INFO - Downloading/unpacking psutil>=3.1.1 14:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:53 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:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:57 INFO - Installing collected packages: psutil 14:32:57 INFO - Running setup.py install for psutil 14:32:57 INFO - building 'psutil._psutil_osx' extension 14:32:57 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:32:57 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:32:57 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:32:57 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:32:57 INFO - building 'psutil._psutil_posix' extension 14:32:57 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:32:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:32:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:32:58 INFO - ^ 14:32:58 INFO - 1 warning generated. 14:32:58 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:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:58 INFO - Successfully installed psutil 14:32:58 INFO - Cleaning up... 14:32:58 INFO - Return code: 0 14:32:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:32: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:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:58 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:32:58 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:32:58 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:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:58 INFO - 'HOME': '/Users/cltbld', 14:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:58 INFO - 'LOGNAME': 'cltbld', 14:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:58 INFO - 'MOZ_NO_REMOTE': '1', 14:32:58 INFO - 'NO_EM_RESTART': '1', 14:32:58 INFO - 'PAGER': '/bin/cat', 14:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:58 INFO - 'PWD': '/builds/slave/test', 14:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:58 INFO - 'SHELL': '/bin/bash', 14:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:32:58 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:58 INFO - 'USER': 'cltbld', 14:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:58 INFO - 'XPC_FLAGS': '0x0', 14:32:58 INFO - 'XPC_SERVICE_NAME': '0', 14:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:33:01 INFO - Installing collected packages: mozsystemmonitor 14:33:01 INFO - Running setup.py install for mozsystemmonitor 14:33:01 INFO - Successfully installed mozsystemmonitor 14:33:01 INFO - Cleaning up... 14:33:01 INFO - Return code: 0 14:33:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:01 INFO - 'HOME': '/Users/cltbld', 14:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:01 INFO - 'LOGNAME': 'cltbld', 14:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:01 INFO - 'MOZ_NO_REMOTE': '1', 14:33:01 INFO - 'NO_EM_RESTART': '1', 14:33:01 INFO - 'PAGER': '/bin/cat', 14:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:01 INFO - 'PWD': '/builds/slave/test', 14:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:01 INFO - 'SHELL': '/bin/bash', 14:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:01 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:01 INFO - 'USER': 'cltbld', 14:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:01 INFO - 'XPC_FLAGS': '0x0', 14:33:01 INFO - 'XPC_SERVICE_NAME': '0', 14:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:01 INFO - Downloading/unpacking jsonschema==2.5.1 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:33:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:33:04 INFO - warning: no files found matching '*.txt' 14:33:04 INFO - no previously-included directories found matching 'build' 14:33:04 INFO - no previously-included directories found matching 'dist' 14:33:04 INFO - no previously-included directories found matching '.git*' 14:33:04 INFO - Installing collected packages: jsonschema, functools32 14:33:04 INFO - Running setup.py install for functools32 14:33:05 INFO - warning: no files found matching '*.txt' 14:33:05 INFO - no previously-included directories found matching 'build' 14:33:05 INFO - no previously-included directories found matching 'dist' 14:33:05 INFO - no previously-included directories found matching '.git*' 14:33:05 INFO - Successfully installed jsonschema functools32 14:33:05 INFO - Cleaning up... 14:33:05 INFO - Return code: 0 14:33:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:05 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:33:05 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:33:05 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:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:05 INFO - 'HOME': '/Users/cltbld', 14:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:05 INFO - 'LOGNAME': 'cltbld', 14:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:05 INFO - 'MOZ_NO_REMOTE': '1', 14:33:05 INFO - 'NO_EM_RESTART': '1', 14:33:05 INFO - 'PAGER': '/bin/cat', 14:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:05 INFO - 'PWD': '/builds/slave/test', 14:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:05 INFO - 'SHELL': '/bin/bash', 14:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:05 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:05 INFO - 'USER': 'cltbld', 14:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:05 INFO - 'XPC_FLAGS': '0x0', 14:33:05 INFO - 'XPC_SERVICE_NAME': '0', 14:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:33:06 INFO - Cleaning up... 14:33:06 INFO - Return code: 0 14:33:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:33:06 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:33:06 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:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:06 INFO - 'HOME': '/Users/cltbld', 14:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:06 INFO - 'LOGNAME': 'cltbld', 14:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:06 INFO - 'MOZ_NO_REMOTE': '1', 14:33:06 INFO - 'NO_EM_RESTART': '1', 14:33:06 INFO - 'PAGER': '/bin/cat', 14:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:06 INFO - 'PWD': '/builds/slave/test', 14:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:06 INFO - 'SHELL': '/bin/bash', 14:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:06 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:06 INFO - 'USER': 'cltbld', 14:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:06 INFO - 'XPC_FLAGS': '0x0', 14:33:06 INFO - 'XPC_SERVICE_NAME': '0', 14:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:33:06 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:33:06 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:33:06 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:33:06 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:33:06 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:33:06 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:33:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:33:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:33:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:33:10 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:33:10 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:33:10 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:33:10 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:33:10 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:33:10 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:33:10 INFO - Downloading docopt-0.6.1.tar.gz 14:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:33:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:33:11 INFO - Running setup.py install for blobuploader 14:33:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:33:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:33:11 INFO - Running setup.py install for requests 14:33:11 INFO - Running setup.py install for docopt 14:33:11 INFO - Successfully installed blobuploader requests docopt 14:33:11 INFO - Cleaning up... 14:33:12 INFO - Return code: 0 14:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:12 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:33:12 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:33:12 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:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:12 INFO - 'HOME': '/Users/cltbld', 14:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:12 INFO - 'LOGNAME': 'cltbld', 14:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:12 INFO - 'MOZ_NO_REMOTE': '1', 14:33:12 INFO - 'NO_EM_RESTART': '1', 14:33:12 INFO - 'PAGER': '/bin/cat', 14:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:12 INFO - 'PWD': '/builds/slave/test', 14:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:12 INFO - 'SHELL': '/bin/bash', 14:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:12 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:12 INFO - 'USER': 'cltbld', 14:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:12 INFO - 'XPC_FLAGS': '0x0', 14:33:12 INFO - 'XPC_SERVICE_NAME': '0', 14:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:12 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-StOiYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:12 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-wk8srb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:12 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-C_Owa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:12 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-MT8BAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:12 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-J9XBlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:12 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-mlsINI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:12 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-RSvhPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-WpXS5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Kr3PGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-b1IqIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-HZyLDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-OpCNzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-QF6FQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-i5bsbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-8qlJxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:13 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-P558UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-RLfNcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:33:14 INFO - Running setup.py install for manifestparser 14:33:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:33:14 INFO - Running setup.py install for mozcrash 14:33:14 INFO - Running setup.py install for mozdebug 14:33:14 INFO - Running setup.py install for mozdevice 14:33:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:33:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:33:14 INFO - Running setup.py install for mozfile 14:33:14 INFO - Running setup.py install for mozhttpd 14:33:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozinfo 14:33:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozInstall 14:33:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozleak 14:33:15 INFO - Running setup.py install for mozlog 14:33:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for moznetwork 14:33:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozprocess 14:33:15 INFO - Running setup.py install for mozprofile 14:33:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozrunner 14:33:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozscreenshot 14:33:16 INFO - Running setup.py install for moztest 14:33:16 INFO - Running setup.py install for mozversion 14:33:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:33:16 INFO - Cleaning up... 14:33:16 INFO - Return code: 0 14:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:16 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:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:16 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:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:16 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:33:16 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:33:16 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:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:16 INFO - 'HOME': '/Users/cltbld', 14:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:16 INFO - 'LOGNAME': 'cltbld', 14:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:16 INFO - 'MOZ_NO_REMOTE': '1', 14:33:16 INFO - 'NO_EM_RESTART': '1', 14:33:16 INFO - 'PAGER': '/bin/cat', 14:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:16 INFO - 'PWD': '/builds/slave/test', 14:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:16 INFO - 'SHELL': '/bin/bash', 14:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:16 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:16 INFO - 'USER': 'cltbld', 14:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:16 INFO - 'XPC_FLAGS': '0x0', 14:33:16 INFO - 'XPC_SERVICE_NAME': '0', 14:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-VlWzTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-YzbDid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-jaSuYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-atvMVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-7KDT_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Z70Xsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-xK1wyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Ea_6XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-50AkrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:17 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:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:17 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Blyu_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:18 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:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:18 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-xXCBsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:18 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:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:18 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-hv1TL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:18 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-uztU9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:18 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:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:18 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Up7Ydo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:18 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:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:18 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-0WxNmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:18 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:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:18 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-CfQm1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:18 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:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:18 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TkZV_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:18 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:33:18 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:33:18 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:33:18 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:33:18 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:18 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:33:18 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:33:18 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:33:18 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:33:18 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:33:18 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:33:18 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:33:21 INFO - Downloading blessings-1.6.tar.gz 14:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:33:21 INFO - Installing collected packages: blessings 14:33:21 INFO - Running setup.py install for blessings 14:33:21 INFO - Successfully installed blessings 14:33:21 INFO - Cleaning up... 14:33:21 INFO - Return code: 0 14:33:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:22 INFO - Reading from file tmpfile_stdout 14:33:22 INFO - Current package versions: 14:33:22 INFO - blessings == 1.6 14:33:22 INFO - blobuploader == 1.2.4 14:33:22 INFO - docopt == 0.6.1 14:33:22 INFO - functools32 == 3.2.3-2 14:33:22 INFO - jsonschema == 2.5.1 14:33:22 INFO - manifestparser == 1.1 14:33:22 INFO - mozInstall == 1.12 14:33:22 INFO - mozcrash == 1.0 14:33:22 INFO - mozdebug == 0.1 14:33:22 INFO - mozdevice == 0.49 14:33:22 INFO - mozfile == 1.2 14:33:22 INFO - mozhttpd == 0.7 14:33:22 INFO - mozinfo == 0.9 14:33:22 INFO - mozleak == 0.1 14:33:22 INFO - mozlog == 3.4 14:33:22 INFO - moznetwork == 0.27 14:33:22 INFO - mozprocess == 0.24 14:33:22 INFO - mozprofile == 0.28 14:33:22 INFO - mozrunner == 6.13 14:33:22 INFO - mozscreenshot == 0.1 14:33:22 INFO - mozsystemmonitor == 0.3 14:33:22 INFO - moztest == 0.8 14:33:22 INFO - mozversion == 1.4 14:33:22 INFO - psutil == 3.1.1 14:33:22 INFO - requests == 1.2.3 14:33:22 INFO - wsgiref == 0.1.2 14:33:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33: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:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:22 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:33:22 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:33:22 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:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:22 INFO - 'HOME': '/Users/cltbld', 14:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:22 INFO - 'LOGNAME': 'cltbld', 14:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:22 INFO - 'MOZ_NO_REMOTE': '1', 14:33:22 INFO - 'NO_EM_RESTART': '1', 14:33:22 INFO - 'PAGER': '/bin/cat', 14:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:22 INFO - 'PWD': '/builds/slave/test', 14:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:22 INFO - 'SHELL': '/bin/bash', 14:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:22 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:22 INFO - 'USER': 'cltbld', 14:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:22 INFO - 'XPC_FLAGS': '0x0', 14:33:22 INFO - 'XPC_SERVICE_NAME': '0', 14:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 INFO - Cleaning up... 14:33:22 INFO - Return code: 0 14:33:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33: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:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33: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:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:22 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 0x10b459b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b45c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff871d6b5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, '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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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:33:22 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:33:22 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:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:22 INFO - 'HOME': '/Users/cltbld', 14:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:22 INFO - 'LOGNAME': 'cltbld', 14:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:22 INFO - 'MOZ_NO_REMOTE': '1', 14:33:22 INFO - 'NO_EM_RESTART': '1', 14:33:22 INFO - 'PAGER': '/bin/cat', 14:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:22 INFO - 'PWD': '/builds/slave/test', 14:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:22 INFO - 'SHELL': '/bin/bash', 14:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:22 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:22 INFO - 'USER': 'cltbld', 14:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:22 INFO - 'XPC_FLAGS': '0x0', 14:33:22 INFO - 'XPC_SERVICE_NAME': '0', 14:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:33:22 INFO - Cleaning up... 14:33:22 INFO - Return code: 0 14:33:22 INFO - Running post-action listener: _resource_record_post_action 14:33:22 INFO - Running post-action listener: _start_resource_monitoring 14:33:22 INFO - Starting resource monitoring. 14:33:22 INFO - [mozharness: 2017-01-16 22:33:22.576844Z] Finished create-virtualenv step (success) 14:33:22 INFO - [mozharness: 2017-01-16 22:33:22.577885Z] Running install step. 14:33:22 INFO - Running pre-action listener: _resource_record_pre_action 14:33:22 INFO - Running main action method: install 14:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:22 INFO - Reading from file tmpfile_stdout 14:33:22 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:22 INFO - Reading from file tmpfile_stdout 14:33:22 INFO - Output received: 14:33:22 INFO - Usage: mozinstall [options] installer 14:33:22 INFO - Options: 14:33:22 INFO - -h, --help show this help message and exit 14:33:22 INFO - -d DEST, --destination=DEST 14:33:22 INFO - Directory to install application into. [default: 14:33:22 INFO - "/builds/slave/test"] 14:33:22 INFO - --app=APP Application being installed. [default: firefox] 14:33:22 INFO - mkdir: /builds/slave/test/build/application 14:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:33:44 INFO - Reading from file tmpfile_stdout 14:33:44 INFO - Output received: 14:33:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:33:44 INFO - Running post-action listener: _resource_record_post_action 14:33:44 INFO - [mozharness: 2017-01-16 22:33:44.691417Z] Finished install step (success) 14:33:44 INFO - [mozharness: 2017-01-16 22:33:44.691561Z] Running run-tests step. 14:33:44 INFO - Running pre-action listener: _resource_record_pre_action 14:33:44 INFO - Running main action method: run_tests 14:33:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:33:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:33:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:33:44 INFO - 2017-01-16 14:33:44.706 screenresolution[1626:7919] starting screenresolution argv=screenresolution get 14:33:44 INFO - 2017-01-16 14:33:44.709 screenresolution[1626:7919] Display 0: 1600x1200x32@60 14:33:44 INFO - 2017-01-16 14:33:44.714 screenresolution[1627:7922] starting screenresolution argv=screenresolution list 14:33:44 INFO - Available Modes on Display 0 14:33:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:33:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:33:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:33:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:33:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:33:44 INFO - Intel Iris: 14:33:44 INFO - Chipset Model: Intel Iris 14:33:44 INFO - Type: GPU 14:33:44 INFO - Bus: Built-In 14:33:44 INFO - VRAM (Dynamic, Max): 1536 MB 14:33:44 INFO - Vendor: Intel (0x8086) 14:33:44 INFO - Device ID: 0x0a2e 14:33:44 INFO - Revision ID: 0x0009 14:33:44 INFO - Displays: 14:33:44 INFO - Display: 14:33:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:33:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:33:44 INFO - Display Serial Number: 1600x1200 60 14:33:44 INFO - Main Display: Yes 14:33:44 INFO - Mirror: Off 14:33:44 INFO - Online: Yes 14:33:44 INFO - Rotation: Supported 14:33:44 INFO - Return code: 0 14:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:44 INFO - Python 2.7.3 14:33:44 INFO - Return code: 0 14:33:44 INFO - grabbing minidump binary from tooltool 14:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:44 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 0x10b237d30>, '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 0x10b15edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b22cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:44 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:33:44 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:33:44 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:33:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:45 INFO - Return code: 0 14:33:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:33:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:33:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --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:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BQyqU62juQ/Render', 14:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:45 INFO - 'HOME': '/Users/cltbld', 14:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:45 INFO - 'LOGNAME': 'cltbld', 14:33:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:45 INFO - 'MOZ_NO_REMOTE': '1', 14:33:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:45 INFO - 'NO_EM_RESTART': '1', 14:33:45 INFO - 'PAGER': '/bin/cat', 14:33:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:45 INFO - 'PWD': '/builds/slave/test', 14:33:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:45 INFO - 'SHELL': '/bin/bash', 14:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lyJUKAwuNZ/Listeners', 14:33:45 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 14:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:45 INFO - 'USER': 'cltbld', 14:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:45 INFO - 'XPC_FLAGS': '0x0', 14:33:45 INFO - 'XPC_SERVICE_NAME': '0', 14:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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:33:45 INFO - mozversion application_buildid: 20170116131921 14:33:45 INFO - mozversion application_changeset: 88030580b14bb253a55bc174c987a9fa43c3fb55 14:33:45 INFO - mozversion application_display_name: Nightly 14:33:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:45 INFO - mozversion application_name: Firefox 14:33:45 INFO - mozversion application_remotingname: firefox 14:33:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:33:45 INFO - mozversion application_vendor: Mozilla 14:33:45 INFO - mozversion application_version: 53.0a1 14:33:45 INFO - mozversion platform_buildid: 20170116131921 14:33:45 INFO - mozversion platform_changeset: 88030580b14bb253a55bc174c987a9fa43c3fb55 14:33:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:33:45 INFO - mozversion platform_version: 53.0a1 14:33:45 INFO - using testdate: 1484606025 14:33:45 INFO - actual date: 1484606025 14:33:45 INFO - starting webserver on 'localhost:49242' 14:33:45 INFO - SUITE-START | Running 2 tests 14:33:45 INFO - TEST-START | dromaeo_css 14:33:45 INFO - operating with platform_type : mac_ 14:33:45 INFO - Initialising browser for dromaeo_css test... 14:33:45 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmptXOeOD/profile http://localhost:49242/getInfo.html) 14:33:48 INFO - PROCESS | 1637 | 2017-01-16 14:33:48.336 plugin-container[1639:8094] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3b, name = 'com.apple.tsm.portname' 14:33:48 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:48 INFO - PROCESS | 1637 | 2017-01-16 14:33:48.340 plugin-container[1639:8094] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b17, name = 'com.apple.CFPasteboardClient' 14:33:48 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:48 INFO - PROCESS | 1637 | 2017-01-16 14:33:48.340 plugin-container[1639:8094] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:33:48 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 14:33:48 INFO - PROCESS | 1637 | colorDepth:24 14:33:48 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 14:33:48 INFO - PROCESS | 1637 | __metrics 14:33:48 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3251: TypeError: this.tabs is undefined 14:33:49 INFO - TEST-INFO | 1637: exit 0 14:33:49 INFO - Browser initialized. 14:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:49 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmptXOeOD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:51 INFO - PROCESS | 1640 | 2017-01-16 14:33:51.671 plugin-container[1641:8219] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 14:33:51 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:51 INFO - PROCESS | 1640 | 2017-01-16 14:33:51.673 plugin-container[1641:8219] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f17, name = 'com.apple.CFPasteboardClient' 14:33:51 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:51 INFO - PROCESS | 1640 | 2017-01-16 14:33:51.673 plugin-container[1641:8219] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:34:01 INFO - PROCESS | 1640 | RSS: Main: 233775104 14:34:01 INFO - PROCESS | 1640 | 14:37:04 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 14:37:05 INFO - PROCESS | 1640 | RSS: Main: 261849088 14:37:05 INFO - PROCESS | 1640 | 14:38:49 INFO - PROCESS | 1640 | ************************* 14:38:49 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 14:38:49 INFO - PROCESS | 1640 | 14:38:49 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:38:49 INFO - PROCESS | 1640 | Full stack: 14:38:49 INFO - PROCESS | 1640 | ************************* 14:40:08 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 14:40:08 INFO - PROCESS | 1640 | RSS: Main: 261328896 14:40:08 INFO - PROCESS | 1640 | 14:43:10 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 14:43:11 INFO - PROCESS | 1640 | RSS: Main: 270495744 14:43:11 INFO - PROCESS | 1640 | 14:46:13 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 14:46:13 INFO - PROCESS | 1640 | RSS: Main: 267190272 14:46:13 INFO - PROCESS | 1640 | 14:49:16 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 14:49:17 INFO - PROCESS | 1640 | RSS: Main: 271499264 14:49:17 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 14:52:20 INFO - PROCESS | 1640 | RSS: Main: 273870848 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | __start_tp_report 14:52:20 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 14:52:20 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 14:52:20 INFO - PROCESS | 1640 | |i|pagename|runs| 14:52:20 INFO - PROCESS | 1640 | |0;dojo.html;3364.125327414871;3379.2903490267045;3422.127357523832;3424.092615456906;3431.8112503812295;5071.594272458204;5680.886382272352;5720.342160651527;5762.53899688025;5798.942010579893;5641.830745077655;5765.625234359763;5812;5849.473547380735;5902.321233058199;5159.122949098643;5185.325907632003;5258.50044245796;5279.340082489689;5313.521783039526;5200.167973124301;5279.70961597112;5344.465553444663;5354.732263386815;5404.081306177959;5122.718250496221;5172.715500647463;5284.682919024871;5297.735113244342;5314.548263397616;5176.482351764831;5188.662736922126;5221.242919776649;5222.712750798704;5230.895382092337;5200.531952124289;5211.062008838408;5232.816851410183;5253.448387919251;5275.551578115865;4512.729236245803;5630.183623374588;5728.713564321767;5801.477866991949;5808.651480911159;6161.9691901540655;6189.133521306976;6286;6287.559870809046;6291.937080629181;4938.629602779806;5627.324721033461;6213.161223234896;6239.438450539428;6254;4071.063655359284;4526.343680166357;5863.824085277449;5950.9107363389585;5958.731857066442;6193.504519638418;6303.432691057827;6382.84042898922;6401.55189136756;6407.263164736022;6120.17377654011;6123;6123.4351415035735;6125.142480052797;6184.969075154685;5223.268742376071;6177.351378105324;6243.937560624427;6279.152314437492;6279.7802076928;6142.621558143003;6203.720832562545;6218.098375735493;6242.406971337716;6249.343818899041;6149.016157414792;6178.474829639531;6197.101420294032;6293.96853015732;6326.335734747877;5005.249212618063;5007.349044624176;5008.17365134756;5043.142665746832;5071.771770270347;4482.305242687388;4500.324951257272;4518.548145185455;4525.7510836904285;4578.748168850679;5876.823695289148;5882.794102206402;5891.882162356815;5900.262467191601;5925.851853703692;6066.817995460143;6219.813405597839;6254.843628909313;6269.8746025079245;6278.937210627927;5736.6558006519745;5781.248437703071;5806.564507661942;5819.709014549256;5821.2141360916585;5452.263944367539;5479.4520547944885;5486.396496385394;5500.532454741392;5512.779488820403;6166.445019948136;6258.593191442542;6333.6516491591565;6336;6355.841103972345;6207.906881396692;6276.497880169484;6285.654289014148;6293.339199383999;6316.557840951089;6414.422701956846;6431.871362572816;6438.098666186831;6450.483961282992;6460.967695161682;5105.285260063668;6082.90875636857;6161.9691901542;6269.059641053878;6317.6209427434505;5180.430152683277;6245.594036387621;6246.750129994931;6254.781082662085;6283.3716628338625;6155.446009859134;6172.074188871705;6208.72060757258;6216.347283535345;6249.093881387083;6052.425019623129;6067.635941843503;6121.510279177744;6126.908096378469;6148.292946311231;4420.9115817684105;4914.410270767531;5211.0359583475665;6027.939720602738;6028.186194863637;4984.476629953802;6169.2288463942;6200;6212.347703491249;6225.564210505221;5896.7936122235515;5953.91069133972;6010.158577799024;6082.087686847009;6099.75600975956 14:52:20 INFO - PROCESS | 1640 | |1;ext.html;438.86175854605796;467.9812807487701;498.52390966626854;513.8612574604856;519.1719207863459;40806.38790418142;43224.567754322445;43228.567714322846;43253.35119973203;43258;43406.565934340644;44143.33784993228;44180.89547761308;44356.556434435646;44406;7965;8661.870071948926;8804.603792829337;9233.815323693521;9592.616295348178;11218.495167717472;11513.078953683686;11534.942325288363;11655.358955257458;11702.414879256046;9767.267454940873;11512.597059102933;11518.942405287962;11568.59509917153;11605.30368177912;11472.598459053936;11559.364234967074;11570.305781653085;11585.015273701745;11600.013998810027;11360.545578176945;11434.142439317002;11441.313521188755;11477.655670329903;11478.253913495597;33665.32669346624;40624.79687601543;41005.1798964022;41076;41256.96857578555;3367.124547617637;3977.482927219443;4006.719529632927;4071.8982025449304;4079.7552146870985;30275.69724302751;30456.086317410514;30774;30822.53766193509;30841.537376939363;3192.457282262021;3202.4235637585225;3210.550522926792;3217.373221235252;3290.720288775457;367441;368009;368521;369483;370563;63171.684141579;63246;63468.682656586425;63522.682386587774;63576.41058973563;61879;65350.673246633465;65660.6716966412;65964.34035659677;65969.34030659632;15851.762223566655;16224.188790560425;16368.263428145761;16388;16452.588685282964;11382.829257561143;11647.010004149573;12469.189502682297;12630.81053784194;12732.172408793398;17329.48011559655;17458.738118928228;17492.12539373026;17494.912525437292;17519.29922803099;6747.426468750211;6771.3905748482875;6793.93206067933;6831.9658401707675;6834.316568343225;753.6194221917897;839;863.4689665855453;865.5499140446932;866.9176428239307;26914.461710766067;29867.436828877122;30204.54693179604;30235.395292094476;30705;993.3940296419179;994.3139233928711;1010.570507534295;1010.9961926734917;1015.6546774096843;11504.884951150381;13229.867701323055;13557;14426.206558639376;14754.188519631309;614518;619491;620799;620862;622418;51947.74026129845;52191;52251;52347.73826130845;52360.738196308776;1392.6518370407398;1404.4803422733653;1434.698713270225;1438.841727409984;1439.2731670506537;23468.882655587295;26125.954961801315;27499.45001100007;27766;27930.720692792813;45708.77145614383;46087.76956115198;46169.53830461652;46188.307175391725;46195;457896;459572;460978;461292;463717;18962.52593685169;23269;24500;24633.753662463147;25308.746912530638;34383;41356;41987.79006105072;42442.45345279293;43143;35471;35801.64198357983;36351.818240909684;36630.63369366379;36678.44982325214;33880.66119338775;35121.64878351184;35580.93257202288;35994.10014749652;36233.81883090568;34180.48729269113;34264.31471370509;34716.82641586877;34723.13192170216;35172.47241291332;28181.45002024908;30050.248743780707;31259.84370078135;32340.029799106065;32436.94538182727;21855.907204639385;24023.51952960896;24273.635895461935;24484.762032124923;24490.63264051005 14:52:20 INFO - PROCESS | 1640 | |2;jquery.html;353.8867562380038;387.778965989386;394.72145335464506;398.2592378176591;420.6718759367694;17298.13509324535;20433.386998390055;20849.06179221935;21294.680579791315;21333.786662133392;21682.566348673015;21813.890930545364;22032.228871989482;22194.88902555489;22465.775342246572;5750.942490575083;5982.581219314649;6024.759009639609;6044.788432404866;6066.817995460143;5616.297962754656;5775.624584402021;5921.141434492018;5964.3737407572235;6002.3997600239845;5790.884182316372;5801.593888427812;5804.912926306109;5807.854803629901;5839.678817665027;5570.944290557083;5784.942150578482;5790.160426738121;5792.768289268424;5869.207656966298;4952.306677065214;5188.455212202702;5194.480551944813;5194.974025129888;5195.818146364859;25786.74213257862;26056.478870422674;26199.083032093975;26438.73561264382;26556.86721566399;2797.8321300722023;2812.6624805023325;2815.4932112219794;2828.9575656365173;2832.504311745436;15457.304421301069;15473.5357939262;15566.455174068853;16393.262303196385;16628.25172867224;1802.8828126171757;1843.4008947092248;1843.8985855777926;1850.5281153305955;1851.7314989326608;129706;130501;131044;132514.68713282148;133184.33407832898;11608.593699220486;11718.472668729928;11846.585369512199;11957.162998590014;11980.161388702882;14970.62573435651;15107.773383399257;15119.319630616648;15124.470643527424;15152.242387880782;8680;8868.955655221811;8959.10408959112;9069.54652267384;9154.725358239264;8666.480011199348;8782.868256976151;8814.162654547808;8952.462852228757;8975.820483590292;6109.908351374733;6622.801315960529;6966.094407726963;7298.744543940937;7445.702171913063;1655;1657.991710041442;1668.8664906807426;1944.2417457191707;1986.5728868293386;884.5311984648147;886.2776836877924;897.6095398501673;906.5784410249134;908.9590968406305;15891.761623575656;16469;20867.64360316605;22142.22502212415;22438.43903902383;874.1957399192758;885.7785553611598;930.6417029443713;951.5717926932908;957.1720461800493;6575.506836987245;6815.454763618898;6946.895796563055;7112.182099058571;7114.466415018895;386873;743020;748410;750331;761826;124488.37755811164;142030;152411;160394.39605604028;162788;462.70849364899897;472.99054018920117;473.06569525188166;473.90048089901507;474.6321600759439;9995.800503939574;11518.308901465938;11580.305181689126;11672.824907626562;12012.879871201176;58635.53411164755;62662.373376265656;62981.05528416986;63020.36979630145;63046;87553.1244687545;92660;92785.53607231921;92796;93224;8275.83448331042;8377.748667539983;8523.360747943805;8967.461952282883;8988.46069235848;11264.549418023515;12868.871311286768;13027.283499407624;13579.388927498088;13593.59219223425;11077.889221107685;11532.308061516336;11534.769304614028;11670.241434306743;11766.941165294118;4563.247064234364;6204.689765511796;10572.41851698164;10898.0383530962;11241;9768.902310976799;11317.943410282896;11674.241174323643;11807.76384472323;11863.347515886364;7663.31030207284;8287.466818638572;8391.790205244917;8538.914610853812;8605.35459840502;8309.916900831156;11385.715357116138;11695.649130526097;11784;11852.881471185177 14:52:20 INFO - PROCESS | 1640 | |3;mootools.html;1205.5418940802494;1397.643600881775;1439.93520291587;1465.6628975335673;1479.3564799312296;7471.962640186805;7759.5344279343135;7969.442139050268;8394;8414.705485308015;7944.721934732285;8139.267465928066;8165;8264.214899584545;8303.833923321545;2192.7697591752917;2238.250186187629;2240.932772016842;2242.618754811686;2250.8762018089;2060.2171174953573;2125.968110478344;2267.331137314488;2303.34354708908;2303.884805759714;2238;2311.456807650201;2318.675385446039;2321.071571371448;2330.9650355244685;2276.146445083094;2280.8631482111127;2298.4368829636765;2299.6665483504967;2309.1340747219792;2262.5361800830956;2291.7708229177115;2308.9609675645856;2336.158982766203;2350.8001819845335;8361.790955226108;8362.749117526484;8417.452865563719;8420.326373890073;8433.620487078097;4355.412019377375;4632.513586073481;5078.13671675816;5219.060569097561;5226.268322434862;2859.4709978654014;2878.352370716572;3227.854746536388;3516;3536.8231588420476;1201.4113084588575;1217.1662411248324;1247.6444213399138;1268.0489632775418;1270.9618711438673;10643.254972151952;10835.891641083646;10866.45667716611;10873.238873278873;10926.562937482411;4319.697621166488;4472.306792447176;4559.361689363492;4562.429696287964;4677.4387073550715;9474.526273686288;9510.239180865514;9524.238060955246;9537.856932146024;9556.283278754121;5232.686038837682;5240.371155461369;5244.947550524522;5252.579793616502;5258.815941442108;4606.262997920317;4779.187538118528;4799.808007679654;4818.590419814285;4838.225883858566;3790.8104594770152;3831.3678243090135;3860.652541271299;3917.314469967744;3928.4107383892647;1149.7298134938283;1190.815423609342;1237.962861114168;1242.2670624331506;1260.7667581497453;784.5371230973639;837.3008537870946;891.3092353426147;905.2486436258022;935.5930170375908;5544.417836127229;5567.359753628384;5605.691686957175;5714.342591809163;5846.123081537803;880.9471431714118;1000.659775676259;1009.7828966772179;1020.0921180149672;1028.0747327405395;3751.643593858579;3759.9060023499633;3809.257194846978;3864.2078373933837;3867.149227170018;9761;9958.651447199314;10057.949710251549;10074.74813129663;10101.898981010243;10026.197904167795;10026.398416095057;10047.296689231829;10076.949615252024;10086.092251697382;7463;7779.688812447552;7831.765047048484;7920.722774702857;7922.247386498273;5363.927214557182;5657.773689052392;5767.134929760569;5822.359540450631;5909.8227053188475;7941.960290198512;8978.416402933788;9139.954300228455;9265.953670231605;9330.533473326443;9309.255259579082;9412.764680883032;9418.4819834907;9539.713808585753;9650.95174524123;7119.82200444993;7212.71149154028;7234.385077268491;7235.963820180866;7251.492395532262;7795.220477952386;7801.102873169658;7801.687932482637;7902.644381002754;7903.802404939923;6425.5502114851515;7127.928720712726;7156.320149585781;7183.03029091087;7213.819654508679;5720.6853623049465;7003.159620845531;7046.084009078787;7066.364027237573;7080.114985626797;6077.7208546794955;6177.042558403455;6179.81460556184;6183.103449999635;6195.256569211723;4675.555822196886;4767.547083027107;4827.831025914076;4906.411230652202;4977.651564390603;4236.6187043166265;4963.925541116814;5035.219540971156;5085.160948443613;5129.179331306973 14:52:20 INFO - PROCESS | 1640 | |4;prototype.html;356.2607589252302;359.99280014399704;372.5678213272603;373.6133102239183;376.4879763521612;4836.637252206081;5190.1176799944005;5406.513413792758;5608.130739735338;5636.915446268305;4998.475160108191;5370.194470829368;5382.515573598375;5422.4306447823;5422.457754224575;4190.700882726349;4199.916001679964;4228.619424251817;4239.745615263078;4249.001484651105;3487.08828128513;4132.814023368941;4199.5380508144235;4249.426327445802;4250.829966801324;3356.244844909888;3394.6435624259466;3519.944016794964;4155.859732237885;4179.728317659343;4172.895677608054;4179.331306990882;4179.853705120307;4200.621944025022;4232.280512312884;3690.944635830465;3697.7411581189326;3709.9072523186865;3717.126475278307;3745.382011968022;3799.7150213733803;4332.67504937131;4716.504766999485;5246.213068039787;5315.840524784263;4666.440027196724;4835.734034628094;4855.465898751135;4862.513748625109;4879.756012199411;5030.723310217936;5159.3247427829465;5406.269833733979;5725.513331366838;5749.8275051748515;3488.6336934621754;3863.7102217333813;4023.9537720192666;4089.89775255618;4113.568075352075;4569.565891240327;5182.740862956837;5828.03837366834;6006.459418652298;6013.5489838261865;3685.3919103348185;3719.702423806089;4017.4978127734034;4169.45797046382;4196.979015104905;3975.827130996363;4110.260153172398;4172.812223449952;4257.595528424795;4262.50812215722;4406.823727050946;4859.829905953275;4868.95131048692;4873.26900964851;4879.365682461257;4872.731999740048;5367.355917289872;5714.342850572238;5782.756707307864;5801.88396232073;1115.893990070942;1150.6030419505257;1286.2668279080833;1359.8436179839248;1381.7996390523317;898.8135660927644;968.6706519783166;979.5396163803001;984.4634674102631;992.9304948653669;4295.871123866289;4773.403324584427;4891.559759621651;4932.26016097581;5095.063875727274;5272.629116429756;5296.887653592788;5350.411454739976;5499.9925027364725;5601.019821531216;4279.358096285519;4347.91300175911;5029.30346195546;5047.268146118792;5127.794888204505;2802.341449759305;2940.3237255430945;3003.294225856922;3018.5321275202377;3040.4223197592387;5028.723420211851;5705.828825135252;5838.328592211865;5868.823935281948;5921.67430791302;4967.602591792648;5727.39862314451;5824.854378640568;5833.774907269521;5886.116442738368;4999.275105109811;5346.7861285548925;5893.9115913260475;5911.142884281755;5914.550935020948;5079.466656001215;5692.686902220417;5715.857103572278;5725.51333136688;5738.282714660668;4992.825251116194;5087.440381557952;5259.815906443256;5494.955958367897;5643.689597072201;5069.9746501267255;5376.516113549799;5693.971530142323;5901.822945311647;5920.585559010828;3152.621685397767;3537.9916723733613;3587.192881601619;3757.304898593769;3799.3214783578064;5228.869278268074;5653.858653533694;5878.823635290948;5882.323532793613;5898.764049437975;4937.58086512562;5106.514881086291;5130.230465430215;5805.390434004369;5820.796272130455;5235.345581802275;5412.377576578587;5555.472230138131;5809;5830.47525722687;5349.679019258857;5366.838994830161;5565.860853478695;5635.295588051494;5668.546516278605;5516.393196748274;5764.394738552392;5816.505597024131;5819.5053420459735;5865.618734782225;4750.714957102585;5113.92329115071;5328.973355133199;5650.971745141248;5669.177969194526 14:52:20 INFO - PROCESS | 1640 | |5;yui.html;711.3349018667543;769.0156599552571;790.9604519774017;822.21889205255;830.364770950223;15313;15941.760873586905;16017.839821601781;16023.519294421158;16025.919870400632;11273.774524509505;12405.937970310135;14791.112533248013;14898.702025959474;14940.7011859763;675.3685304240527;698.0053423870988;844.4637655089032;860.3117505995226;876.6843936182969;872.9127087291251;876.8947726272825;885.7209978856639;886.5611522296472;889.4040992534984;817.8631701934316;903.9909600903973;940.6989763275755;940.9905900941005;943.3538026451868;928.6610387208688;934.63082082577;936.6066252174035;936.8173206224754;938.7746940734208;697.7453229571221;698.1622053535726;700.3136925812732;701.4879138229121;702.8453740177204;12948.093633445662;15006.849931500654;15021.774673379909;15766.842331576652;15813.68372632541;11335.603253886075;14375.928120359436;14419.639509012253;14616.049956752884;14714.33785479656;11734.471948762326;11749.706257343549;11870.821937670942;11928.642140735792;12319.014478841671;3699.5190625218547;3724.4971928789537;3730.2725968436166;3749.6250374962287;3828.1769419574925;99884;102539;102894.97105028928;103403.48298258535;103920.48039759752;10308.896911030793;10650.520726567323;11361.14791390649;11422.428878556038;11712;21429.67855482169;21584.028718707697;21880.343589692333;21937.670934935988;22087.558248834932;7791.220877912164;7914.24814642608;7923.762287131395;8110.148434414302;8209.220124088202;4339.587739164775;4349.739015659071;4408.448943882015;4414.646828253796;4469.08383781324;3654.3604869147794;3718.6095459976855;3732.1789206374556;3744.4383342498845;3746.737728359043;665.8934570468701;686.8557602903446;688.6040526697169;715.6707914359453;742.2836962331376;673.9898901516481;685.6982927511879;700.8458139209366;704.3871831506519;721.9241979592172;9287.76780580491;10182.745431364276;10271.897281027244;10374.481275936172;10386.584536618602;701.2776839854957;703.3880523944099;719.2232389019846;722.1947528505783;753.6759193546718;4645.721256724607;4868.736981820565;4943.250219221157;4945.8021679132435;4985.052839960396;99704.50147749214;99797;103097.48451257695;103668;104920.47539762252;67064;83068.58465707753;84236.05173818886;90712.63931041039;94863.52568237115;76630;85513;86605;87951.56024219838;89823;10641.8935810644;10701.839472407764;10851.294665846695;10962.013418792347;10968.177386696188;41890.58109418989;43359.04884280278;50759.731006725124;52062;52731;48578;51857.481425185266;56849.72601096075;67461;69745.65127174332;13071.477140914258;13811.51659691906;14023.368948397143;14263.215523145911;14342.282885855457;14817.296010958878;14853.925730371278;14858.628534286729;14903.32935017905;15066.472673456376;13520.39158237862;13636.86363136356;13681.863181368457;13742.312884355943;13789.962926481596;13833.79249311241;14134.858651413766;14148.929255353658;14420.783688244894;14627.488037919047;13347.09185799595;13444.932775336452;13488.595342139752;13500.459981600627;13912.930435347758;11051.889481105087;11204.943975280072;11313.773724525628;11361.43192840338;11365.636123664883;8607.956960215159;10279.743006424898;10990.065844403316;11007.064399525809;11057.834132487858 14:52:20 INFO - PROCESS | 1640 | __end_tp_report 14:52:20 INFO - PROCESS | 1640 | __start_cc_report 14:52:20 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,397 14:52:20 INFO - PROCESS | 1640 | __end_cc_report 14:52:20 INFO - PROCESS | 1640 | __startTimestamp1484607140397__endTimestamp 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | ------- Summary: start ------- 14:52:20 INFO - PROCESS | 1640 | Number of tests: 6 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5710.05 Median:5925.85 stddev:675.24 (11.4%) stddev-sans-first:651.75 14:52:20 INFO - PROCESS | 1640 | Values: 3364.1 3379.3 3422.1 3424.1 3431.8 5071.6 5680.9 5720.3 5762.5 5798.9 5641.8 5765.6 5812.0 5849.5 5902.3 5159.1 5185.3 5258.5 5279.3 5313.5 5200.2 5279.7 5344.5 5354.7 5404.1 5122.7 5172.7 5284.7 5297.7 5314.5 5176.5 5188.7 5221.2 5222.7 5230.9 5200.5 5211.1 5232.8 5253.4 5275.6 4512.7 5630.2 5728.7 5801.5 5808.7 6162.0 6189.1 6286.0 6287.6 6291.9 4938.6 5627.3 6213.2 6239.4 6254.0 4071.1 4526.3 5863.8 5950.9 5958.7 6193.5 6303.4 6382.8 6401.6 6407.3 6120.2 6123.0 6123.4 6125.1 6185.0 5223.3 6177.4 6243.9 6279.2 6279.8 6142.6 6203.7 6218.1 6242.4 6249.3 6149.0 6178.5 6197.1 6294.0 6326.3 5005.2 5007.3 5008.2 5043.1 5071.8 4482.3 4500.3 4518.5 4525.8 4578.7 5876.8 5882.8 5891.9 5900.3 5925.9 6066.8 6219.8 6254.8 6269.9 6278.9 5736.7 5781.2 5806.6 5819.7 5821.2 5452.3 5479.5 5486.4 5500.5 5512.8 6166.4 6258.6 6333.7 6336.0 6355.8 6207.9 6276.5 6285.7 6293.3 6316.6 6414.4 6431.9 6438.1 6450.5 6461.0 5105.3 6082.9 6162.0 6269.1 6317.6 5180.4 6245.6 6246.8 6254.8 6283.4 6155.4 6172.1 6208.7 6216.3 6249.1 6052.4 6067.6 6121.5 6126.9 6148.3 4420.9 4914.4 5211.0 6027.9 6028.2 4984.5 6169.2 6200.0 6212.3 6225.6 5896.8 5953.9 6010.2 6082.1 6099.8 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:62371.60 Median:35147.06 stddev:131830.32 (375.1%) stddev-sans-first:132118.13 14:52:20 INFO - PROCESS | 1640 | Values: 438.9 468.0 498.5 513.9 519.2 40806.4 43224.6 43228.6 43253.4 43258.0 43406.6 44143.3 44180.9 44356.6 44406.0 7965.0 8661.9 8804.6 9233.8 9592.6 11218.5 11513.1 11534.9 11655.4 11702.4 9767.3 11512.6 11518.9 11568.6 11605.3 11472.6 11559.4 11570.3 11585.0 11600.0 11360.5 11434.1 11441.3 11477.7 11478.3 33665.3 40624.8 41005.2 41076.0 41257.0 3367.1 3977.5 4006.7 4071.9 4079.8 30275.7 30456.1 30774.0 30822.5 30841.5 3192.5 3202.4 3210.6 3217.4 3290.7 367441.0 368009.0 368521.0 369483.0 370563.0 63171.7 63246.0 63468.7 63522.7 63576.4 61879.0 65350.7 65660.7 65964.3 65969.3 15851.8 16224.2 16368.3 16388.0 16452.6 11382.8 11647.0 12469.2 12630.8 12732.2 17329.5 17458.7 17492.1 17494.9 17519.3 6747.4 6771.4 6793.9 6832.0 6834.3 753.6 839.0 863.5 865.5 866.9 26914.5 29867.4 30204.5 30235.4 30705.0 993.4 994.3 1010.6 1011.0 1015.7 11504.9 13229.9 13557.0 14426.2 14754.2 614518.0 619491.0 620799.0 620862.0 622418.0 51947.7 52191.0 52251.0 52347.7 52360.7 1392.7 1404.5 1434.7 1438.8 1439.3 23468.9 26126.0 27499.5 27766.0 27930.7 45708.8 46087.8 46169.5 46188.3 46195.0 457896.0 459572.0 460978.0 461292.0 463717.0 18962.5 23269.0 24500.0 24633.8 25308.7 34383.0 41356.0 41987.8 42442.5 43143.0 35471.0 35801.6 36351.8 36630.6 36678.4 33880.7 35121.6 35580.9 35994.1 36233.8 34180.5 34264.3 34716.8 34723.1 35172.5 28181.5 30050.2 31259.8 32340.0 32436.9 21855.9 24023.5 24273.6 24484.8 24490.6 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:38765.22 Median:2491.96 stddev:116112.99 (4659.5%) stddev-sans-first:116402.89 14:52:20 INFO - PROCESS | 1640 | Values: 353.9 387.8 394.7 398.3 420.7 17298.1 20433.4 20849.1 21294.7 21333.8 21682.6 21813.9 22032.2 22194.9 22465.8 5750.9 5982.6 6024.8 6044.8 6066.8 5616.3 5775.6 5921.1 5964.4 6002.4 5790.9 5801.6 5804.9 5807.9 5839.7 5570.9 5784.9 5790.2 5792.8 5869.2 4952.3 5188.5 5194.5 5195.0 5195.8 25786.7 26056.5 26199.1 26438.7 26556.9 2797.8 2812.7 2815.5 2829.0 2832.5 15457.3 15473.5 15566.5 16393.3 16628.3 1802.9 1843.4 1843.9 1850.5 1851.7 129706.0 130501.0 131044.0 132514.7 133184.3 11608.6 11718.5 11846.6 11957.2 11980.2 14970.6 15107.8 15119.3 15124.5 15152.2 8680.0 8869.0 8959.1 9069.5 9154.7 8666.5 8782.9 8814.2 8952.5 8975.8 6109.9 6622.8 6966.1 7298.7 7445.7 1655.0 1658.0 1668.9 1944.2 1986.6 884.5 886.3 897.6 906.6 909.0 15891.8 16469.0 20867.6 22142.2 22438.4 874.2 885.8 930.6 951.6 957.2 6575.5 6815.5 6946.9 7112.2 7114.5 386873.0 743020.0 748410.0 750331.0 761826.0 124488.4 142030.0 152411.0 160394.4 162788.0 462.7 473.0 473.1 473.9 474.6 9995.8 11518.3 11580.3 11672.8 12012.9 58635.5 62662.4 62981.1 63020.4 63046.0 87553.1 92660.0 92785.5 92796.0 93224.0 8275.8 8377.7 8523.4 8967.5 8988.5 11264.5 12868.9 13027.3 13579.4 13593.6 11077.9 11532.3 11534.8 11670.2 11766.9 4563.2 6204.7 10572.4 10898.0 11241.0 9768.9 11317.9 11674.2 11807.8 11863.3 7663.3 8287.5 8391.8 8538.9 8605.4 8309.9 11385.7 11695.6 11784.0 11852.9 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5406.08 Median:5006.44 stddev:2964.35 (59.2%) stddev-sans-first:2955.85 14:52:20 INFO - PROCESS | 1640 | Values: 1205.5 1397.6 1439.9 1465.7 1479.4 7472.0 7759.5 7969.4 8394.0 8414.7 7944.7 8139.3 8165.0 8264.2 8303.8 2192.8 2238.3 2240.9 2242.6 2250.9 2060.2 2126.0 2267.3 2303.3 2303.9 2238.0 2311.5 2318.7 2321.1 2331.0 2276.1 2280.9 2298.4 2299.7 2309.1 2262.5 2291.8 2309.0 2336.2 2350.8 8361.8 8362.7 8417.5 8420.3 8433.6 4355.4 4632.5 5078.1 5219.1 5226.3 2859.5 2878.4 3227.9 3516.0 3536.8 1201.4 1217.2 1247.6 1268.0 1271.0 10643.3 10835.9 10866.5 10873.2 10926.6 4319.7 4472.3 4559.4 4562.4 4677.4 9474.5 9510.2 9524.2 9537.9 9556.3 5232.7 5240.4 5244.9 5252.6 5258.8 4606.3 4779.2 4799.8 4818.6 4838.2 3790.8 3831.4 3860.7 3917.3 3928.4 1149.7 1190.8 1238.0 1242.3 1260.8 784.5 837.3 891.3 905.2 935.6 5544.4 5567.4 5605.7 5714.3 5846.1 880.9 1000.7 1009.8 1020.1 1028.1 3751.6 3759.9 3809.3 3864.2 3867.1 9761.0 9958.7 10057.9 10074.7 10101.9 10026.2 10026.4 10047.3 10076.9 10086.1 7463.0 7779.7 7831.8 7920.7 7922.2 5363.9 5657.8 5767.1 5822.4 5909.8 7942.0 8978.4 9140.0 9266.0 9330.5 9309.3 9412.8 9418.5 9539.7 9651.0 7119.8 7212.7 7234.4 7236.0 7251.5 7795.2 7801.1 7801.7 7902.6 7903.8 6425.6 7127.9 7156.3 7183.0 7213.8 5720.7 7003.2 7046.1 7066.4 7080.1 6077.7 6177.0 6179.8 6183.1 6195.3 4675.6 4767.5 4827.8 4906.4 4977.7 4236.6 4963.9 5035.2 5085.2 5129.2 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4556.45 Median:5039.00 stddev:1370.05 (27.2%) stddev-sans-first:1337.13 14:52:20 INFO - PROCESS | 1640 | Values: 356.3 360.0 372.6 373.6 376.5 4836.6 5190.1 5406.5 5608.1 5636.9 4998.5 5370.2 5382.5 5422.4 5422.5 4190.7 4199.9 4228.6 4239.7 4249.0 3487.1 4132.8 4199.5 4249.4 4250.8 3356.2 3394.6 3519.9 4155.9 4179.7 4172.9 4179.3 4179.9 4200.6 4232.3 3690.9 3697.7 3709.9 3717.1 3745.4 3799.7 4332.7 4716.5 5246.2 5315.8 4666.4 4835.7 4855.5 4862.5 4879.8 5030.7 5159.3 5406.3 5725.5 5749.8 3488.6 3863.7 4024.0 4089.9 4113.6 4569.6 5182.7 5828.0 6006.5 6013.5 3685.4 3719.7 4017.5 4169.5 4197.0 3975.8 4110.3 4172.8 4257.6 4262.5 4406.8 4859.8 4869.0 4873.3 4879.4 4872.7 5367.4 5714.3 5782.8 5801.9 1115.9 1150.6 1286.3 1359.8 1381.8 898.8 968.7 979.5 984.5 992.9 4295.9 4773.4 4891.6 4932.3 5095.1 5272.6 5296.9 5350.4 5500.0 5601.0 4279.4 4347.9 5029.3 5047.3 5127.8 2802.3 2940.3 3003.3 3018.5 3040.4 5028.7 5705.8 5838.3 5868.8 5921.7 4967.6 5727.4 5824.9 5833.8 5886.1 4999.3 5346.8 5893.9 5911.1 5914.6 5079.5 5692.7 5715.9 5725.5 5738.3 4992.8 5087.4 5259.8 5495.0 5643.7 5070.0 5376.5 5694.0 5901.8 5920.6 3152.6 3538.0 3587.2 3757.3 3799.3 5228.9 5653.9 5878.8 5882.3 5898.8 4937.6 5106.5 5130.2 5805.4 5820.8 5235.3 5412.4 5555.5 5809.0 5830.5 5349.7 5366.8 5565.9 5635.3 5668.5 5516.4 5764.4 5816.5 5819.5 5865.6 4750.7 5113.9 5329.0 5651.0 5669.2 14:52:20 INFO - PROCESS | 1640 | 14:52:20 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20247.65 Median:3738.31 stddev:28811.13 (770.7%) stddev-sans-first:28854.60 14:52:20 INFO - PROCESS | 1640 | Values: 711.3 769.0 791.0 822.2 830.4 15313.0 15941.8 16017.8 16023.5 16025.9 11273.8 12405.9 14791.1 14898.7 14940.7 675.4 698.0 844.5 860.3 876.7 872.9 876.9 885.7 886.6 889.4 817.9 904.0 940.7 941.0 943.4 928.7 934.6 936.6 936.8 938.8 697.7 698.2 700.3 701.5 702.8 12948.1 15006.8 15021.8 15766.8 15813.7 11335.6 14375.9 14419.6 14616.0 14714.3 11734.5 11749.7 11870.8 11928.6 12319.0 3699.5 3724.5 3730.3 3749.6 3828.2 99884.0 102539.0 102895.0 103403.5 103920.5 10308.9 10650.5 11361.1 11422.4 11712.0 21429.7 21584.0 21880.3 21937.7 22087.6 7791.2 7914.2 7923.8 8110.1 8209.2 4339.6 4349.7 4408.4 4414.6 4469.1 3654.4 3718.6 3732.2 3744.4 3746.7 665.9 686.9 688.6 715.7 742.3 674.0 685.7 700.8 704.4 721.9 9287.8 10182.7 10271.9 10374.5 10386.6 701.3 703.4 719.2 722.2 753.7 4645.7 4868.7 4943.3 4945.8 4985.1 99704.5 99797.0 103097.5 103668.0 104920.5 67064.0 83068.6 84236.1 90712.6 94863.5 76630.0 85513.0 86605.0 87951.6 89823.0 10641.9 10701.8 10851.3 10962.0 10968.2 41890.6 43359.0 50759.7 52062.0 52731.0 48578.0 51857.5 56849.7 67461.0 69745.7 13071.5 13811.5 14023.4 14263.2 14342.3 14817.3 14853.9 14858.6 14903.3 15066.5 13520.4 13636.9 13681.9 13742.3 13790.0 13833.8 14134.9 14148.9 14420.8 14627.5 13347.1 13444.9 13488.6 13500.5 13912.9 11051.9 11204.9 11313.8 11361.4 11365.6 8608.0 10279.7 10990.1 11007.1 11057.8 14:52:20 INFO - PROCESS | 1640 | -------- Summary: end -------- 14:52:20 INFO - PROCESS | 1640 | 14:52:21 INFO - TEST-INFO | 1640: exit 0 14:52:21 INFO - TEST-OK | dromaeo_css | took 1115745ms 14:52:21 INFO - TEST-START | kraken 14:52:21 INFO - operating with platform_type : mac_ 14:52:21 INFO - Initialising browser for kraken test... 14:52:21 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpIY2FKh/profile http://localhost:49242/getInfo.html) 14:52:23 INFO - PROCESS | 1648 | 2017-01-16 14:52:23.816 plugin-container[1649:10521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 14:52:23 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:23 INFO - PROCESS | 1648 | 2017-01-16 14:52:23.819 plugin-container[1649:10521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 14:52:23 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:23 INFO - PROCESS | 1648 | 2017-01-16 14:52:23.819 plugin-container[1649:10521] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:52:23 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 14:52:23 INFO - PROCESS | 1648 | colorDepth:24 14:52:23 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 14:52:23 INFO - PROCESS | 1648 | __metrics 14:52:23 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3251: TypeError: this.tabs is undefined 14:52:24 INFO - TEST-INFO | 1648: exit 0 14:52:24 INFO - Browser initialized. 14:52:24 INFO - Running cycle 1/1 for kraken test... 14:52:24 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpIY2FKh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:27 INFO - PROCESS | 1650 | 2017-01-16 14:52:27.366 plugin-container[1651:10634] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 14:52:27 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:27 INFO - PROCESS | 1650 | 2017-01-16 14:52:27.366 plugin-container[1651:10634] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4327, name = 'com.apple.CFPasteboardClient' 14:52:27 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:27 INFO - PROCESS | 1650 | 2017-01-16 14:52:27.366 plugin-container[1651:10634] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:52:37 INFO - PROCESS | 1650 | RSS: Main: 233562112 14:52:37 INFO - PROCESS | 1650 | 14:52:40 INFO - PROCESS | 1650 | 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:52:41 INFO - PROCESS | 1650 | RSS: Main: 246382592 14:52:41 INFO - PROCESS | 1650 | 14:52:43 INFO - PROCESS | 1650 | 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:52:44 INFO - PROCESS | 1650 | RSS: Main: 254046208 14:52:44 INFO - PROCESS | 1650 | 14:52:47 INFO - PROCESS | 1650 | 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:52:48 INFO - PROCESS | 1650 | RSS: Main: 256790528 14:52:48 INFO - PROCESS | 1650 | 14:52:50 INFO - PROCESS | 1650 | 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:52:50 INFO - PROCESS | 1650 | RSS: Main: 257912832 14:52:50 INFO - PROCESS | 1650 | 14:52:52 INFO - PROCESS | 1650 | 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:52:53 INFO - PROCESS | 1650 | RSS: Main: 259543040 14:52:53 INFO - PROCESS | 1650 | 14:52:56 INFO - PROCESS | 1650 | 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:52:57 INFO - PROCESS | 1650 | RSS: Main: 265523200 14:52:57 INFO - PROCESS | 1650 | 14:53:00 INFO - PROCESS | 1650 | 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:53:00 INFO - PROCESS | 1650 | RSS: Main: 264396800 14:53:00 INFO - PROCESS | 1650 | 14:53:03 INFO - PROCESS | 1650 | 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:53:04 INFO - PROCESS | 1650 | RSS: Main: 264355840 14:53:04 INFO - PROCESS | 1650 | 14:53:05 INFO - PROCESS | 1650 | 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:53:06 INFO - PROCESS | 1650 | RSS: Main: 263725056 14:53:06 INFO - PROCESS | 1650 | 14:53:08 INFO - PROCESS | 1650 | 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:53:09 INFO - PROCESS | 1650 | RSS: Main: 264220672 14:53:09 INFO - PROCESS | 1650 | 14:53:11 INFO - PROCESS | 1650 | 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:53:12 INFO - PROCESS | 1650 | RSS: Main: 263766016 14:53:12 INFO - PROCESS | 1650 | 14:53:15 INFO - PROCESS | 1650 | 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:53:15 INFO - PROCESS | 1650 | RSS: Main: 264130560 14:53:15 INFO - PROCESS | 1650 | 14:53:18 INFO - PROCESS | 1650 | 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:53:19 INFO - PROCESS | 1650 | RSS: Main: 263843840 14:53:19 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | 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:53:21 INFO - PROCESS | 1650 | RSS: Main: 265707520 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | __start_tp_report 14:53:21 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 14:53:21 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 14:53:21 INFO - PROCESS | 1650 | |i|pagename|runs| 14:53:21 INFO - PROCESS | 1650 | |0;ai-astar;106;116;120;117;119;119;117;118;118;116 14:53:21 INFO - PROCESS | 1650 | |1;audio-beat-detection;151;112;113;146;114;116;112;134;150;146 14:53:21 INFO - PROCESS | 1650 | |2;audio-dft;197;261;280;198;199;204;198;200;201;198 14:53:21 INFO - PROCESS | 1650 | |3;audio-fft;82;59;61;88;62;60;61;68;97;86 14:53:21 INFO - PROCESS | 1650 | |4;audio-oscillator;77;72;85;74;70;73;79;58;60;82 14:53:21 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;93;119;88;90;125;85;80;132;134;85 14:53:21 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;107;154;95;95;93;134;93;95;97 14:53:21 INFO - PROCESS | 1650 | |7;imaging-desaturate;91;95;92;111;117;98;92;92;91;90 14:53:21 INFO - PROCESS | 1650 | |8;json-parse-financial;62;64;62;63;64;63;63;63;63;62 14:53:21 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;70;68;76;88;123;110;63;90;107;109 14:53:21 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;89;92;92;86;90;90;95;101;107;115 14:53:21 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;153;160;134;140;144;144;140;162;213;182 14:53:21 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;175;176;175;177;177;174;172;176;175;175 14:53:21 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;69;71;67;68;70;64;63;91;92;67 14:53:21 INFO - PROCESS | 1650 | __end_tp_report 14:53:21 INFO - PROCESS | 1650 | __start_cc_report 14:53:21 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,943 14:53:21 INFO - PROCESS | 1650 | __end_cc_report 14:53:21 INFO - PROCESS | 1650 | __startTimestamp1484607201503__endTimestamp 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | ------- Summary: start ------- 14:53:21 INFO - PROCESS | 1650 | Number of tests: 14 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:116.60 Median:118.00 stddev:3.95 (3.3%) stddev-sans-first:1.39 14:53:21 INFO - PROCESS | 1650 | Values: 106.0 116.0 120.0 117.0 119.0 119.0 117.0 118.0 118.0 116.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:140.00 stddev:17.49 (12.5%) stddev-sans-first:16.72 14:53:21 INFO - PROCESS | 1650 | Values: 151.0 112.0 113.0 146.0 114.0 116.0 112.0 134.0 150.0 146.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:213.60 Median:200.50 stddev:30.39 (15.2%) stddev-sans-first:31.63 14:53:21 INFO - PROCESS | 1650 | Values: 197.0 261.0 280.0 198.0 199.0 204.0 198.0 200.0 201.0 198.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:72.40 Median:75.00 stddev:14.32 (19.1%) stddev-sans-first:14.76 14:53:21 INFO - PROCESS | 1650 | Values: 82.0 59.0 61.0 88.0 62.0 60.0 61.0 68.0 97.0 86.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:73.00 Median:75.50 stddev:8.71 (11.5%) stddev-sans-first:9.11 14:53:21 INFO - PROCESS | 1650 | Values: 77.0 72.0 85.0 74.0 70.0 73.0 79.0 58.0 60.0 82.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:85.00 stddev:21.64 (25.5%) stddev-sans-first:22.64 14:53:21 INFO - PROCESS | 1650 | Values: 93.0 119.0 88.0 90.0 125.0 85.0 80.0 132.0 134.0 85.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:94.50 stddev:21.12 (22.3%) stddev-sans-first:21.97 14:53:21 INFO - PROCESS | 1650 | Values: 94.0 107.0 154.0 95.0 95.0 93.0 134.0 93.0 95.0 97.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:92.00 stddev:9.41 (10.2%) stddev-sans-first:9.74 14:53:21 INFO - PROCESS | 1650 | Values: 91.0 95.0 92.0 111.0 117.0 98.0 92.0 92.0 91.0 90.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 14:53:21 INFO - PROCESS | 1650 | Values: 62.0 64.0 62.0 63.0 64.0 63.0 63.0 63.0 63.0 62.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:90.40 Median:69.00 stddev:20.95 (30.4%) stddev-sans-first:20.88 14:53:21 INFO - PROCESS | 1650 | Values: 70.0 68.0 76.0 88.0 123.0 110.0 63.0 90.0 107.0 109.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:95.70 Median:90.00 stddev:9.19 (10.2%) stddev-sans-first:9.42 14:53:21 INFO - PROCESS | 1650 | Values: 89.0 92.0 92.0 86.0 90.0 90.0 95.0 101.0 107.0 115.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:157.20 Median:156.50 stddev:24.17 (15.4%) stddev-sans-first:25.58 14:53:21 INFO - PROCESS | 1650 | Values: 153.0 160.0 134.0 140.0 144.0 144.0 140.0 162.0 213.0 182.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:175.50 stddev:1.48 (0.8%) stddev-sans-first:1.56 14:53:21 INFO - PROCESS | 1650 | Values: 175.0 176.0 175.0 177.0 177.0 174.0 172.0 176.0 175.0 175.0 14:53:21 INFO - PROCESS | 1650 | 14:53:21 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:69.50 stddev:10.46 (15.1%) stddev-sans-first:11.04 14:53:21 INFO - PROCESS | 1650 | Values: 69.0 71.0 67.0 68.0 70.0 64.0 63.0 91.0 92.0 67.0 14:53:21 INFO - PROCESS | 1650 | -------- Summary: end -------- 14:53:21 INFO - PROCESS | 1650 | 14:53:22 INFO - TEST-INFO | 1650: exit 0 14:53:22 INFO - TEST-OK | kraken | took 61365ms 14:53:22 INFO - SUITE-END | took 1177s 14:53:22 INFO - Completed test suite (00:19:37) 14:53:22 INFO - javascript benchmark 14:53:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7248.83248375817, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.125327414871, 3379.2903490267045, 3422.127357523832, 3424.092615456906, 3431.8112503812295, 5071.594272458204, 5680.886382272352, 5720.342160651527, 5762.53899688025, 5798.942010579893, 5641.830745077655, 5765.625234359763, 5812.0, 5849.473547380735, 5902.321233058199, 5159.122949098643, 5185.325907632003, 5258.50044245796, 5279.340082489689, 5313.521783039526, 5200.167973124301, 5279.70961597112, 5344.465553444663, 5354.732263386815, 5404.081306177959, 5122.718250496221, 5172.715500647463, 5284.682919024871, 5297.735113244342, 5314.548263397616, 5176.482351764831, 5188.662736922126, 5221.242919776649, 5222.712750798704, 5230.895382092337, 5200.531952124289, 5211.062008838408, 5232.816851410183, 5253.448387919251, 5275.551578115865, 4512.729236245803, 5630.183623374588, 5728.713564321767, 5801.477866991949, 5808.651480911159, 6161.9691901540655, 6189.133521306976, 6286.0, 6287.559870809046, 6291.937080629181, 4938.629602779806, 5627.324721033461, 6213.161223234896, 6239.438450539428, 6254.0, 4071.063655359284, 4526.343680166357, 5863.824085277449, 5950.9107363389585, 5958.731857066442, 6193.504519638418, 6303.432691057827, 6382.84042898922, 6401.55189136756, 6407.263164736022, 6120.17377654011, 6123.0, 6123.4351415035735, 6125.142480052797, 6184.969075154685, 5223.268742376071, 6177.351378105324, 6243.937560624427, 6279.152314437492, 6279.7802076928, 6142.621558143003, 6203.720832562545, 6218.098375735493, 6242.406971337716, 6249.343818899041, 6149.016157414792, 6178.474829639531, 6197.101420294032, 6293.96853015732, 6326.335734747877, 5005.249212618063, 5007.349044624176, 5008.17365134756, 5043.142665746832, 5071.771770270347, 4482.305242687388, 4500.324951257272, 4518.548145185455, 4525.7510836904285, 4578.748168850679, 5876.823695289148, 5882.794102206402, 5891.882162356815, 5900.262467191601, 5925.851853703692, 6066.817995460143, 6219.813405597839, 6254.843628909313, 6269.8746025079245, 6278.937210627927, 5736.6558006519745, 5781.248437703071, 5806.564507661942, 5819.709014549256, 5821.2141360916585, 5452.263944367539, 5479.4520547944885, 5486.396496385394, 5500.532454741392, 5512.779488820403, 6166.445019948136, 6258.593191442542, 6333.6516491591565, 6336.0, 6355.841103972345, 6207.906881396692, 6276.497880169484, 6285.654289014148, 6293.339199383999, 6316.557840951089, 6414.422701956846, 6431.871362572816, 6438.098666186831, 6450.483961282992, 6460.967695161682, 5105.285260063668, 6082.90875636857, 6161.9691901542, 6269.059641053878, 6317.6209427434505, 5180.430152683277, 6245.594036387621, 6246.750129994931, 6254.781082662085, 6283.3716628338625, 6155.446009859134, 6172.074188871705, 6208.72060757258, 6216.347283535345, 6249.093881387083, 6052.425019623129, 6067.635941843503, 6121.510279177744, 6126.908096378469, 6148.292946311231, 4420.9115817684105, 4914.410270767531, 5211.0359583475665, 6027.939720602738, 6028.186194863637, 4984.476629953802, 6169.2288463942, 6200.0, 6212.347703491249, 6225.564210505221, 5896.7936122235515, 5953.91069133972, 6010.158577799024, 6082.087686847009, 6099.75600975956], "value": 5671.242401272013, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.86175854605796, 467.9812807487701, 498.52390966626854, 513.8612574604856, 519.1719207863459, 40806.38790418142, 43224.567754322445, 43228.567714322846, 43253.35119973203, 43258.0, 43406.565934340644, 44143.33784993228, 44180.89547761308, 44356.556434435646, 44406.0, 7965.0, 8661.870071948926, 8804.603792829337, 9233.815323693521, 9592.616295348178, 11218.495167717472, 11513.078953683686, 11534.942325288363, 11655.358955257458, 11702.414879256046, 9767.267454940873, 11512.597059102933, 11518.942405287962, 11568.59509917153, 11605.30368177912, 11472.598459053936, 11559.364234967074, 11570.305781653085, 11585.015273701745, 11600.013998810027, 11360.545578176945, 11434.142439317002, 11441.313521188755, 11477.655670329903, 11478.253913495597, 33665.32669346624, 40624.79687601543, 41005.1798964022, 41076.0, 41256.96857578555, 3367.124547617637, 3977.482927219443, 4006.719529632927, 4071.8982025449304, 4079.7552146870985, 30275.69724302751, 30456.086317410514, 30774.0, 30822.53766193509, 30841.537376939363, 3192.457282262021, 3202.4235637585225, 3210.550522926792, 3217.373221235252, 3290.720288775457, 367441.0, 368009.0, 368521.0, 369483.0, 370563.0, 63171.684141579, 63246.0, 63468.682656586425, 63522.682386587774, 63576.41058973563, 61879.0, 65350.673246633465, 65660.6716966412, 65964.34035659677, 65969.34030659632, 15851.762223566655, 16224.188790560425, 16368.263428145761, 16388.0, 16452.588685282964, 11382.829257561143, 11647.010004149573, 12469.189502682297, 12630.81053784194, 12732.172408793398, 17329.48011559655, 17458.738118928228, 17492.12539373026, 17494.912525437292, 17519.29922803099, 6747.426468750211, 6771.3905748482875, 6793.93206067933, 6831.9658401707675, 6834.316568343225, 753.6194221917897, 839.0, 863.4689665855453, 865.5499140446932, 866.9176428239307, 26914.461710766067, 29867.436828877122, 30204.54693179604, 30235.395292094476, 30705.0, 993.3940296419179, 994.3139233928711, 1010.570507534295, 1010.9961926734917, 1015.6546774096843, 11504.884951150381, 13229.867701323055, 13557.0, 14426.206558639376, 14754.188519631309, 614518.0, 619491.0, 620799.0, 620862.0, 622418.0, 51947.74026129845, 52191.0, 52251.0, 52347.73826130845, 52360.738196308776, 1392.6518370407398, 1404.4803422733653, 1434.698713270225, 1438.841727409984, 1439.2731670506537, 23468.882655587295, 26125.954961801315, 27499.45001100007, 27766.0, 27930.720692792813, 45708.77145614383, 46087.76956115198, 46169.53830461652, 46188.307175391725, 46195.0, 457896.0, 459572.0, 460978.0, 461292.0, 463717.0, 18962.52593685169, 23269.0, 24500.0, 24633.753662463147, 25308.746912530638, 34383.0, 41356.0, 41987.79006105072, 42442.45345279293, 43143.0, 35471.0, 35801.64198357983, 36351.818240909684, 36630.63369366379, 36678.44982325214, 33880.66119338775, 35121.64878351184, 35580.93257202288, 35994.10014749652, 36233.81883090568, 34180.48729269113, 34264.31471370509, 34716.82641586877, 34723.13192170216, 35172.47241291332, 28181.45002024908, 30050.248743780707, 31259.84370078135, 32340.029799106065, 32436.94538182727, 21855.907204639385, 24023.51952960896, 24273.635895461935, 24484.762032124923, 24490.63264051005], "value": 19336.345940176092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8867562380038, 387.778965989386, 394.72145335464506, 398.2592378176591, 420.6718759367694, 17298.13509324535, 20433.386998390055, 20849.06179221935, 21294.680579791315, 21333.786662133392, 21682.566348673015, 21813.890930545364, 22032.228871989482, 22194.88902555489, 22465.775342246572, 5750.942490575083, 5982.581219314649, 6024.759009639609, 6044.788432404866, 6066.817995460143, 5616.297962754656, 5775.624584402021, 5921.141434492018, 5964.3737407572235, 6002.3997600239845, 5790.884182316372, 5801.593888427812, 5804.912926306109, 5807.854803629901, 5839.678817665027, 5570.944290557083, 5784.942150578482, 5790.160426738121, 5792.768289268424, 5869.207656966298, 4952.306677065214, 5188.455212202702, 5194.480551944813, 5194.974025129888, 5195.818146364859, 25786.74213257862, 26056.478870422674, 26199.083032093975, 26438.73561264382, 26556.86721566399, 2797.8321300722023, 2812.6624805023325, 2815.4932112219794, 2828.9575656365173, 2832.504311745436, 15457.304421301069, 15473.5357939262, 15566.455174068853, 16393.262303196385, 16628.25172867224, 1802.8828126171757, 1843.4008947092248, 1843.8985855777926, 1850.5281153305955, 1851.7314989326608, 129706.0, 130501.0, 131044.0, 132514.68713282148, 133184.33407832898, 11608.593699220486, 11718.472668729928, 11846.585369512199, 11957.162998590014, 11980.161388702882, 14970.62573435651, 15107.773383399257, 15119.319630616648, 15124.470643527424, 15152.242387880782, 8680.0, 8868.955655221811, 8959.10408959112, 9069.54652267384, 9154.725358239264, 8666.480011199348, 8782.868256976151, 8814.162654547808, 8952.462852228757, 8975.820483590292, 6109.908351374733, 6622.801315960529, 6966.094407726963, 7298.744543940937, 7445.702171913063, 1655.0, 1657.991710041442, 1668.8664906807426, 1944.2417457191707, 1986.5728868293386, 884.5311984648147, 886.2776836877924, 897.6095398501673, 906.5784410249134, 908.9590968406305, 15891.761623575656, 16469.0, 20867.64360316605, 22142.22502212415, 22438.43903902383, 874.1957399192758, 885.7785553611598, 930.6417029443713, 951.5717926932908, 957.1720461800493, 6575.506836987245, 6815.454763618898, 6946.895796563055, 7112.182099058571, 7114.466415018895, 386873.0, 743020.0, 748410.0, 750331.0, 761826.0, 124488.37755811164, 142030.0, 152411.0, 160394.39605604028, 162788.0, 462.70849364899897, 472.99054018920117, 473.06569525188166, 473.90048089901507, 474.6321600759439, 9995.800503939574, 11518.308901465938, 11580.305181689126, 11672.824907626562, 12012.879871201176, 58635.53411164755, 62662.373376265656, 62981.05528416986, 63020.36979630145, 63046.0, 87553.1244687545, 92660.0, 92785.53607231921, 92796.0, 93224.0, 8275.83448331042, 8377.748667539983, 8523.360747943805, 8967.461952282883, 8988.46069235848, 11264.549418023515, 12868.871311286768, 13027.283499407624, 13579.388927498088, 13593.59219223425, 11077.889221107685, 11532.308061516336, 11534.769304614028, 11670.241434306743, 11766.941165294118, 4563.247064234364, 6204.689765511796, 10572.41851698164, 10898.0383530962, 11241.0, 9768.902310976799, 11317.943410282896, 11674.241174323643, 11807.76384472323, 11863.347515886364, 7663.31030207284, 8287.466818638572, 8391.790205244917, 8538.914610853812, 8605.35459840502, 8309.916900831156, 11385.715357116138, 11695.649130526097, 11784.0, 11852.881471185177], "value": 9568.246755053693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.5418940802494, 1397.643600881775, 1439.93520291587, 1465.6628975335673, 1479.3564799312296, 7471.962640186805, 7759.5344279343135, 7969.442139050268, 8394.0, 8414.705485308015, 7944.721934732285, 8139.267465928066, 8165.0, 8264.214899584545, 8303.833923321545, 2192.7697591752917, 2238.250186187629, 2240.932772016842, 2242.618754811686, 2250.8762018089, 2060.2171174953573, 2125.968110478344, 2267.331137314488, 2303.34354708908, 2303.884805759714, 2238.0, 2311.456807650201, 2318.675385446039, 2321.071571371448, 2330.9650355244685, 2276.146445083094, 2280.8631482111127, 2298.4368829636765, 2299.6665483504967, 2309.1340747219792, 2262.5361800830956, 2291.7708229177115, 2308.9609675645856, 2336.158982766203, 2350.8001819845335, 8361.790955226108, 8362.749117526484, 8417.452865563719, 8420.326373890073, 8433.620487078097, 4355.412019377375, 4632.513586073481, 5078.13671675816, 5219.060569097561, 5226.268322434862, 2859.4709978654014, 2878.352370716572, 3227.854746536388, 3516.0, 3536.8231588420476, 1201.4113084588575, 1217.1662411248324, 1247.6444213399138, 1268.0489632775418, 1270.9618711438673, 10643.254972151952, 10835.891641083646, 10866.45667716611, 10873.238873278873, 10926.562937482411, 4319.697621166488, 4472.306792447176, 4559.361689363492, 4562.429696287964, 4677.4387073550715, 9474.526273686288, 9510.239180865514, 9524.238060955246, 9537.856932146024, 9556.283278754121, 5232.686038837682, 5240.371155461369, 5244.947550524522, 5252.579793616502, 5258.815941442108, 4606.262997920317, 4779.187538118528, 4799.808007679654, 4818.590419814285, 4838.225883858566, 3790.8104594770152, 3831.3678243090135, 3860.652541271299, 3917.314469967744, 3928.4107383892647, 1149.7298134938283, 1190.815423609342, 1237.962861114168, 1242.2670624331506, 1260.7667581497453, 784.5371230973639, 837.3008537870946, 891.3092353426147, 905.2486436258022, 935.5930170375908, 5544.417836127229, 5567.359753628384, 5605.691686957175, 5714.342591809163, 5846.123081537803, 880.9471431714118, 1000.659775676259, 1009.7828966772179, 1020.0921180149672, 1028.0747327405395, 3751.643593858579, 3759.9060023499633, 3809.257194846978, 3864.2078373933837, 3867.149227170018, 9761.0, 9958.651447199314, 10057.949710251549, 10074.74813129663, 10101.898981010243, 10026.197904167795, 10026.398416095057, 10047.296689231829, 10076.949615252024, 10086.092251697382, 7463.0, 7779.688812447552, 7831.765047048484, 7920.722774702857, 7922.247386498273, 5363.927214557182, 5657.773689052392, 5767.134929760569, 5822.359540450631, 5909.8227053188475, 7941.960290198512, 8978.416402933788, 9139.954300228455, 9265.953670231605, 9330.533473326443, 9309.255259579082, 9412.764680883032, 9418.4819834907, 9539.713808585753, 9650.95174524123, 7119.82200444993, 7212.71149154028, 7234.385077268491, 7235.963820180866, 7251.492395532262, 7795.220477952386, 7801.102873169658, 7801.687932482637, 7902.644381002754, 7903.802404939923, 6425.5502114851515, 7127.928720712726, 7156.320149585781, 7183.03029091087, 7213.819654508679, 5720.6853623049465, 7003.159620845531, 7046.084009078787, 7066.364027237573, 7080.114985626797, 6077.7208546794955, 6177.042558403455, 6179.81460556184, 6183.103449999635, 6195.256569211723, 4675.555822196886, 4767.547083027107, 4827.831025914076, 4906.411230652202, 4977.651564390603, 4236.6187043166265, 4963.925541116814, 5035.219540971156, 5085.160948443613, 5129.179331306973], "value": 4391.027986145461, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2607589252302, 359.99280014399704, 372.5678213272603, 373.6133102239183, 376.4879763521612, 4836.637252206081, 5190.1176799944005, 5406.513413792758, 5608.130739735338, 5636.915446268305, 4998.475160108191, 5370.194470829368, 5382.515573598375, 5422.4306447823, 5422.457754224575, 4190.700882726349, 4199.916001679964, 4228.619424251817, 4239.745615263078, 4249.001484651105, 3487.08828128513, 4132.814023368941, 4199.5380508144235, 4249.426327445802, 4250.829966801324, 3356.244844909888, 3394.6435624259466, 3519.944016794964, 4155.859732237885, 4179.728317659343, 4172.895677608054, 4179.331306990882, 4179.853705120307, 4200.621944025022, 4232.280512312884, 3690.944635830465, 3697.7411581189326, 3709.9072523186865, 3717.126475278307, 3745.382011968022, 3799.7150213733803, 4332.67504937131, 4716.504766999485, 5246.213068039787, 5315.840524784263, 4666.440027196724, 4835.734034628094, 4855.465898751135, 4862.513748625109, 4879.756012199411, 5030.723310217936, 5159.3247427829465, 5406.269833733979, 5725.513331366838, 5749.8275051748515, 3488.6336934621754, 3863.7102217333813, 4023.9537720192666, 4089.89775255618, 4113.568075352075, 4569.565891240327, 5182.740862956837, 5828.03837366834, 6006.459418652298, 6013.5489838261865, 3685.3919103348185, 3719.702423806089, 4017.4978127734034, 4169.45797046382, 4196.979015104905, 3975.827130996363, 4110.260153172398, 4172.812223449952, 4257.595528424795, 4262.50812215722, 4406.823727050946, 4859.829905953275, 4868.95131048692, 4873.26900964851, 4879.365682461257, 4872.731999740048, 5367.355917289872, 5714.342850572238, 5782.756707307864, 5801.88396232073, 1115.893990070942, 1150.6030419505257, 1286.2668279080833, 1359.8436179839248, 1381.7996390523317, 898.8135660927644, 968.6706519783166, 979.5396163803001, 984.4634674102631, 992.9304948653669, 4295.871123866289, 4773.403324584427, 4891.559759621651, 4932.26016097581, 5095.063875727274, 5272.629116429756, 5296.887653592788, 5350.411454739976, 5499.9925027364725, 5601.019821531216, 4279.358096285519, 4347.91300175911, 5029.30346195546, 5047.268146118792, 5127.794888204505, 2802.341449759305, 2940.3237255430945, 3003.294225856922, 3018.5321275202377, 3040.4223197592387, 5028.723420211851, 5705.828825135252, 5838.328592211865, 5868.823935281948, 5921.67430791302, 4967.602591792648, 5727.39862314451, 5824.854378640568, 5833.774907269521, 5886.116442738368, 4999.275105109811, 5346.7861285548925, 5893.9115913260475, 5911.142884281755, 5914.550935020948, 5079.466656001215, 5692.686902220417, 5715.857103572278, 5725.51333136688, 5738.282714660668, 4992.825251116194, 5087.440381557952, 5259.815906443256, 5494.955958367897, 5643.689597072201, 5069.9746501267255, 5376.516113549799, 5693.971530142323, 5901.822945311647, 5920.585559010828, 3152.621685397767, 3537.9916723733613, 3587.192881601619, 3757.304898593769, 3799.3214783578064, 5228.869278268074, 5653.858653533694, 5878.823635290948, 5882.323532793613, 5898.764049437975, 4937.58086512562, 5106.514881086291, 5130.230465430215, 5805.390434004369, 5820.796272130455, 5235.345581802275, 5412.377576578587, 5555.472230138131, 5809.0, 5830.47525722687, 5349.679019258857, 5366.838994830161, 5565.860853478695, 5635.295588051494, 5668.546516278605, 5516.393196748274, 5764.394738552392, 5816.505597024131, 5819.5053420459735, 5865.618734782225, 4750.714957102585, 5113.92329115071, 5328.973355133199, 5650.971745141248, 5669.177969194526], "value": 4138.685985161086, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.3349018667543, 769.0156599552571, 790.9604519774017, 822.21889205255, 830.364770950223, 15313.0, 15941.760873586905, 16017.839821601781, 16023.519294421158, 16025.919870400632, 11273.774524509505, 12405.937970310135, 14791.112533248013, 14898.702025959474, 14940.7011859763, 675.3685304240527, 698.0053423870988, 844.4637655089032, 860.3117505995226, 876.6843936182969, 872.9127087291251, 876.8947726272825, 885.7209978856639, 886.5611522296472, 889.4040992534984, 817.8631701934316, 903.9909600903973, 940.6989763275755, 940.9905900941005, 943.3538026451868, 928.6610387208688, 934.63082082577, 936.6066252174035, 936.8173206224754, 938.7746940734208, 697.7453229571221, 698.1622053535726, 700.3136925812732, 701.4879138229121, 702.8453740177204, 12948.093633445662, 15006.849931500654, 15021.774673379909, 15766.842331576652, 15813.68372632541, 11335.603253886075, 14375.928120359436, 14419.639509012253, 14616.049956752884, 14714.33785479656, 11734.471948762326, 11749.706257343549, 11870.821937670942, 11928.642140735792, 12319.014478841671, 3699.5190625218547, 3724.4971928789537, 3730.2725968436166, 3749.6250374962287, 3828.1769419574925, 99884.0, 102539.0, 102894.97105028928, 103403.48298258535, 103920.48039759752, 10308.896911030793, 10650.520726567323, 11361.14791390649, 11422.428878556038, 11712.0, 21429.67855482169, 21584.028718707697, 21880.343589692333, 21937.670934935988, 22087.558248834932, 7791.220877912164, 7914.24814642608, 7923.762287131395, 8110.148434414302, 8209.220124088202, 4339.587739164775, 4349.739015659071, 4408.448943882015, 4414.646828253796, 4469.08383781324, 3654.3604869147794, 3718.6095459976855, 3732.1789206374556, 3744.4383342498845, 3746.737728359043, 665.8934570468701, 686.8557602903446, 688.6040526697169, 715.6707914359453, 742.2836962331376, 673.9898901516481, 685.6982927511879, 700.8458139209366, 704.3871831506519, 721.9241979592172, 9287.76780580491, 10182.745431364276, 10271.897281027244, 10374.481275936172, 10386.584536618602, 701.2776839854957, 703.3880523944099, 719.2232389019846, 722.1947528505783, 753.6759193546718, 4645.721256724607, 4868.736981820565, 4943.250219221157, 4945.8021679132435, 4985.052839960396, 99704.50147749214, 99797.0, 103097.48451257695, 103668.0, 104920.47539762252, 67064.0, 83068.58465707753, 84236.05173818886, 90712.63931041039, 94863.52568237115, 76630.0, 85513.0, 86605.0, 87951.56024219838, 89823.0, 10641.8935810644, 10701.839472407764, 10851.294665846695, 10962.013418792347, 10968.177386696188, 41890.58109418989, 43359.04884280278, 50759.731006725124, 52062.0, 52731.0, 48578.0, 51857.481425185266, 56849.72601096075, 67461.0, 69745.65127174332, 13071.477140914258, 13811.51659691906, 14023.368948397143, 14263.215523145911, 14342.282885855457, 14817.296010958878, 14853.925730371278, 14858.628534286729, 14903.32935017905, 15066.472673456376, 13520.39158237862, 13636.86363136356, 13681.863181368457, 13742.312884355943, 13789.962926481596, 13833.79249311241, 14134.858651413766, 14148.929255353658, 14420.783688244894, 14627.488037919047, 13347.09185799595, 13444.932775336452, 13488.595342139752, 13500.459981600627, 13912.930435347758, 11051.889481105087, 11204.943975280072, 11313.773724525628, 11361.43192840338, 11365.636123664883, 8607.956960215159, 10279.743006424898, 10990.065844403316, 11007.064399525809, 11057.834132487858], "value": 7607.620631551834, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 120.0, 117.0, 119.0, 119.0, 117.0, 118.0, 118.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 112.0, 113.0, 146.0, 114.0, 116.0, 112.0, 134.0, 150.0, 146.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 261.0, 280.0, 198.0, 199.0, 204.0, 198.0, 200.0, 201.0, 198.0], "value": 213.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 61.0, 88.0, 62.0, 60.0, 61.0, 68.0, 97.0, 86.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 85.0, 74.0, 70.0, 73.0, 79.0, 58.0, 60.0, 82.0], "value": 73.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 119.0, 88.0, 90.0, 125.0, 85.0, 80.0, 132.0, 134.0, 85.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 107.0, 154.0, 95.0, 95.0, 93.0, 134.0, 93.0, 95.0, 97.0], "value": 105.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 92.0, 111.0, 117.0, 98.0, 92.0, 92.0, 91.0, 90.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 76.0, 88.0, 123.0, 110.0, 63.0, 90.0, 107.0, 109.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 92.0, 86.0, 90.0, 90.0, 95.0, 101.0, 107.0, 115.0], "value": 95.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 160.0, 134.0, 140.0, 144.0, 144.0, 140.0, 162.0, 213.0, 182.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 175.0, 177.0, 177.0, 174.0, 172.0, 176.0, 175.0, 175.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 67.0, 68.0, 70.0, 64.0, 63.0, 91.0, 92.0, 67.0], "value": 72.2, "unit": "score"}]}]} 14:53:22 INFO - Return code: 0 14:53:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:53:22 ERROR - # TBPL SUCCESS # 14:53:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:22 INFO - 2017-01-16 14:53:22.827 screenresolution[1655:11015] starting screenresolution argv=screenresolution get 14:53:22 INFO - 2017-01-16 14:53:22.830 screenresolution[1655:11015] Display 0: 1600x1200x32@60 14:53:22 INFO - 2017-01-16 14:53:22.836 screenresolution[1656:11018] starting screenresolution argv=screenresolution list 14:53:22 INFO - Available Modes on Display 0 14:53:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:23 INFO - Intel Iris: 14:53:23 INFO - Chipset Model: Intel Iris 14:53:23 INFO - Type: GPU 14:53:23 INFO - Bus: Built-In 14:53:23 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:23 INFO - Vendor: Intel (0x8086) 14:53:23 INFO - Device ID: 0x0a2e 14:53:23 INFO - Revision ID: 0x0009 14:53:23 INFO - Displays: 14:53:23 INFO - Display: 14:53:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:23 INFO - Display Serial Number: 1600x1200 60 14:53:23 INFO - Main Display: Yes 14:53:23 INFO - Mirror: Off 14:53:23 INFO - Online: Yes 14:53:23 INFO - Rotation: Supported 14:53:23 INFO - Return code: 0 14:53:23 INFO - Running post-action listener: _resource_record_post_action 14:53:23 INFO - [mozharness: 2017-01-16 22:53:23.079154Z] Finished run-tests step (success) 14:53:23 INFO - Running post-run listener: _resource_record_post_run 14:53:23 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38709760; Write bytes: 557160960; Read time: 248; Write time: 1725 14:53:23 INFO - TinderboxPrint: CPU usage
54.4% 14:53:23 INFO - TinderboxPrint: I/O read bytes / time
38,709,760 / 248 14:53:23 INFO - TinderboxPrint: I/O write bytes / time
557,160,960 / 1,725 14:53:23 INFO - TinderboxPrint: CPU idle
2,191.9 (45.6%) 14:53:23 INFO - TinderboxPrint: CPU system
964.3 (20.1%) 14:53:23 INFO - TinderboxPrint: CPU user
1,645.5 (34.3%) 14:53:23 INFO - TinderboxPrint: Swap in / out
289,914,880 / 0 14:53:23 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 258195968; Write bytes: 253662720; Read time: 18219; Write time: 558 14:53:23 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29880832; Write bytes: 302158848; Read time: 180; Write time: 1160 14:53:23 INFO - Running post-run listener: _upload_blobber_files 14:53:23 INFO - Blob upload gear active. 14:53:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:23 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:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:53:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:25 INFO - (blobuploader) - INFO - Done attempting. 14:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:26 INFO - (blobuploader) - INFO - Done attempting. 14:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:27 INFO - (blobuploader) - INFO - Done attempting. 14:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:30 INFO - (blobuploader) - INFO - Done attempting. 14:53:30 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:30 INFO - Return code: 0 14:53:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c4bc362e36ae044f83d9b5c255ef499b951b8f88f198851622c7f114a19f1cc27fe34e9625c30d5be062b4d58c0d848feff63a65a7b8d9fa506b16cbb084e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cad9229842552f309c8e056070153de65984b164be14897b439c60c7632edd0d79a4f4778bb980f8ca1d1ade69c2f0eedbb8e5ee849f87b5368a0a8bb538cea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e58d1a8c8af160cdca930fa60ea91a92f2a210a63a2e3947271b5e3f8a4cdb72d2da9468ed2026337d04099d1ec50775ffc8baa7384a67cd5ac6e636534ae80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1386946bd9e029295d97850660ae715d757d2647c91d9db9de67cea9c2ec18dc5158847971c15adc4835e6b092f22c241f36e80bac342bf2cac9f4085c133759"} 14:53:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:30 INFO - Contents: 14:53:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c4bc362e36ae044f83d9b5c255ef499b951b8f88f198851622c7f114a19f1cc27fe34e9625c30d5be062b4d58c0d848feff63a65a7b8d9fa506b16cbb084e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cad9229842552f309c8e056070153de65984b164be14897b439c60c7632edd0d79a4f4778bb980f8ca1d1ade69c2f0eedbb8e5ee849f87b5368a0a8bb538cea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e58d1a8c8af160cdca930fa60ea91a92f2a210a63a2e3947271b5e3f8a4cdb72d2da9468ed2026337d04099d1ec50775ffc8baa7384a67cd5ac6e636534ae80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1386946bd9e029295d97850660ae715d757d2647c91d9db9de67cea9c2ec18dc5158847971c15adc4835e6b092f22c241f36e80bac342bf2cac9f4085c133759"} 14:53:30 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:30 INFO - Copying logs to upload dir... 14:53:30 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.455364 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-16 14:53:30.464948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:30.469189) ========= 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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c4bc362e36ae044f83d9b5c255ef499b951b8f88f198851622c7f114a19f1cc27fe34e9625c30d5be062b4d58c0d848feff63a65a7b8d9fa506b16cbb084e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cad9229842552f309c8e056070153de65984b164be14897b439c60c7632edd0d79a4f4778bb980f8ca1d1ade69c2f0eedbb8e5ee849f87b5368a0a8bb538cea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e58d1a8c8af160cdca930fa60ea91a92f2a210a63a2e3947271b5e3f8a4cdb72d2da9468ed2026337d04099d1ec50775ffc8baa7384a67cd5ac6e636534ae80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1386946bd9e029295d97850660ae715d757d2647c91d9db9de67cea9c2ec18dc5158847971c15adc4835e6b092f22c241f36e80bac342bf2cac9f4085c133759"} build_url:https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/UiGE4eAyQiiXaQbsVzm8Cw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c4bc362e36ae044f83d9b5c255ef499b951b8f88f198851622c7f114a19f1cc27fe34e9625c30d5be062b4d58c0d848feff63a65a7b8d9fa506b16cbb084e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cad9229842552f309c8e056070153de65984b164be14897b439c60c7632edd0d79a4f4778bb980f8ca1d1ade69c2f0eedbb8e5ee849f87b5368a0a8bb538cea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e58d1a8c8af160cdca930fa60ea91a92f2a210a63a2e3947271b5e3f8a4cdb72d2da9468ed2026337d04099d1ec50775ffc8baa7384a67cd5ac6e636534ae80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1386946bd9e029295d97850660ae715d757d2647c91d9db9de67cea9c2ec18dc5158847971c15adc4835e6b092f22c241f36e80bac342bf2cac9f4085c133759"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:30.507006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:30.507313) ========= 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.BQyqU62juQ/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.lyJUKAwuNZ/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.005080 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:53:30.555480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 14:53:30.558828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 14:53:30.559151) ========= ========= Total master_lag: 0.21 =========