builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0297 starttime: 1484379378.67 results: success (0) buildid: 20170113220224 builduid: 1e169432424244c390899c65dec09ef7 revision: 6a5da724ef90edf99628489c4d773fcded43eefb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:18.672835) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:18.673265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:18.673536) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:18.711557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:18.711832) ========= 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.sLELspbehJ/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.KYC9SbrA7M/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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-13 23:36:18-- 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% 66.8M=0s 2017-01-13 23:36:19 (66.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.638858 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:19.373840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:19.374136) ========= 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.sLELspbehJ/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.KYC9SbrA7M/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.026023 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:19.423596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 23:36:19.423974) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 6a5da724ef90edf99628489c4d773fcded43eefb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 6a5da724ef90edf99628489c4d773fcded43eefb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sLELspbehJ/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.KYC9SbrA7M/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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-13 23:36:19,521 truncating revision to first 12 chars 2017-01-13 23:36:19,521 Setting DEBUG logging. 2017-01-13 23:36:19,521 attempt 1/10 2017-01-13 23:36:19,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/6a5da724ef90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 23:36:21,360 unpacking tar archive at: graphics-6a5da724ef90/testing/mozharness/ program finished with exit code 0 elapsedTime=2.112642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 23:36:21.559930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:21.560254) ========= script_repo_revision: 6a5da724ef90edf99628489c4d773fcded43eefb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:21.560658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:21.560939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 23:36:21.580888) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-13 23:36:21.581183) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sLELspbehJ/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.KYC9SbrA7M/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:36:21 INFO - MultiFileLogger online at 20170113 23:36:21 in /builds/slave/test 23:36:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 23:36:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:36:21 INFO - {'append_to_log': False, 23:36:21 INFO - 'base_work_dir': '/builds/slave/test', 23:36:21 INFO - 'blob_upload_branch': 'Graphics', 23:36:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:36:21 INFO - 'branch': 'Graphics', 23:36:21 INFO - 'buildbot_json_path': 'buildprops.json', 23:36:21 INFO - 'config_files': ('talos/mac_config.py',), 23:36:21 INFO - 'default_actions': ('clobber', 23:36:21 INFO - 'read-buildbot-config', 23:36:21 INFO - 'download-and-extract', 23:36:21 INFO - 'populate-webroot', 23:36:21 INFO - 'create-virtualenv', 23:36:21 INFO - 'install', 23:36:21 INFO - 'run-tests'), 23:36:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:36:21 INFO - 'download_minidump_stackwalk': True, 23:36:21 INFO - 'download_symbols': 'ondemand', 23:36:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:36:21 INFO - 'tooltool.py': '/tools/tooltool.py', 23:36:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:36:21 INFO - '/tools/misc-python/virtualenv.py')}, 23:36:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:36:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:36:21 INFO - 'installer_path': 'installer.exe', 23:36:21 INFO - 'log_level': 'info', 23:36:21 INFO - 'log_name': 'talos', 23:36:21 INFO - 'log_to_console': True, 23:36:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:36:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:36:21 INFO - 'opt_config_files': (), 23:36:21 INFO - 'pip_index': False, 23:36:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:36:21 INFO - 'cmd': ('bash', 23:36:21 INFO - '-c', 23:36:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:36:21 INFO - 'enabled': True, 23:36:21 INFO - 'halt_on_failure': False, 23:36:21 INFO - 'name': 'check_screen_resolution'},), 23:36:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:36:21 INFO - 'cmd': ('bash', 23:36:21 INFO - '-c', 23:36:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:36:21 INFO - 'enabled': True, 23:36:21 INFO - 'halt_on_failure': False, 23:36:21 INFO - 'name': 'check_screen_resolution'},), 23:36:21 INFO - 'run_cmd_checks_enabled': True, 23:36:21 INFO - 'sps_profile': False, 23:36:21 INFO - 'sps_profile_interval': 0, 23:36:21 INFO - 'suite': 'dromaeojs-e10s', 23:36:21 INFO - 'system_bits': '32', 23:36:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:36:21 INFO - 'title': 't-yosemite-r7-0297', 23:36:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:36:21 INFO - 'use_talos_json': True, 23:36:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:36:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:36:21 INFO - 'work_dir': 'build'} 23:36:21 INFO - [mozharness: 2017-01-14 07:36:21.789931Z] Running clobber step. 23:36:21 INFO - Running pre-action listener: _resource_record_pre_action 23:36:21 INFO - Running main action method: clobber 23:36:21 INFO - rmtree: /builds/slave/test/build 23:36:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:36:24 INFO - Running post-action listener: _resource_record_post_action 23:36:24 INFO - [mozharness: 2017-01-14 07:36:24.175032Z] Finished clobber step (success) 23:36:24 INFO - [mozharness: 2017-01-14 07:36:24.175166Z] Running read-buildbot-config step. 23:36:24 INFO - Running pre-action listener: _resource_record_pre_action 23:36:24 INFO - Running main action method: read_buildbot_config 23:36:24 INFO - Using buildbot properties: 23:36:24 INFO - { 23:36:24 INFO - "project": "", 23:36:24 INFO - "product": "firefox", 23:36:24 INFO - "script_repo_revision": "default", 23:36:24 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 23:36:24 INFO - "repository": "", 23:36:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 23:36:24 INFO - "buildid": "20170113220224", 23:36:24 INFO - "pgo_build": "False", 23:36:24 INFO - "basedir": "/builds/slave/test", 23:36:24 INFO - "buildnumber": 1, 23:36:24 INFO - "slavename": "t-yosemite-r7-0297", 23:36:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 23:36:24 INFO - "platform": "yosemite_r7", 23:36:24 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 23:36:24 INFO - "branch": "graphics", 23:36:24 INFO - "repo_path": "projects/graphics", 23:36:24 INFO - "revision": "6a5da724ef90edf99628489c4d773fcded43eefb", 23:36:24 INFO - "stage_platform": "macosx64", 23:36:24 INFO - "builduid": "1e169432424244c390899c65dec09ef7", 23:36:24 INFO - "slavebuilddir": "test" 23:36:24 INFO - } 23:36:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 23:36:24 INFO - Running post-action listener: _resource_record_post_action 23:36:24 INFO - [mozharness: 2017-01-14 07:36:24.178534Z] Finished read-buildbot-config step (success) 23:36:24 INFO - [mozharness: 2017-01-14 07:36:24.178674Z] Running download-and-extract step. 23:36:24 INFO - Running pre-action listener: _resource_record_pre_action 23:36:24 INFO - Running main action method: download_and_extract 23:36:24 INFO - mkdir: /builds/slave/test/build/tests 23:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:36:24 INFO - trying https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 23:36:24 INFO - Downloading https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/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 23:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/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 23:36:25 INFO - Downloaded 1199 bytes. 23:36:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 23:36:25 INFO - Using the following test package requirements: 23:36:25 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 23:36:25 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 23:36:25 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 23:36:25 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'jsshell-mac.zip'], 23:36:25 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 23:36:25 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 23:36:25 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 23:36:25 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 23:36:25 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 23:36:25 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:36:25 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 23:36:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:36:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 23:36:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:36:25 INFO - Fetch https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 23:36:26 INFO - Expected file size: 16316967 23:36:26 INFO - Obtained file size: 16316967 23:36:33 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 23:36:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 23:36:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:36:33 INFO - Fetch https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 23:36:33 INFO - Expected file size: 16316967 23:36:33 INFO - Obtained file size: 16316967 23:36:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 23:36:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:36:40 INFO - Fetch https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 23:36:40 INFO - Expected file size: 14403555 23:36:40 INFO - Obtained file size: 14403555 23:36:41 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')]} 23:36:41 INFO - trying https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:36:41 INFO - Downloading https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 23:36:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/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 23:36:43 INFO - Downloaded 70220546 bytes. 23:36:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:36:43 INFO - mkdir: /builds/slave/test/properties 23:36:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:36:43 INFO - Writing to file /builds/slave/test/properties/build_url 23:36:43 INFO - Contents: 23:36:43 INFO - build_url:https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:36:44 INFO - Running post-action listener: _resource_record_post_action 23:36:44 INFO - Running post-action listener: set_extra_try_arguments 23:36:44 INFO - [mozharness: 2017-01-14 07:36:44.322412Z] Finished download-and-extract step (success) 23:36:44 INFO - [mozharness: 2017-01-14 07:36:44.322539Z] Running populate-webroot step. 23:36:44 INFO - Running pre-action listener: _resource_record_pre_action 23:36:44 INFO - Running main action method: populate_webroot 23:36:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:36:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:36:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:36:44 INFO - '--tppagecycles', 23:36:44 INFO - '7'], 23:36:44 INFO - 'tests': ['tsvgm']}}, 23:36:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:36:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:36:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:36:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:36:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:36:44 INFO - 'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:36:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:36:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:36:44 INFO - 'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['damp', 'tps']}, 23:36:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:36:44 INFO - 'tests': ['damp', 'tps']}, 23:36:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['dromaeo_dom']}, 23:36:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:36:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['basic_compositor_video']}, 23:36:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:36:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['a11yr', 23:36:44 INFO - 'ts_paint', 23:36:44 INFO - 'tpaint', 23:36:44 INFO - 'sessionrestore', 23:36:44 INFO - 'sessionrestore_no_auto_restore', 23:36:44 INFO - 'tabpaint']}, 23:36:44 INFO - 'other-e10s': {'tests': ['a11yr', 23:36:44 INFO - 'ts_paint', 23:36:44 INFO - 'tpaint', 23:36:44 INFO - 'sessionrestore', 23:36:44 INFO - 'sessionrestore_no_auto_restore', 23:36:44 INFO - 'tabpaint']}, 23:36:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:36:44 INFO - 'ts_paint', 23:36:44 INFO - 'tpaint', 23:36:44 INFO - 'sessionrestore', 23:36:44 INFO - 'sessionrestore_no_auto_restore', 23:36:44 INFO - 'tabpaint']}, 23:36:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:36:44 INFO - 'ts_paint', 23:36:44 INFO - 'tpaint', 23:36:44 INFO - 'sessionrestore', 23:36:44 INFO - 'sessionrestore_no_auto_restore', 23:36:44 INFO - 'tabpaint']}, 23:36:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['a11yr', 23:36:44 INFO - 'ts_paint', 23:36:44 INFO - 'tpaint', 23:36:44 INFO - 'sessionrestore', 23:36:44 INFO - 'sessionrestore_no_auto_restore', 23:36:44 INFO - 'tabpaint']}, 23:36:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['a11yr', 23:36:44 INFO - 'ts_paint', 23:36:44 INFO - 'tpaint', 23:36:44 INFO - 'sessionrestore', 23:36:44 INFO - 'sessionrestore_no_auto_restore', 23:36:44 INFO - 'tabpaint']}, 23:36:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['tsvgx', 23:36:44 INFO - 'tsvgr_opacity', 23:36:44 INFO - 'tart', 23:36:44 INFO - 'tscrollx', 23:36:44 INFO - 'cart', 23:36:44 INFO - 'tsvg_static']}, 23:36:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:36:44 INFO - 'tsvgr_opacity', 23:36:44 INFO - 'tart', 23:36:44 INFO - 'tscrollx', 23:36:44 INFO - 'cart', 23:36:44 INFO - 'tsvg_static']}, 23:36:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:36:44 INFO - 'talos_options': ['--disable-e10s'], 23:36:44 INFO - 'tests': ['tp5o']}, 23:36:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:36:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:36:44 INFO - 'talos_options': ['--disable-e10s', 23:36:44 INFO - '--xperf_path', 23:36:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:44 INFO - 'tests': ['tp5n']}, 23:36:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:36:44 INFO - 'talos_options': ['--xperf_path', 23:36:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:36:44 INFO - 'tests': ['tp5n']}}, 23:36:44 INFO - 'talos.zip': {'path': '', 23:36:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:36:44 INFO - Running post-action listener: _resource_record_post_action 23:36:44 INFO - [mozharness: 2017-01-14 07:36:44.340752Z] Finished populate-webroot step (success) 23:36:44 INFO - [mozharness: 2017-01-14 07:36:44.340888Z] Running create-virtualenv step. 23:36:44 INFO - Running pre-action listener: _resource_record_pre_action 23:36:44 INFO - Running main action method: create_virtualenv 23:36:44 INFO - Creating virtualenv /builds/slave/test/build/venv 23:36:44 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 23:36:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:36:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:36:44 INFO - Using real prefix '/tools/python27' 23:36:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:36:45 INFO - Installing distribute.............................................................................................................................................................................................done. 23:36:48 INFO - Installing pip.................done. 23:36:48 INFO - Return code: 0 23:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:36:48 INFO - Reading from file tmpfile_stdout 23:36:48 INFO - Output received: 23:36:48 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) 23:36:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:36:48 INFO - 'HOME': '/Users/cltbld', 23:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:36:48 INFO - 'LOGNAME': 'cltbld', 23:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:48 INFO - 'MOZ_NO_REMOTE': '1', 23:36:48 INFO - 'NO_EM_RESTART': '1', 23:36:48 INFO - 'PAGER': '/bin/cat', 23:36:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:48 INFO - 'PWD': '/builds/slave/test', 23:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:36:48 INFO - 'SHELL': '/bin/bash', 23:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:36:48 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:36:48 INFO - 'USER': 'cltbld', 23:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:48 INFO - 'XPC_FLAGS': '0x0', 23:36:48 INFO - 'XPC_SERVICE_NAME': '0', 23:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:48 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 23:36:48 INFO - Cleaning up... 23:36:48 INFO - Return code: 0 23:36:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:36:48 INFO - 'HOME': '/Users/cltbld', 23:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:36:48 INFO - 'LOGNAME': 'cltbld', 23:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:48 INFO - 'MOZ_NO_REMOTE': '1', 23:36:48 INFO - 'NO_EM_RESTART': '1', 23:36:48 INFO - 'PAGER': '/bin/cat', 23:36:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:48 INFO - 'PWD': '/builds/slave/test', 23:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:36:48 INFO - 'SHELL': '/bin/bash', 23:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:36:48 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:36:48 INFO - 'USER': 'cltbld', 23:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:48 INFO - 'XPC_FLAGS': '0x0', 23:36:48 INFO - 'XPC_SERVICE_NAME': '0', 23:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:48 INFO - Downloading/unpacking psutil>=3.1.1 23:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:36:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:52 INFO - Installing collected packages: psutil 23:36:52 INFO - Running setup.py install for psutil 23:36:52 INFO - building 'psutil._psutil_osx' extension 23:36:52 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 23:36:53 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 23:36:53 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 23:36:53 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 23:36:53 INFO - building 'psutil._psutil_posix' extension 23:36:53 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 23:36:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:36:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:36:53 INFO - ^ 23:36:53 INFO - 1 warning generated. 23:36:53 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 23:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:36:53 INFO - Successfully installed psutil 23:36:53 INFO - Cleaning up... 23:36:53 INFO - Return code: 0 23:36:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:36: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')]} 23:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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')]} 23:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:36: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:36: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 mozsystemmonitor==0.3 23:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:36:53 INFO - 'HOME': '/Users/cltbld', 23:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:36:53 INFO - 'LOGNAME': 'cltbld', 23:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:53 INFO - 'MOZ_NO_REMOTE': '1', 23:36:53 INFO - 'NO_EM_RESTART': '1', 23:36:53 INFO - 'PAGER': '/bin/cat', 23:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:53 INFO - 'PWD': '/builds/slave/test', 23:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:36:53 INFO - 'SHELL': '/bin/bash', 23:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:36:53 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:36:53 INFO - 'USER': 'cltbld', 23:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:53 INFO - 'XPC_FLAGS': '0x0', 23:36:53 INFO - 'XPC_SERVICE_NAME': '0', 23:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:36:54 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 23:36:54 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 23:36:54 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 23:36:54 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 23:36:54 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 23:36:54 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 23:36:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:36:56 INFO - Installing collected packages: mozsystemmonitor 23:36:56 INFO - Running setup.py install for mozsystemmonitor 23:36:56 INFO - Successfully installed mozsystemmonitor 23:36:56 INFO - Cleaning up... 23:36:56 INFO - Return code: 0 23:36:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:36:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:36:56 INFO - 'HOME': '/Users/cltbld', 23:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:36:56 INFO - 'LOGNAME': 'cltbld', 23:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:36:56 INFO - 'MOZ_NO_REMOTE': '1', 23:36:56 INFO - 'NO_EM_RESTART': '1', 23:36:56 INFO - 'PAGER': '/bin/cat', 23:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:36:56 INFO - 'PWD': '/builds/slave/test', 23:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:36:56 INFO - 'SHELL': '/bin/bash', 23:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:36:56 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:36:56 INFO - 'USER': 'cltbld', 23:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:36:56 INFO - 'XPC_FLAGS': '0x0', 23:36:56 INFO - 'XPC_SERVICE_NAME': '0', 23:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:36:57 INFO - Downloading/unpacking jsonschema==2.5.1 23:36:57 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 23:36:57 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 23:36:57 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 23:36:57 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 23:36:57 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 23:36:57 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 23:36:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:36:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:36:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:36:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:00 INFO - Downloading functools32-3.2.3-2.tar.gz 23:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:37:00 INFO - warning: no files found matching '*.txt' 23:37:00 INFO - no previously-included directories found matching 'build' 23:37:00 INFO - no previously-included directories found matching 'dist' 23:37:00 INFO - no previously-included directories found matching '.git*' 23:37:00 INFO - Installing collected packages: jsonschema, functools32 23:37:00 INFO - Running setup.py install for functools32 23:37:00 INFO - warning: no files found matching '*.txt' 23:37:00 INFO - no previously-included directories found matching 'build' 23:37:00 INFO - no previously-included directories found matching 'dist' 23:37:00 INFO - no previously-included directories found matching '.git*' 23:37:00 INFO - Successfully installed jsonschema functools32 23:37:00 INFO - Cleaning up... 23:37:00 INFO - Return code: 0 23:37:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:37:00 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')]} 23:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:00 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')]} 23:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:00 INFO - 'HOME': '/Users/cltbld', 23:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:00 INFO - 'LOGNAME': 'cltbld', 23:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:00 INFO - 'MOZ_NO_REMOTE': '1', 23:37:00 INFO - 'NO_EM_RESTART': '1', 23:37:00 INFO - 'PAGER': '/bin/cat', 23:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:00 INFO - 'PWD': '/builds/slave/test', 23:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:00 INFO - 'SHELL': '/bin/bash', 23:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:37:00 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:00 INFO - 'USER': 'cltbld', 23:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:00 INFO - 'XPC_FLAGS': '0x0', 23:37:00 INFO - 'XPC_SERVICE_NAME': '0', 23:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:37:00 INFO - Cleaning up... 23:37:00 INFO - Return code: 0 23:37:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:37:00 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')]} 23:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:00 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')]} 23:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:00 INFO - 'HOME': '/Users/cltbld', 23:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:00 INFO - 'LOGNAME': 'cltbld', 23:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:00 INFO - 'MOZ_NO_REMOTE': '1', 23:37:00 INFO - 'NO_EM_RESTART': '1', 23:37:00 INFO - 'PAGER': '/bin/cat', 23:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:00 INFO - 'PWD': '/builds/slave/test', 23:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:00 INFO - 'SHELL': '/bin/bash', 23:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:37:00 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:00 INFO - 'USER': 'cltbld', 23:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:00 INFO - 'XPC_FLAGS': '0x0', 23:37:00 INFO - 'XPC_SERVICE_NAME': '0', 23:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:01 INFO - Downloading/unpacking blobuploader==1.2.4 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:37:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:37:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:37:03 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 23:37:03 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 23:37:03 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 23:37:03 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 23:37:03 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 23:37:03 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 23:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:37:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:37: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 23:37:04 INFO - Downloading docopt-0.6.1.tar.gz 23:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:37:05 INFO - Installing collected packages: blobuploader, requests, docopt 23:37:05 INFO - Running setup.py install for blobuploader 23:37:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:37:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:37:05 INFO - Running setup.py install for requests 23:37:05 INFO - Running setup.py install for docopt 23:37:05 INFO - Successfully installed blobuploader requests docopt 23:37:05 INFO - Cleaning up... 23:37:05 INFO - Return code: 0 23:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:37: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')]} 23:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37: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')]} 23:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:05 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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:37:05 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 23:37:05 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 23:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:05 INFO - 'HOME': '/Users/cltbld', 23:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:05 INFO - 'LOGNAME': 'cltbld', 23:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:05 INFO - 'MOZ_NO_REMOTE': '1', 23:37:05 INFO - 'NO_EM_RESTART': '1', 23:37:05 INFO - 'PAGER': '/bin/cat', 23:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:05 INFO - 'PWD': '/builds/slave/test', 23:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:05 INFO - 'SHELL': '/bin/bash', 23:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:37:05 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:05 INFO - 'USER': 'cltbld', 23:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:05 INFO - 'XPC_FLAGS': '0x0', 23:37:05 INFO - 'XPC_SERVICE_NAME': '0', 23:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-2XBXoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-Van4AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-_IqZdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-spJV99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-leAtdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-dcMYt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ZPj03d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ds6ltT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:37:06 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-B0_aET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ib9fHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-VKWV7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-hpRas9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-yEv0Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-LFN7jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-QNyto7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-X1TNav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:37:07 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-Qc2u3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:37:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:37:07 INFO - Running setup.py install for manifestparser 23:37:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:37:08 INFO - Running setup.py install for mozcrash 23:37:08 INFO - Running setup.py install for mozdebug 23:37:08 INFO - Running setup.py install for mozdevice 23:37:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:37:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:37:08 INFO - Running setup.py install for mozfile 23:37:08 INFO - Running setup.py install for mozhttpd 23:37:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:37:08 INFO - Running setup.py install for mozinfo 23:37:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:37:08 INFO - Running setup.py install for mozInstall 23:37:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Running setup.py install for mozleak 23:37:09 INFO - Running setup.py install for mozlog 23:37:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Running setup.py install for moznetwork 23:37:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Running setup.py install for mozprocess 23:37:09 INFO - Running setup.py install for mozprofile 23:37:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:37:09 INFO - Running setup.py install for mozrunner 23:37:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:37:10 INFO - Running setup.py install for mozscreenshot 23:37:10 INFO - Running setup.py install for moztest 23:37:10 INFO - Running setup.py install for mozversion 23:37:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:37:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:37:10 INFO - Cleaning up... 23:37:10 INFO - Return code: 0 23:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:37:10 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')]} 23:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:10 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')]} 23:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:10 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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:37:10 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 23:37:10 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 23:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:10 INFO - 'HOME': '/Users/cltbld', 23:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:10 INFO - 'LOGNAME': 'cltbld', 23:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:10 INFO - 'MOZ_NO_REMOTE': '1', 23:37:10 INFO - 'NO_EM_RESTART': '1', 23:37:10 INFO - 'PAGER': '/bin/cat', 23:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:10 INFO - 'PWD': '/builds/slave/test', 23:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:10 INFO - 'SHELL': '/bin/bash', 23:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:37:10 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:10 INFO - 'USER': 'cltbld', 23:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:10 INFO - 'XPC_FLAGS': '0x0', 23:37:10 INFO - 'XPC_SERVICE_NAME': '0', 23:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:37:10 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-emCLVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:37:10 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)) 23:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:37:10 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ykdvhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:37:10 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)) 23:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:37:10 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-d0bHCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-NQNimr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-PTidgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-srPGxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-W9pzWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-PDFZDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-iXzKea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-bNFO7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-OzyRCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:37:11 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)) 23:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:37:11 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-vMxcVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:37:12 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)) 23:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:37:12 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-tuuywO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:37:12 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)) 23:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:37:12 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-Aa52d2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:37:12 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)) 23:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:37:12 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-EA00Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:37:12 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)) 23:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:37:12 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-G1orcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:37:12 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)) 23:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:37:12 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-lmVEs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:37:12 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)) 23:37:12 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)) 23:37:12 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)) 23:37:12 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)) 23:37:12 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)) 23:37:12 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)) 23:37:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:15 INFO - Downloading blessings-1.6.tar.gz 23:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:37:15 INFO - Installing collected packages: blessings 23:37:15 INFO - Running setup.py install for blessings 23:37:15 INFO - Successfully installed blessings 23:37:15 INFO - Cleaning up... 23:37:15 INFO - Return code: 0 23:37:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:37:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:37:15 INFO - Reading from file tmpfile_stdout 23:37:15 INFO - Current package versions: 23:37:15 INFO - blessings == 1.6 23:37:15 INFO - blobuploader == 1.2.4 23:37:15 INFO - docopt == 0.6.1 23:37:15 INFO - functools32 == 3.2.3-2 23:37:15 INFO - jsonschema == 2.5.1 23:37:15 INFO - manifestparser == 1.1 23:37:15 INFO - mozInstall == 1.12 23:37:15 INFO - mozcrash == 1.0 23:37:15 INFO - mozdebug == 0.1 23:37:15 INFO - mozdevice == 0.49 23:37:15 INFO - mozfile == 1.2 23:37:15 INFO - mozhttpd == 0.7 23:37:15 INFO - mozinfo == 0.9 23:37:15 INFO - mozleak == 0.1 23:37:15 INFO - mozlog == 3.4 23:37:15 INFO - moznetwork == 0.27 23:37:15 INFO - mozprocess == 0.24 23:37:15 INFO - mozprofile == 0.28 23:37:15 INFO - mozrunner == 6.13 23:37:15 INFO - mozscreenshot == 0.1 23:37:15 INFO - mozsystemmonitor == 0.3 23:37:15 INFO - moztest == 0.8 23:37:15 INFO - mozversion == 1.4 23:37:15 INFO - psutil == 3.1.1 23:37:15 INFO - requests == 1.2.3 23:37:15 INFO - wsgiref == 0.1.2 23:37:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:37:15 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')]} 23:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:15 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')]} 23:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:15 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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:37:15 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 23:37:15 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 23:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:15 INFO - 'HOME': '/Users/cltbld', 23:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:15 INFO - 'LOGNAME': 'cltbld', 23:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:15 INFO - 'MOZ_NO_REMOTE': '1', 23:37:15 INFO - 'NO_EM_RESTART': '1', 23:37:15 INFO - 'PAGER': '/bin/cat', 23:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:15 INFO - 'PWD': '/builds/slave/test', 23:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:15 INFO - 'SHELL': '/bin/bash', 23:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:37:15 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:15 INFO - 'USER': 'cltbld', 23:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:15 INFO - 'XPC_FLAGS': '0x0', 23:37:15 INFO - 'XPC_SERVICE_NAME': '0', 23:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 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)) 23:37:16 INFO - Cleaning up... 23:37:16 INFO - Return code: 0 23:37:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:37: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')]} 23:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37: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')]} 23:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:16 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 0x10c9e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4978f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, '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.sLELspbehJ/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.KYC9SbrA7M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 23:37:16 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 23:37:16 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 23:37:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:37:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:16 INFO - 'HOME': '/Users/cltbld', 23:37:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:16 INFO - 'LOGNAME': 'cltbld', 23:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:16 INFO - 'MOZ_NO_REMOTE': '1', 23:37:16 INFO - 'NO_EM_RESTART': '1', 23:37:16 INFO - 'PAGER': '/bin/cat', 23:37:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:16 INFO - 'PWD': '/builds/slave/test', 23:37:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:16 INFO - 'SHELL': '/bin/bash', 23:37:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:37:16 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:37:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:16 INFO - 'USER': 'cltbld', 23:37:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:16 INFO - 'XPC_FLAGS': '0x0', 23:37:16 INFO - 'XPC_SERVICE_NAME': '0', 23:37:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:37:16 INFO - Cleaning up... 23:37:16 INFO - Return code: 0 23:37:16 INFO - Running post-action listener: _resource_record_post_action 23:37:16 INFO - Running post-action listener: _start_resource_monitoring 23:37:16 INFO - Starting resource monitoring. 23:37:16 INFO - [mozharness: 2017-01-14 07:37:16.422610Z] Finished create-virtualenv step (success) 23:37:16 INFO - [mozharness: 2017-01-14 07:37:16.423607Z] Running install step. 23:37:16 INFO - Running pre-action listener: _resource_record_pre_action 23:37:16 INFO - Running main action method: install 23:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:37:16 INFO - Reading from file tmpfile_stdout 23:37:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:37:16 INFO - Reading from file tmpfile_stdout 23:37:16 INFO - Output received: 23:37:16 INFO - Usage: mozinstall [options] installer 23:37:16 INFO - Options: 23:37:16 INFO - -h, --help show this help message and exit 23:37:16 INFO - -d DEST, --destination=DEST 23:37:16 INFO - Directory to install application into. [default: 23:37:16 INFO - "/builds/slave/test"] 23:37:16 INFO - --app=APP Application being installed. [default: firefox] 23:37:16 INFO - mkdir: /builds/slave/test/build/application 23:37:16 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'] 23:37:16 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 23:37:38 INFO - Reading from file tmpfile_stdout 23:37:38 INFO - Output received: 23:37:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:37:38 INFO - Running post-action listener: _resource_record_post_action 23:37:38 INFO - [mozharness: 2017-01-14 07:37:38.873160Z] Finished install step (success) 23:37:38 INFO - [mozharness: 2017-01-14 07:37:38.873290Z] Running run-tests step. 23:37:38 INFO - Running pre-action listener: _resource_record_pre_action 23:37:38 INFO - Running main action method: run_tests 23:37:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:37:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:37:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:37:38 INFO - 2017-01-13 23:37:38.887 screenresolution[1644:11509] starting screenresolution argv=screenresolution get 23:37:38 INFO - 2017-01-13 23:37:38.890 screenresolution[1644:11509] Display 0: 1600x1200x32@60 23:37:38 INFO - 2017-01-13 23:37:38.895 screenresolution[1645:11511] starting screenresolution argv=screenresolution list 23:37:38 INFO - Available Modes on Display 0 23:37:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:37:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:37:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:37:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:37:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:37:39 INFO - Intel Iris: 23:37:39 INFO - Chipset Model: Intel Iris 23:37:39 INFO - Type: GPU 23:37:39 INFO - Bus: Built-In 23:37:39 INFO - VRAM (Dynamic, Max): 1536 MB 23:37:39 INFO - Vendor: Intel (0x8086) 23:37:39 INFO - Device ID: 0x0a2e 23:37:39 INFO - Revision ID: 0x0009 23:37:39 INFO - Displays: 23:37:39 INFO - Display: 23:37:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:37:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:37:39 INFO - Display Serial Number: 1600x1200 60 23:37:39 INFO - Main Display: Yes 23:37:39 INFO - Mirror: Off 23:37:39 INFO - Online: Yes 23:37:39 INFO - Rotation: Supported 23:37:39 INFO - Return code: 0 23:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:37:39 INFO - Python 2.7.3 23:37:39 INFO - Return code: 0 23:37:39 INFO - grabbing minidump binary from tooltool 23:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:37:39 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 0x10c7c4d30>, '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 0x10c6ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7b9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:37:39 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 23:37:39 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 23:37:39 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 23:37:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:37:39 INFO - Return code: 0 23:37:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:37:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:37:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:37:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:37:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 23:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0297 --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 23:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sLELspbehJ/Render', 23:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:39 INFO - 'HOME': '/Users/cltbld', 23:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:39 INFO - 'LOGNAME': 'cltbld', 23:37:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:37:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:39 INFO - 'MOZ_NO_REMOTE': '1', 23:37:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:37:39 INFO - 'NO_EM_RESTART': '1', 23:37:39 INFO - 'PAGER': '/bin/cat', 23:37:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:39 INFO - 'PWD': '/builds/slave/test', 23:37:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:39 INFO - 'SHELL': '/bin/bash', 23:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KYC9SbrA7M/Listeners', 23:37:39 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 23:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:39 INFO - 'USER': 'cltbld', 23:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:39 INFO - 'XPC_FLAGS': '0x0', 23:37:39 INFO - 'XPC_SERVICE_NAME': '0', 23:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 23:37:39 INFO - mozversion application_buildid: 20170113220224 23:37:39 INFO - mozversion application_changeset: 6a5da724ef90edf99628489c4d773fcded43eefb 23:37:39 INFO - mozversion application_display_name: Nightly 23:37:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:37:39 INFO - mozversion application_name: Firefox 23:37:39 INFO - mozversion application_remotingname: firefox 23:37:39 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 23:37:39 INFO - mozversion application_vendor: Mozilla 23:37:39 INFO - mozversion application_version: 53.0a1 23:37:39 INFO - mozversion platform_buildid: 20170113220224 23:37:39 INFO - mozversion platform_changeset: 6a5da724ef90edf99628489c4d773fcded43eefb 23:37:39 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 23:37:39 INFO - mozversion platform_version: 53.0a1 23:37:39 INFO - using testdate: 1484379459 23:37:39 INFO - actual date: 1484379459 23:37:39 INFO - starting webserver on 'localhost:49243' 23:37:39 INFO - SUITE-START | Running 2 tests 23:37:39 INFO - TEST-START | dromaeo_css 23:37:39 INFO - operating with platform_type : mac_ 23:37:39 INFO - Initialising browser for dromaeo_css test... 23:37:39 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpMR3Lah/profile http://localhost:49243/getInfo.html) 23:37:42 INFO - PROCESS | 1655 | 2017-01-13 23:37:42.507 plugin-container[1659:11689] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 23:37:42 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:37:42 INFO - PROCESS | 1655 | 2017-01-13 23:37:42.511 plugin-container[1659:11689] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 23:37:42 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:37:42 INFO - PROCESS | 1655 | 2017-01-13 23:37:42.511 plugin-container[1659:11689] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:37:42 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 23:37:42 INFO - PROCESS | 1655 | colorDepth:24 23:37:42 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 23:37:42 INFO - PROCESS | 1655 | __metrics 23:37:42 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 23:37:43 INFO - TEST-INFO | 1655: exit 0 23:37:43 INFO - Browser initialized. 23:37:43 INFO - Running cycle 1/1 for dromaeo_css test... 23:37:43 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpMR3Lah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:45 INFO - PROCESS | 1660 | 2017-01-13 23:37:45.739 plugin-container[1661:11809] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 23:37:45 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:37:45 INFO - PROCESS | 1660 | 2017-01-13 23:37:45.740 plugin-container[1661:11809] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 23:37:45 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:37:45 INFO - PROCESS | 1660 | 2017-01-13 23:37:45.740 plugin-container[1661:11809] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:37:55 INFO - PROCESS | 1660 | RSS: Main: 233676800 23:37:55 INFO - PROCESS | 1660 | 23:40:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 23:40:59 INFO - PROCESS | 1660 | RSS: Main: 255082496 23:40:59 INFO - PROCESS | 1660 | 23:42:43 INFO - PROCESS | 1660 | ************************* 23:42:43 INFO - PROCESS | 1660 | A coding exception was thrown and uncaught in a Task. 23:42:43 INFO - PROCESS | 1660 | 23:42:43 ERROR - PROCESS | 1660 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:42:43 INFO - PROCESS | 1660 | Full stack: 23:42:43 INFO - PROCESS | 1660 | ************************* 23:44:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 23:44:02 INFO - PROCESS | 1660 | RSS: Main: 263155712 23:44:02 INFO - PROCESS | 1660 | 23:47:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 23:47:05 INFO - PROCESS | 1660 | RSS: Main: 271695872 23:47:05 INFO - PROCESS | 1660 | 23:50:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 23:50:07 INFO - PROCESS | 1660 | RSS: Main: 267837440 23:50:07 INFO - PROCESS | 1660 | 23:53:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 23:53:11 INFO - PROCESS | 1660 | RSS: Main: 272711680 23:53:11 INFO - PROCESS | 1660 | 23:56:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 23:56:14 INFO - PROCESS | 1660 | RSS: Main: 274919424 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | __start_tp_report 23:56:14 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 23:56:14 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 23:56:14 INFO - PROCESS | 1660 | |i|pagename|runs| 23:56:14 INFO - PROCESS | 1660 | |0;dojo.html;2895.898643547475;3381.9661803381964;3388.2884594235193;3402.353552824963;3417.04322789619;4938.629602779793;5465.3330734126075;5594.804181853636;5687.203791469197;5797.855053623662;5613.270274864262;5639.830805075854;5729.0833466645345;5730.7707691692385;5760.683162426065;5168.948310516885;5211.140161873305;5219.034478621457;5226.007058658862;5287.894242115155;5169.870753231162;5208.322918020652;5275.36695596529;5307.2569840222395;5318.388385335697;4687.531246875319;5303.469653034705;5317.2821669074565;5319.813806516772;5323.574114070865;4000.5399379071196;4159.355299928486;4313.482382114135;5140.1518749406305;5159.819406320798;5178.663386879841;5204.193350030713;5233.4243233244315;5238.214267859814;5253.842384728464;4595.931061034087;5385.165299378603;5620.325560932714;5768;5777.220075289866;6110.786122485736;6120.294761999619;6142.7850025249345;6239.65681887496;6266;6216.316205217422;6270.937290627081;6285.811425657238;6288;6290.842728931768;5876.265466816648;5878.294604647427;5881.176635271066;5885;5897.941020589825;6144.8771024580155;6239.937600624026;6251.624902505864;6260.40526150015;6267.2479302484;5960;5995.160677505153;6097.115918191926;6105.793350785129;6115.816525504242;6145.016797312498;6148.508119350441;6151.200343955257;6161;6208;6093.512518998469;6098.976888192001;6130.908036379458;6140.539459540552;6153.661548614869;4805.8558243252755;5027.371578552681;6178.567500275028;6279.058141278845;6288.088227207029;5042.940982393665;5051.040302342543;5059.569936555434;5061.822836200715;5077.568406685473;4416.381706561084;4510.548945105464;4517.457905051415;4521.344405061248;4523.751193684313;5792.768289268382;5857.238558987305;5906.438888305604;5946.4648181663;5995.940040599626;6227.159333490012;6253.093301471261;6259.71831267594;6261.749530018748;6269.185005949197;5943.078822782476;5971.820845374646;6005.858886811492;6013.1581578579035;6056.152138700585;4500.482444518857;5383.892322153613;5432.864178395572;5464.754086066137;5515.172724091338;6335.619862808154;6360.840978975562;6364.459020983083;6370.713317900613;6380.393862583047;6260.342664020212;6265.937340626535;6268.467180289544;6279.529035322278;6289.40250676185;5234.869128271671;6199.8530271899845;6296.779612713533;6314.147590075465;6365.077063825812;6127.678242056309;6204.224471941007;6234.594751341148;6242.188515492957;6253.843653908689;6269.74921003173;6276.874462510816;6279.654618995999;6292.842678933063;6312.873742525216;4772.737499437425;5951.226340575698;6072.423119803611;6096.146539484387;6199.752009919553;5199.220116982483;5779.595428319977;5926.436988486087;5968.731407086605;5987.550933679904;5602.13166959122;5833.270841144857;5842.1820945066875;5869.73586188614;5895.823125306248;5992.340842507234;5995;6049.153118563317;6067.271927368744;6104.481119104926;5357.928414317074;5584.525315348241;5640.379558248507;5911.615744976562;5948.851278718067 23:56:14 INFO - PROCESS | 1660 | |1;ext.html;461.5615165592687;467.41106206180245;502.70591703853245;511.80039784484046;544.5779520871324;39735.2052958941;41771.164576708485;41867.85991050672;43922.90192745183;43973.34039989395;42326.57673423265;42972.925676858096;43045.56954430455;43102;43172;8424.073351931283;8584.570771461402;9270.026647202048;9496.810063798754;9512.57193426294;9625.518724063804;11154.832677509843;11399.202055856093;11446.313221206712;11534.019608333301;11403.030742386865;11424;11431.371274579895;11486;11508.194426390157;11356;11426.028787553068;11427.085833133413;11441.256318339281;11452.141089418326;11193;11244.26912250701;11293.887061129448;11301.943490282496;11330.58367704037;40266;40419.79790101031;40585.79707101475;40600.59399406027;40661.59338406608;3906.570277269498;3972.245273398045;4031;4050.1494686115952;4110.917781644351;24675.87662061696;29176.562351564742;29221.41557168866;29242.85378573115;29269;3150.684931506854;3242.6108866935883;3324.434846076173;3327.584051993501;3331.350386674575;373885;480377;480785;482202;486167;57376;57628.42371576314;57787.55531111756;57877;58142.12786808201;55323.44676553264;55420.445795542335;55452.16821747677;55536.44463555393;55562.277206437095;12520.31138287403;15085.019473734172;15174.544763657108;15386.384544618313;15437.691246175014;10620.840687389695;10919.454027298762;11579.363135027486;11794.410279485992;11881.643550693492;17847.196876140606;17898.194581243875;17926.5518362042;18034.098295085194;18062;6867.759628413081;7791.363813599094;7796.883046754303;7820.530768153929;7886.881696774553;700.6461736822973;844.55660778092;851.8083431227924;860.813533624599;863.5078005536784;30251.09246722602;30320.54519182214;30326.54510182349;30347.393052138832;30830.84584577063;975.4098770244042;1053.2995557953875;1061.2200032975911;1080.2816127275273;1103.713034610991;15845.841541584437;15917.761233581505;16002.199890005453;16010.759838602431;16266;622761;623182.7681723215;626679;628509;630795.0761477163;61137.69431152816;61749.382506175265;61863.6906815463;62008.379916201164;62377.68811156006;1235.604606525921;1374.3746595299115;1390.2353705461956;1413.4628841040544;1417.5322143692556;28929.276768080967;29797;29852.70147298499;30457.54313685252;30565;45447;45541.86145346393;45650.63048108562;45671.31493027541;45837.77081114573;518764;525459;526198.6421222108;527294;529039;25618.23145305644;26215.868920655274;26936.461270774867;27053.323666907698;27328.04351847676;37008.814955925045;37847.2430551393;44324.89187770332;44595.777021114685;44925.326120108875;35376.823115884254;36661.266774663825;37148.25703485969;37502;38145.237095257384;36271.274574507835;36514.45228321524;36528.817355914114;37666.811665941495;37729.81135094307;34901.12747181341;39955.54430932447;41401;41583;42277.78861105675;38141.618583813804;40235;41048.589514104475;42382.78808605937;42552.93617659583;24744.25767226986;30996.0701178965;31932.840335798173;32180.19549511281;32396.676033239364 23:56:14 INFO - PROCESS | 1660 | |2;jquery.html;344.46091866229347;382.5027464296412;392.6270043458714;395.01837932737124;407.96736261099096;16573.513972904057;17758.490528305094;20097.698534521995;20397.98010099493;21335.466613334673;21040.473988150305;21338.786612133874;21525;21889.67165492519;21922.780772192273;4583.495815460296;5741.425857414267;5893.970530147343;5945.613535120225;5958.9702051489685;5406.8918621627545;5741.483266506014;5885.558583106263;5897;5902.940970590304;5609.298837645294;5717.371089180187;5764.365919748824;5782.653040817564;5912.497437717778;5699.658020518782;5762.855928601776;5786.566007549451;5803.593748437611;5809.506191973687;4997.150484417622;5031.371078615173;5095.668781529226;5096.51583099605;5096.898062038776;25308.620370694454;25581.744182558123;25700.971961121533;25766.09818656338;26234.21297361082;2295.2425699519117;2777.388974425623;2795.343094372821;2798.916032519028;2818.070036887822;8620.741377758677;15719.292631831595;15778.684426311409;15902.840971590253;15905.739323438667;1790.5881647221213;1833.9633207335912;1854.5085552328644;1859.0518835393912;1871.8315351618419;130775;131681;132440.6755932438;134555.65444345528;134617.65382346246;11331.036861866669;11453.59912403062;11456.312621242752;11571.76856462866;11771.587994420153;14341.56975290743;14416.42334306637;14416.567502974927;14425.134491930517;14489.20309382973;8365.1216622255;8616.526091065052;8628.26659733917;8758.649654013769;8759.824803503894;7111.431085513146;7638.388928885787;8522.914770852336;8523.06246312905;8621.05168431472;5772.740226689809;5982.73077711504;7146.499745017799;7202.96398518004;7278.417726581861;1946.912388942501;1968.832649224832;1983.5239542509983;1989.8209161175273;2000.7098970649174;1046.40877903984;1049.511976930731;1053.9156867450738;1059.3485006720812;1093.1528065749108;16580.502584922473;17773.7333939991;20627.17491300361;22213.77824219651;22292.888535557544;1004.6634377483479;1057.862477877871;1088.450332582041;1090.4711215060688;1093.7101668057971;10620.468976551141;11544.480498377594;11560.24858384219;11569.132315076404;11602.825957610643;686092;689594;695375;710836.4458177676;715474;115490.8450915497;137411;138697;140820;141909;932.2821427500786;1037.372389704218;1049.9842502362471;1055.5408397347178;1061.4374381577622;18580.628387432447;19191.424257272305;19262.32581859628;19291.070892910597;19365.32221372245;46703.29945050759;55006;55179.724101380845;55545.889082218935;55885.16172257338;55581.722091390904;67785.66107169433;74399;75069;76058.15476607133;8240.83518329642;8413.747587572383;8463.534505602005;8563.015253245707;8703.521306328214;10439.321444106108;11501.48243329069;12026.458809353775;13373.732525349633;13400.664983375493;9962.402255864672;10922.781544368909;10927.344359338465;11233.943830280796;11481.253718508271;10322.741931451774;10961.232713709964;11070;11303.378314192798;11543.76912461763;9358.953205234202;10912.345259284468;11193.328400296008;11255.887441125484;11358.375289359165;8411.285040771603;8489.83020339602;8647.610857511552;8697.826043479221;8792.868106978529;8329;10046.497675116361;11816.291022538675;11975.221610595283;12038.699032523906 23:56:14 INFO - PROCESS | 1660 | |3;mootools.html;1316.3813007886292;1455.3887367305738;1457.6210185351806;1473.3738161281453;1487.5091219897436;7535.9623201883915;7782.338501227388;7881.802954926123;8223.958880205599;8249.422540422172;7963.60181990901;8186.590670466483;8257.38069644776;8285.91714082859;8301.252887240147;2278.305116939333;2312.4912519245822;2317.606006978809;2325.3953971967326;2334.159702507096;2078.5842831433697;2148.946276343096;2294.7705229477087;2326.499802542453;2337.2871274261342;2245.5733410652006;2303.078768492608;2310.6187479066016;2327.5577640248384;2332.463533387322;2288.862668239911;2296.322584837477;2309.2379514760087;2311.075569772088;2312.3409828198883;2286.371247906822;2306.0660432524855;2335.859848409101;2358.752331005237;2366.1008816649564;7143.464240181956;7897.854811052365;8371.706990255372;8443.746687599381;8461.53461559614;5025.673331233458;5123.180291153398;5160.174372100483;5161.974190129063;5164;3279.754018448626;3458.654134586546;3535.6464353564693;3544.2202715402827;3556.751027428081;1149.7298134938283;1182.278809925953;1214.4413569757921;1231.1751126745103;1232.8890399863965;10737.194710396752;10818.945905270502;10876.67369978894;10892.074173695246;10902;4568.611668008257;4657.278121891112;4664.4869064403565;4672.415948006499;4719.315699223662;9424.623015079456;9550.95224523873;9561.330706850593;9568.808623827623;9586;5203.739813009334;5227.398849132398;5232.450592687713;5232.555232805178;5241.73791310433;4559.928416822044;4698.8355407560575;4753.263244197085;4796.1127191468995;4807.423109226916;3209.406259841937;3861;3884.8251828667776;3964.266610677034;3969.6030396960073;1167.2821214952912;1175.9235649682744;1181.2440038375446;1216.841810564621;1249.743802520481;775.7595145504912;915.6886658535997;919.2737737187547;930.8231436027133;935.2751617496494;5545.279113715191;5749;5766.971165144231;5820.796272130539;5831.533477321804;854.2909385210261;973.7711637765119;984.8621193032981;990.3810118675827;1042.08296698906;3020.909372718822;3224.6936541028563;3837.1174629835295;3857.267119247334;3885.0287428142965;9703.223742100616;9977.700668979942;10057.59769609222;10057.994200579884;10080.840703319065;9796.804063918682;10028.44843533598;10031.542272143372;10043.397396156253;10044.497775111215;7652.387808975269;7967.322777563856;7987.520748755093;7998.680052797939;8003.799905002422;4482.484514280899;5528.889422211614;5547.528460080938;5607.439256074523;5616.241807356118;9076.909230907871;9120.589573469077;9222.95388523053;9285.72142835716;9308.929473110407;9236.30727695439;9384.436933783994;9400.435973841591;9544.713658590254;9547.904520954979;6708.060871477899;6799.184097908283;6838.897416538656;6843.726250950105;6852.897206542006;7762.5730584818375;7769.300762931363;7778.727744528915;7821;7839.294463498312;6505.21937367519;7139.250378710369;7183.353498185188;7192.748253811092;7217.7112915484895;7023.508354415142;7052.612106334201;7101.8579628406105;7158.355747982707;7193.136823581203;6414.775482858077;6432.45324147434;6498.220213574212;6503.414692677682;6511.511636627367;4940.407151141886;5003.774830132726;5041.269015992734;5084.51697088776;5194.194899790538;4995.650304478797;5052.69683818972;5103.821366252163;5110.79556817738;5282.339707536558 23:56:14 INFO - PROCESS | 1660 | |4;prototype.html;325.56049333399915;348.09148123397944;357.5869870299803;358.90176061252566;365.5686290177593;5050.29295898574;5102.693838369701;5153.948460515394;5193.350831146106;5442.510174084332;4292.570742925705;5049.343585333911;5151.81968631098;5177.249298851664;5270.657407268525;3204.759643026771;3602.369585322558;3750.8747375787293;4168.916621667565;4174.37384392342;3965.583613720561;4145.611220241223;4185.895352616194;4210.157968406331;4256.425382573344;3290.6873846984618;4095.508538975312;4115.506139263292;4153.667706583481;4155.4182414462;3748.582164503893;4122.175564887005;4123.8969025774295;4126.1128857295525;4131.607497287768;3158.384115097557;3678.70570354371;3697.8705745298785;3714.8699795507027;3724.9627503724887;4502.16709908668;4878.195097808857;5075.198304601887;5121.564667003309;5145.382554093533;4524.343970124313;4810.278458231258;4823.324734537167;4848.6848354857175;4850.871188083702;4596.4024676791805;4839.991403567516;4924.039812236615;5190.870228244286;5675.829725108253;3751.381022131345;3958.524977002778;4079.4492743479545;4091.787946462043;4171.520275168334;4985.800567977277;5664.603477756558;5742.196092547047;5746.540276777848;5767.538596912237;3504.842282097312;3799.8100094995693;3819.1235895566024;4178.707490475698;4187.183499217624;3685.7933597769575;3960.742551734128;3996.300647386696;4246.940233986514;4262.893427664271;3977.801109944491;4509.233430316854;4750.477447480775;4770.737609431445;4826.203676393426;5114.974425127925;5145.897082058338;5482.80810171642;5674.914876276859;5681;1224.6570960131178;1276.9489220431078;1303.3939218263554;1336.5255334356164;1342.992755433425;960.9711708648751;980.3431700760508;980.578351308944;981.4945303168873;986.7024862306044;4331.285337919208;4471.1728330259;4601.309803529431;4676.08816280822;5005.399352077774;5055.093321340244;5253.632245742761;5431.945680543223;5467.617266791286;5481.314835645544;4830.951690483121;4974.463023857858;4994.875128121826;5001.199808030698;5019.837502373482;2293.8552453456073;2530.708968468613;2798.818076825;2823.929401764972;2829.306819829155;4842.5157484251295;5510.669359838423;5678.971605141948;5733.77064917407;5761.378572749389;4614.630829533629;4630.629549636021;4843.564079232886;5439.2866247132815;5766.846630673882;4806.519348065165;4977.825776097891;5109.591232701449;5448.9727551362785;6025.246844144482;5334.306540149756;5499.340079190522;5797.275280618102;5800.1589769484035;5811.912821307599;4732.408448943882;5011.974940125276;5043.638217681279;5444.509994100392;5818.149106937654;5533.944660553504;5983.790567330123;6016.969915150396;6058.606190597597;6120.510359171167;3227.72564332025;3309.387763263804;3441.380551500754;3626.437902125175;3899.980500097481;5074.965402504944;5430.289458820459;5754.2022265304695;5771.3651498335985;5792.623479473821;4844.442889067662;4913.410390753133;5090.734623092836;5614.466625670555;5668.773249069991;5453.945460545344;5565.3599836019375;5583.7106786217455;5593.860153496195;5627.971860140673;5471.781128754806;5484.91772623403;5493.7089783899955;5517.4275331530325;5533.474319939599;4646.86059418218;4858.514148585114;5533.667979921057;5567.103027880419;5669.433056694297;4636.629069674485;4906.975465122651;5434.10337294342;5453.018456677836;5494.5054945055135 23:56:14 INFO - PROCESS | 1660 | |5;yui.html;712.2983860897016;713.2439614009154;730.5616630021987;786.8504984053029;833.1168960901445;14708.191049492274;15526.689466210682;15538.223088845569;15597.376104955789;15602.921985390072;11676.708082297926;13134.60596182116;13556.457741690321;14546.854531454708;14661.486847960323;678.0541145102567;705.5872314695883;726.4442701333484;772.934300584451;842.5787106446777;869.1569177897429;881.6385282034336;882.1266945723719;882.8190221004679;884.650563027607;894.8120894612139;933.3559843707853;934.5047125023714;936.2509992006402;938.8826396700413;912.8174365126968;927.2303987690201;930.0978051290238;930.2186163622522;930.6928713524554;658.6904155047121;689.1729924091111;693.2859155070286;695.0373732380639;697.1982220446477;14035.157890526601;14143.787843182361;14182.219977901212;15361.615959600987;15767.921160394124;14085;14351.712965740731;14385.640358991004;14451.566453006426;14476.782848257284;9107.590158442887;10817.18871084664;11739.413029348583;11744;11875.703107422298;4492.393526873896;4539.4098767160385;4545.704529205591;4570.634349252052;4636.072785442925;112736.87263127428;114319.42840285745;114992;115462;116042;10783.622573210057;10944.124470042378;11017.228793984345;11097.1122310215;11194.44027798623;21297.57404851894;21548.245811396526;21580.56838863214;21593.02831372592;21642.675359869616;7585.924140758521;7611.124720657195;7729.768106956801;7799.06411230656;7958.3235424989525;4177.248095342868;4239.130978149534;4251.192273468031;4263.786810659454;4361.476622805284;3275.4268003099837;3320.3027364253294;3466.1507930557177;3519.9472007919903;3546.219831637036;646.8350570604466;651.1469974333638;655.52474456019;655.8589903170841;664.0603545982477;518.6272801931179;530.8672831792052;541.8103663717667;543.6900966449086;544.8964696707612;8616.879805625229;9139.725808225763;9903.504824758733;10035.849462258071;10064.094231519199;447.55133968354454;517.5730022731186;538.5244430261057;543.3344153412118;591.4765432592187;4732.432108146975;4796.640251981115;4802;4805.327254184417;4807.471178170468;86247.56876215579;104711;104838;106686;110370.44814775875;95358.0464195363;96092.07815843644;96420;98435;98699.50650246846;83942;83986.16013839905;84922.15077849143;85088;86004.56997715097;7710.653020613973;8418.663253469793;9275.76810579741;9277.721668349961;9413.949216585568;54353.18470223029;54507.18660167479;54956;56311.87376252534;56613.716931416726;65354;68275.29311767047;70947;72814;73537;9678.370905891095;10867.184961127788;10986.945065274622;11006.834897476385;11020.669379918616;11978.221415607957;12049.578264760692;12094.213876098025;12336.691582710504;12532.749345012866;11683.766324673288;11834.408279586158;11963.820542691692;12298.323592202514;12314.199577027464;10997.230193886351;11260.774784504429;11489.425528723363;11600.071994240272;11855;10198.133158681596;10637.468126593485;11619.535218591162;11761.941190293994;12055.21641093326;9731.978142294956;9776.120149186607;9893.65372211969;9950.800983980425;10007.899921000697;9180.770480738034;9196.218321442751;9199.954000229956;9215.354925155174;9219.308551858772 23:56:14 INFO - PROCESS | 1660 | __end_tp_report 23:56:14 INFO - PROCESS | 1660 | __start_cc_report 23:56:14 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,369 23:56:14 INFO - PROCESS | 1660 | __end_cc_report 23:56:14 INFO - PROCESS | 1660 | __startTimestamp1484380574115__endTimestamp 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | ------- Summary: start ------- 23:56:14 INFO - PROCESS | 1660 | Number of tests: 6 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5675.65 Median:5911.62 stddev:687.23 (11.6%) stddev-sans-first:653.83 23:56:14 INFO - PROCESS | 1660 | Values: 2895.9 3382.0 3388.3 3402.4 3417.0 4938.6 5465.3 5594.8 5687.2 5797.9 5613.3 5639.8 5729.1 5730.8 5760.7 5168.9 5211.1 5219.0 5226.0 5287.9 5169.9 5208.3 5275.4 5307.3 5318.4 4687.5 5303.5 5317.3 5319.8 5323.6 4000.5 4159.4 4313.5 5140.2 5159.8 5178.7 5204.2 5233.4 5238.2 5253.8 4595.9 5385.2 5620.3 5768.0 5777.2 6110.8 6120.3 6142.8 6239.7 6266.0 6216.3 6270.9 6285.8 6288.0 6290.8 5876.3 5878.3 5881.2 5885.0 5897.9 6144.9 6239.9 6251.6 6260.4 6267.2 5960.0 5995.2 6097.1 6105.8 6115.8 6145.0 6148.5 6151.2 6161.0 6208.0 6093.5 6099.0 6130.9 6140.5 6153.7 4805.9 5027.4 6178.6 6279.1 6288.1 5042.9 5051.0 5059.6 5061.8 5077.6 4416.4 4510.5 4517.5 4521.3 4523.8 5792.8 5857.2 5906.4 5946.5 5995.9 6227.2 6253.1 6259.7 6261.7 6269.2 5943.1 5971.8 6005.9 6013.2 6056.2 4500.5 5383.9 5432.9 5464.8 5515.2 6335.6 6360.8 6364.5 6370.7 6380.4 6260.3 6265.9 6268.5 6279.5 6289.4 5234.9 6199.9 6296.8 6314.1 6365.1 6127.7 6204.2 6234.6 6242.2 6253.8 6269.7 6276.9 6279.7 6292.8 6312.9 4772.7 5951.2 6072.4 6096.1 6199.8 5199.2 5779.6 5926.4 5968.7 5987.6 5602.1 5833.3 5842.2 5869.7 5895.8 5992.3 5995.0 6049.2 6067.3 6104.5 5357.9 5584.5 5640.4 5911.6 5948.9 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:67611.15 Median:37994.43 stddev:144659.30 (380.7%) stddev-sans-first:144977.25 23:56:14 INFO - PROCESS | 1660 | Values: 461.6 467.4 502.7 511.8 544.6 39735.2 41771.2 41867.9 43922.9 43973.3 42326.6 42972.9 43045.6 43102.0 43172.0 8424.1 8584.6 9270.0 9496.8 9512.6 9625.5 11154.8 11399.2 11446.3 11534.0 11403.0 11424.0 11431.4 11486.0 11508.2 11356.0 11426.0 11427.1 11441.3 11452.1 11193.0 11244.3 11293.9 11301.9 11330.6 40266.0 40419.8 40585.8 40600.6 40661.6 3906.6 3972.2 4031.0 4050.1 4110.9 24675.9 29176.6 29221.4 29242.9 29269.0 3150.7 3242.6 3324.4 3327.6 3331.4 373885.0 480377.0 480785.0 482202.0 486167.0 57376.0 57628.4 57787.6 57877.0 58142.1 55323.4 55420.4 55452.2 55536.4 55562.3 12520.3 15085.0 15174.5 15386.4 15437.7 10620.8 10919.5 11579.4 11794.4 11881.6 17847.2 17898.2 17926.6 18034.1 18062.0 6867.8 7791.4 7796.9 7820.5 7886.9 700.6 844.6 851.8 860.8 863.5 30251.1 30320.5 30326.5 30347.4 30830.8 975.4 1053.3 1061.2 1080.3 1103.7 15845.8 15917.8 16002.2 16010.8 16266.0 622761.0 623182.8 626679.0 628509.0 630795.1 61137.7 61749.4 61863.7 62008.4 62377.7 1235.6 1374.4 1390.2 1413.5 1417.5 28929.3 29797.0 29852.7 30457.5 30565.0 45447.0 45541.9 45650.6 45671.3 45837.8 518764.0 525459.0 526198.6 527294.0 529039.0 25618.2 26215.9 26936.5 27053.3 27328.0 37008.8 37847.2 44324.9 44595.8 44925.3 35376.8 36661.3 37148.3 37502.0 38145.2 36271.3 36514.5 36528.8 37666.8 37729.8 34901.1 39955.5 41401.0 41583.0 42277.8 38141.6 40235.0 41048.6 42382.8 42552.9 24744.3 30996.1 31932.8 32180.2 32396.7 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:38391.35 Median:21707.34 stddev:116294.33 (535.7%) stddev-sans-first:116585.47 23:56:14 INFO - PROCESS | 1660 | Values: 344.5 382.5 392.6 395.0 408.0 16573.5 17758.5 20097.7 20398.0 21335.5 21040.5 21338.8 21525.0 21889.7 21922.8 4583.5 5741.4 5894.0 5945.6 5959.0 5406.9 5741.5 5885.6 5897.0 5902.9 5609.3 5717.4 5764.4 5782.7 5912.5 5699.7 5762.9 5786.6 5803.6 5809.5 4997.2 5031.4 5095.7 5096.5 5096.9 25308.6 25581.7 25701.0 25766.1 26234.2 2295.2 2777.4 2795.3 2798.9 2818.1 8620.7 15719.3 15778.7 15902.8 15905.7 1790.6 1834.0 1854.5 1859.1 1871.8 130775.0 131681.0 132440.7 134555.7 134617.7 11331.0 11453.6 11456.3 11571.8 11771.6 14341.6 14416.4 14416.6 14425.1 14489.2 8365.1 8616.5 8628.3 8758.6 8759.8 7111.4 7638.4 8522.9 8523.1 8621.1 5772.7 5982.7 7146.5 7203.0 7278.4 1946.9 1968.8 1983.5 1989.8 2000.7 1046.4 1049.5 1053.9 1059.3 1093.2 16580.5 17773.7 20627.2 22213.8 22292.9 1004.7 1057.9 1088.5 1090.5 1093.7 10620.5 11544.5 11560.2 11569.1 11602.8 686092.0 689594.0 695375.0 710836.4 715474.0 115490.8 137411.0 138697.0 140820.0 141909.0 932.3 1037.4 1050.0 1055.5 1061.4 18580.6 19191.4 19262.3 19291.1 19365.3 46703.3 55006.0 55179.7 55545.9 55885.2 55581.7 67785.7 74399.0 75069.0 76058.2 8240.8 8413.7 8463.5 8563.0 8703.5 10439.3 11501.5 12026.5 13373.7 13400.7 9962.4 10922.8 10927.3 11233.9 11481.3 10322.7 10961.2 11070.0 11303.4 11543.8 9359.0 10912.3 11193.3 11255.9 11358.4 8411.3 8489.8 8647.6 8697.8 8792.9 8329.0 10046.5 11816.3 11975.2 12038.7 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5425.73 Median:5162.99 stddev:2955.70 (57.2%) stddev-sans-first:2947.86 23:56:14 INFO - PROCESS | 1660 | Values: 1316.4 1455.4 1457.6 1473.4 1487.5 7536.0 7782.3 7881.8 8224.0 8249.4 7963.6 8186.6 8257.4 8285.9 8301.3 2278.3 2312.5 2317.6 2325.4 2334.2 2078.6 2148.9 2294.8 2326.5 2337.3 2245.6 2303.1 2310.6 2327.6 2332.5 2288.9 2296.3 2309.2 2311.1 2312.3 2286.4 2306.1 2335.9 2358.8 2366.1 7143.5 7897.9 8371.7 8443.7 8461.5 5025.7 5123.2 5160.2 5162.0 5164.0 3279.8 3458.7 3535.6 3544.2 3556.8 1149.7 1182.3 1214.4 1231.2 1232.9 10737.2 10818.9 10876.7 10892.1 10902.0 4568.6 4657.3 4664.5 4672.4 4719.3 9424.6 9551.0 9561.3 9568.8 9586.0 5203.7 5227.4 5232.5 5232.6 5241.7 4559.9 4698.8 4753.3 4796.1 4807.4 3209.4 3861.0 3884.8 3964.3 3969.6 1167.3 1175.9 1181.2 1216.8 1249.7 775.8 915.7 919.3 930.8 935.3 5545.3 5749.0 5767.0 5820.8 5831.5 854.3 973.8 984.9 990.4 1042.1 3020.9 3224.7 3837.1 3857.3 3885.0 9703.2 9977.7 10057.6 10058.0 10080.8 9796.8 10028.4 10031.5 10043.4 10044.5 7652.4 7967.3 7987.5 7998.7 8003.8 4482.5 5528.9 5547.5 5607.4 5616.2 9076.9 9120.6 9223.0 9285.7 9308.9 9236.3 9384.4 9400.4 9544.7 9547.9 6708.1 6799.2 6838.9 6843.7 6852.9 7762.6 7769.3 7778.7 7821.0 7839.3 6505.2 7139.3 7183.4 7192.7 7217.7 7023.5 7052.6 7101.9 7158.4 7193.1 6414.8 6432.5 6498.2 6503.4 6511.5 4940.4 5003.8 5041.3 5084.5 5194.2 4995.7 5052.7 5103.8 5110.8 5282.3 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4461.77 Median:4910.19 stddev:1341.10 (27.3%) stddev-sans-first:1308.43 23:56:14 INFO - PROCESS | 1660 | Values: 325.6 348.1 357.6 358.9 365.6 5050.3 5102.7 5153.9 5193.4 5442.5 4292.6 5049.3 5151.8 5177.2 5270.7 3204.8 3602.4 3750.9 4168.9 4174.4 3965.6 4145.6 4185.9 4210.2 4256.4 3290.7 4095.5 4115.5 4153.7 4155.4 3748.6 4122.2 4123.9 4126.1 4131.6 3158.4 3678.7 3697.9 3714.9 3725.0 4502.2 4878.2 5075.2 5121.6 5145.4 4524.3 4810.3 4823.3 4848.7 4850.9 4596.4 4840.0 4924.0 5190.9 5675.8 3751.4 3958.5 4079.4 4091.8 4171.5 4985.8 5664.6 5742.2 5746.5 5767.5 3504.8 3799.8 3819.1 4178.7 4187.2 3685.8 3960.7 3996.3 4246.9 4262.9 3977.8 4509.2 4750.5 4770.7 4826.2 5115.0 5145.9 5482.8 5674.9 5681.0 1224.7 1276.9 1303.4 1336.5 1343.0 961.0 980.3 980.6 981.5 986.7 4331.3 4471.2 4601.3 4676.1 5005.4 5055.1 5253.6 5431.9 5467.6 5481.3 4831.0 4974.5 4994.9 5001.2 5019.8 2293.9 2530.7 2798.8 2823.9 2829.3 4842.5 5510.7 5679.0 5733.8 5761.4 4614.6 4630.6 4843.6 5439.3 5766.8 4806.5 4977.8 5109.6 5449.0 6025.2 5334.3 5499.3 5797.3 5800.2 5811.9 4732.4 5012.0 5043.6 5444.5 5818.1 5533.9 5983.8 6017.0 6058.6 6120.5 3227.7 3309.4 3441.4 3626.4 3900.0 5075.0 5430.3 5754.2 5771.4 5792.6 4844.4 4913.4 5090.7 5614.5 5668.8 5453.9 5565.4 5583.7 5593.9 5628.0 5471.8 5484.9 5493.7 5517.4 5533.5 4646.9 4858.5 5533.7 5567.1 5669.4 4636.6 4907.0 5434.1 5453.0 5494.5 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:20906.52 Median:2662.52 stddev:31412.32 (1179.8%) stddev-sans-first:31463.84 23:56:14 INFO - PROCESS | 1660 | Values: 712.3 713.2 730.6 786.9 833.1 14708.2 15526.7 15538.2 15597.4 15602.9 11676.7 13134.6 13556.5 14546.9 14661.5 678.1 705.6 726.4 772.9 842.6 869.2 881.6 882.1 882.8 884.7 894.8 933.4 934.5 936.3 938.9 912.8 927.2 930.1 930.2 930.7 658.7 689.2 693.3 695.0 697.2 14035.2 14143.8 14182.2 15361.6 15767.9 14085.0 14351.7 14385.6 14451.6 14476.8 9107.6 10817.2 11739.4 11744.0 11875.7 4492.4 4539.4 4545.7 4570.6 4636.1 112736.9 114319.4 114992.0 115462.0 116042.0 10783.6 10944.1 11017.2 11097.1 11194.4 21297.6 21548.2 21580.6 21593.0 21642.7 7585.9 7611.1 7729.8 7799.1 7958.3 4177.2 4239.1 4251.2 4263.8 4361.5 3275.4 3320.3 3466.2 3519.9 3546.2 646.8 651.1 655.5 655.9 664.1 518.6 530.9 541.8 543.7 544.9 8616.9 9139.7 9903.5 10035.8 10064.1 447.6 517.6 538.5 543.3 591.5 4732.4 4796.6 4802.0 4805.3 4807.5 86247.6 104711.0 104838.0 106686.0 110370.4 95358.0 96092.1 96420.0 98435.0 98699.5 83942.0 83986.2 84922.2 85088.0 86004.6 7710.7 8418.7 9275.8 9277.7 9413.9 54353.2 54507.2 54956.0 56311.9 56613.7 65354.0 68275.3 70947.0 72814.0 73537.0 9678.4 10867.2 10986.9 11006.8 11020.7 11978.2 12049.6 12094.2 12336.7 12532.7 11683.8 11834.4 11963.8 12298.3 12314.2 10997.2 11260.8 11489.4 11600.1 11855.0 10198.1 10637.5 11619.5 11761.9 12055.2 9732.0 9776.1 9893.7 9950.8 10007.9 9180.8 9196.2 9200.0 9215.4 9219.3 23:56:14 INFO - PROCESS | 1660 | -------- Summary: end -------- 23:56:14 INFO - PROCESS | 1660 | 23:56:14 INFO - TEST-INFO | 1660: exit 0 23:56:14 INFO - TEST-OK | dromaeo_css | took 1115258ms 23:56:14 INFO - TEST-START | kraken 23:56:14 INFO - operating with platform_type : mac_ 23:56:14 INFO - Initialising browser for kraken test... 23:56:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpjEsS0H/profile http://localhost:49243/getInfo.html) 23:56:17 INFO - PROCESS | 1667 | 2017-01-13 23:56:17.246 plugin-container[1668:14218] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 23:56:17 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:56:17 INFO - PROCESS | 1667 | 2017-01-13 23:56:17.250 plugin-container[1668:14218] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.CFPasteboardClient' 23:56:17 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:56:17 INFO - PROCESS | 1667 | 2017-01-13 23:56:17.250 plugin-container[1668:14218] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:56:17 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 23:56:17 INFO - PROCESS | 1667 | colorDepth:24 23:56:17 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 23:56:17 INFO - PROCESS | 1667 | __metrics 23:56:17 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 23:56:18 INFO - TEST-INFO | 1667: exit 0 23:56:18 INFO - Browser initialized. 23:56:18 INFO - Running cycle 1/1 for kraken test... 23:56:18 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpjEsS0H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:56:20 INFO - PROCESS | 1669 | 2017-01-13 23:56:20.679 plugin-container[1670:14335] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 23:56:20 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:56:20 INFO - PROCESS | 1669 | 2017-01-13 23:56:20.680 plugin-container[1670:14335] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 23:56:20 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:56:20 INFO - PROCESS | 1669 | 2017-01-13 23:56:20.680 plugin-container[1670:14335] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:56:30 INFO - PROCESS | 1669 | RSS: Main: 233623552 23:56:30 INFO - PROCESS | 1669 | 23:56:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 23:56:34 INFO - PROCESS | 1669 | RSS: Main: 246190080 23:56:34 INFO - PROCESS | 1669 | 23:56:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 23:56:37 INFO - PROCESS | 1669 | RSS: Main: 254124032 23:56:37 INFO - PROCESS | 1669 | 23:56:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 23:56:41 INFO - PROCESS | 1669 | RSS: Main: 256901120 23:56:41 INFO - PROCESS | 1669 | 23:56:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 23:56:44 INFO - PROCESS | 1669 | RSS: Main: 259145728 23:56:44 INFO - PROCESS | 1669 | 23:56:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:56:47 INFO - PROCESS | 1669 | RSS: Main: 260288512 23:56:47 INFO - PROCESS | 1669 | 23:56:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 23:56:50 INFO - PROCESS | 1669 | RSS: Main: 265875456 23:56:50 INFO - PROCESS | 1669 | 23:56:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 23:56:54 INFO - PROCESS | 1669 | RSS: Main: 264785920 23:56:54 INFO - PROCESS | 1669 | 23:56:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 23:56:58 INFO - PROCESS | 1669 | RSS: Main: 264585216 23:56:58 INFO - PROCESS | 1669 | 23:57:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:57:00 INFO - PROCESS | 1669 | RSS: Main: 263704576 23:57:00 INFO - PROCESS | 1669 | 23:57:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:57:03 INFO - PROCESS | 1669 | RSS: Main: 263663616 23:57:03 INFO - PROCESS | 1669 | 23:57:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:57:06 INFO - PROCESS | 1669 | RSS: Main: 264228864 23:57:06 INFO - PROCESS | 1669 | 23:57:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:57:09 INFO - PROCESS | 1669 | RSS: Main: 264044544 23:57:09 INFO - PROCESS | 1669 | 23:57:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:57:13 INFO - PROCESS | 1669 | RSS: Main: 263872512 23:57:13 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 23:57:15 INFO - PROCESS | 1669 | RSS: Main: 265777152 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | __start_tp_report 23:57:15 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 23:57:15 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 23:57:15 INFO - PROCESS | 1669 | |i|pagename|runs| 23:57:15 INFO - PROCESS | 1669 | |0;ai-astar;108;118;118;119;119;118;119;119;118;121 23:57:15 INFO - PROCESS | 1669 | |1;audio-beat-detection;183;147;150;147;116;114;114;126;135;116 23:57:15 INFO - PROCESS | 1669 | |2;audio-dft;209;208;223;199;197;200;202;197;198;250 23:57:15 INFO - PROCESS | 1669 | |3;audio-fft;87;86;78;84;61;63;75;57;77;83 23:57:15 INFO - PROCESS | 1669 | |4;audio-oscillator;87;72;90;85;94;74;83;72;101;116 23:57:15 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;93;90;90;126;106;129;125;135;118;132 23:57:15 INFO - PROCESS | 1669 | |6;imaging-darkroom;97;128;153;96;97;96;111;155;114;98 23:57:15 INFO - PROCESS | 1669 | |7;imaging-desaturate;92;94;94;93;102;92;93;93;92;79 23:57:15 INFO - PROCESS | 1669 | |8;json-parse-financial;62;62;55;50;96;96;97;96;97;59 23:57:15 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;75;70;69;78;73;73;71;70;74;73 23:57:15 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;88;87;91;90;89;91;90;89;92;89 23:57:15 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;155;163;168;160;144;143;157;152;225;157 23:57:15 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;176;177;174;176;176;176;240;241;191;179 23:57:15 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;73;68;66;69;69;67;69;68;68;68 23:57:15 INFO - PROCESS | 1669 | __end_tp_report 23:57:15 INFO - PROCESS | 1669 | __start_cc_report 23:57:15 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,919 23:57:15 INFO - PROCESS | 1669 | __end_cc_report 23:57:15 INFO - PROCESS | 1669 | __startTimestamp1484380635543__endTimestamp 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | ------- Summary: start ------- 23:57:15 INFO - PROCESS | 1669 | Number of tests: 14 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:117.70 Median:119.00 stddev:3.53 (3.0%) stddev-sans-first:0.97 23:57:15 INFO - PROCESS | 1669 | Values: 108.0 118.0 118.0 119.0 119.0 118.0 119.0 119.0 118.0 121.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:141.00 stddev:22.36 (15.9%) stddev-sans-first:15.49 23:57:15 INFO - PROCESS | 1669 | Values: 183.0 147.0 150.0 147.0 116.0 114.0 114.0 126.0 135.0 116.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:208.30 Median:205.00 stddev:16.71 (8.1%) stddev-sans-first:17.72 23:57:15 INFO - PROCESS | 1669 | Values: 209.0 208.0 223.0 199.0 197.0 200.0 202.0 197.0 198.0 250.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:75.10 Median:80.50 stddev:10.99 (13.7%) stddev-sans-first:10.78 23:57:15 INFO - PROCESS | 1669 | Values: 87.0 86.0 78.0 84.0 61.0 63.0 75.0 57.0 77.0 83.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:84.00 stddev:13.87 (16.5%) stddev-sans-first:14.71 23:57:15 INFO - PROCESS | 1669 | Values: 87.0 72.0 90.0 85.0 94.0 74.0 83.0 72.0 101.0 116.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:133.50 stddev:18.03 (13.5%) stddev-sans-first:17.38 23:57:15 INFO - PROCESS | 1669 | Values: 93.0 90.0 90.0 126.0 106.0 129.0 125.0 135.0 118.0 132.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:114.50 Median:96.00 stddev:23.30 (24.3%) stddev-sans-first:23.84 23:57:15 INFO - PROCESS | 1669 | Values: 97.0 128.0 153.0 96.0 97.0 96.0 111.0 155.0 114.0 98.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:93.00 stddev:5.56 (6.0%) stddev-sans-first:5.90 23:57:15 INFO - PROCESS | 1669 | Values: 92.0 94.0 94.0 93.0 102.0 92.0 93.0 93.0 92.0 79.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:77.00 Median:96.00 stddev:20.74 (21.6%) stddev-sans-first:21.27 23:57:15 INFO - PROCESS | 1669 | Values: 62.0 62.0 55.0 50.0 96.0 96.0 97.0 96.0 97.0 59.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:2.72 (3.7%) stddev-sans-first:2.74 23:57:15 INFO - PROCESS | 1669 | Values: 75.0 70.0 69.0 78.0 73.0 73.0 71.0 70.0 74.0 73.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:90.00 stddev:1.51 (1.7%) stddev-sans-first:1.48 23:57:15 INFO - PROCESS | 1669 | Values: 88.0 87.0 91.0 90.0 89.0 91.0 90.0 89.0 92.0 89.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:158.50 stddev:23.32 (14.7%) stddev-sans-first:24.58 23:57:15 INFO - PROCESS | 1669 | Values: 155.0 163.0 168.0 160.0 144.0 143.0 157.0 152.0 225.0 157.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:178.00 stddev:26.73 (15.0%) stddev-sans-first:27.82 23:57:15 INFO - PROCESS | 1669 | Values: 176.0 177.0 174.0 176.0 176.0 176.0 240.0 241.0 191.0 179.0 23:57:15 INFO - PROCESS | 1669 | 23:57:15 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.84 (2.7%) stddev-sans-first:1.00 23:57:15 INFO - PROCESS | 1669 | Values: 73.0 68.0 66.0 69.0 69.0 67.0 69.0 68.0 68.0 68.0 23:57:15 INFO - PROCESS | 1669 | -------- Summary: end -------- 23:57:15 INFO - PROCESS | 1669 | 23:57:16 INFO - TEST-INFO | 1669: exit 0 23:57:16 INFO - TEST-OK | kraken | took 61710ms 23:57:16 INFO - SUITE-END | took 1176s 23:57:16 INFO - Completed test suite (00:19:37) 23:57:16 INFO - javascript benchmark 23:57:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7251.679117693687, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2895.898643547475, 3381.9661803381964, 3388.2884594235193, 3402.353552824963, 3417.04322789619, 4938.629602779793, 5465.3330734126075, 5594.804181853636, 5687.203791469197, 5797.855053623662, 5613.270274864262, 5639.830805075854, 5729.0833466645345, 5730.7707691692385, 5760.683162426065, 5168.948310516885, 5211.140161873305, 5219.034478621457, 5226.007058658862, 5287.894242115155, 5169.870753231162, 5208.322918020652, 5275.36695596529, 5307.2569840222395, 5318.388385335697, 4687.531246875319, 5303.469653034705, 5317.2821669074565, 5319.813806516772, 5323.574114070865, 4000.5399379071196, 4159.355299928486, 4313.482382114135, 5140.1518749406305, 5159.819406320798, 5178.663386879841, 5204.193350030713, 5233.4243233244315, 5238.214267859814, 5253.842384728464, 4595.931061034087, 5385.165299378603, 5620.325560932714, 5768.0, 5777.220075289866, 6110.786122485736, 6120.294761999619, 6142.7850025249345, 6239.65681887496, 6266.0, 6216.316205217422, 6270.937290627081, 6285.811425657238, 6288.0, 6290.842728931768, 5876.265466816648, 5878.294604647427, 5881.176635271066, 5885.0, 5897.941020589825, 6144.8771024580155, 6239.937600624026, 6251.624902505864, 6260.40526150015, 6267.2479302484, 5960.0, 5995.160677505153, 6097.115918191926, 6105.793350785129, 6115.816525504242, 6145.016797312498, 6148.508119350441, 6151.200343955257, 6161.0, 6208.0, 6093.512518998469, 6098.976888192001, 6130.908036379458, 6140.539459540552, 6153.661548614869, 4805.8558243252755, 5027.371578552681, 6178.567500275028, 6279.058141278845, 6288.088227207029, 5042.940982393665, 5051.040302342543, 5059.569936555434, 5061.822836200715, 5077.568406685473, 4416.381706561084, 4510.548945105464, 4517.457905051415, 4521.344405061248, 4523.751193684313, 5792.768289268382, 5857.238558987305, 5906.438888305604, 5946.4648181663, 5995.940040599626, 6227.159333490012, 6253.093301471261, 6259.71831267594, 6261.749530018748, 6269.185005949197, 5943.078822782476, 5971.820845374646, 6005.858886811492, 6013.1581578579035, 6056.152138700585, 4500.482444518857, 5383.892322153613, 5432.864178395572, 5464.754086066137, 5515.172724091338, 6335.619862808154, 6360.840978975562, 6364.459020983083, 6370.713317900613, 6380.393862583047, 6260.342664020212, 6265.937340626535, 6268.467180289544, 6279.529035322278, 6289.40250676185, 5234.869128271671, 6199.8530271899845, 6296.779612713533, 6314.147590075465, 6365.077063825812, 6127.678242056309, 6204.224471941007, 6234.594751341148, 6242.188515492957, 6253.843653908689, 6269.74921003173, 6276.874462510816, 6279.654618995999, 6292.842678933063, 6312.873742525216, 4772.737499437425, 5951.226340575698, 6072.423119803611, 6096.146539484387, 6199.752009919553, 5199.220116982483, 5779.595428319977, 5926.436988486087, 5968.731407086605, 5987.550933679904, 5602.13166959122, 5833.270841144857, 5842.1820945066875, 5869.73586188614, 5895.823125306248, 5992.340842507234, 5995.0, 6049.153118563317, 6067.271927368744, 6104.481119104926, 5357.928414317074, 5584.525315348241, 5640.379558248507, 5911.615744976562, 5948.851278718067], "value": 5632.424377543369, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.5615165592687, 467.41106206180245, 502.70591703853245, 511.80039784484046, 544.5779520871324, 39735.2052958941, 41771.164576708485, 41867.85991050672, 43922.90192745183, 43973.34039989395, 42326.57673423265, 42972.925676858096, 43045.56954430455, 43102.0, 43172.0, 8424.073351931283, 8584.570771461402, 9270.026647202048, 9496.810063798754, 9512.57193426294, 9625.518724063804, 11154.832677509843, 11399.202055856093, 11446.313221206712, 11534.019608333301, 11403.030742386865, 11424.0, 11431.371274579895, 11486.0, 11508.194426390157, 11356.0, 11426.028787553068, 11427.085833133413, 11441.256318339281, 11452.141089418326, 11193.0, 11244.26912250701, 11293.887061129448, 11301.943490282496, 11330.58367704037, 40266.0, 40419.79790101031, 40585.79707101475, 40600.59399406027, 40661.59338406608, 3906.570277269498, 3972.245273398045, 4031.0, 4050.1494686115952, 4110.917781644351, 24675.87662061696, 29176.562351564742, 29221.41557168866, 29242.85378573115, 29269.0, 3150.684931506854, 3242.6108866935883, 3324.434846076173, 3327.584051993501, 3331.350386674575, 373885.0, 480377.0, 480785.0, 482202.0, 486167.0, 57376.0, 57628.42371576314, 57787.55531111756, 57877.0, 58142.12786808201, 55323.44676553264, 55420.445795542335, 55452.16821747677, 55536.44463555393, 55562.277206437095, 12520.31138287403, 15085.019473734172, 15174.544763657108, 15386.384544618313, 15437.691246175014, 10620.840687389695, 10919.454027298762, 11579.363135027486, 11794.410279485992, 11881.643550693492, 17847.196876140606, 17898.194581243875, 17926.5518362042, 18034.098295085194, 18062.0, 6867.759628413081, 7791.363813599094, 7796.883046754303, 7820.530768153929, 7886.881696774553, 700.6461736822973, 844.55660778092, 851.8083431227924, 860.813533624599, 863.5078005536784, 30251.09246722602, 30320.54519182214, 30326.54510182349, 30347.393052138832, 30830.84584577063, 975.4098770244042, 1053.2995557953875, 1061.2200032975911, 1080.2816127275273, 1103.713034610991, 15845.841541584437, 15917.761233581505, 16002.199890005453, 16010.759838602431, 16266.0, 622761.0, 623182.7681723215, 626679.0, 628509.0, 630795.0761477163, 61137.69431152816, 61749.382506175265, 61863.6906815463, 62008.379916201164, 62377.68811156006, 1235.604606525921, 1374.3746595299115, 1390.2353705461956, 1413.4628841040544, 1417.5322143692556, 28929.276768080967, 29797.0, 29852.70147298499, 30457.54313685252, 30565.0, 45447.0, 45541.86145346393, 45650.63048108562, 45671.31493027541, 45837.77081114573, 518764.0, 525459.0, 526198.6421222108, 527294.0, 529039.0, 25618.23145305644, 26215.868920655274, 26936.461270774867, 27053.323666907698, 27328.04351847676, 37008.814955925045, 37847.2430551393, 44324.89187770332, 44595.777021114685, 44925.326120108875, 35376.823115884254, 36661.266774663825, 37148.25703485969, 37502.0, 38145.237095257384, 36271.274574507835, 36514.45228321524, 36528.817355914114, 37666.811665941495, 37729.81135094307, 34901.12747181341, 39955.54430932447, 41401.0, 41583.0, 42277.78861105675, 38141.618583813804, 40235.0, 41048.589514104475, 42382.78808605937, 42552.93617659583, 24744.25767226986, 30996.0701178965, 31932.840335798173, 32180.19549511281, 32396.676033239364], "value": 20103.614055845494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.46091866229347, 382.5027464296412, 392.6270043458714, 395.01837932737124, 407.96736261099096, 16573.513972904057, 17758.490528305094, 20097.698534521995, 20397.98010099493, 21335.466613334673, 21040.473988150305, 21338.786612133874, 21525.0, 21889.67165492519, 21922.780772192273, 4583.495815460296, 5741.425857414267, 5893.970530147343, 5945.613535120225, 5958.9702051489685, 5406.8918621627545, 5741.483266506014, 5885.558583106263, 5897.0, 5902.940970590304, 5609.298837645294, 5717.371089180187, 5764.365919748824, 5782.653040817564, 5912.497437717778, 5699.658020518782, 5762.855928601776, 5786.566007549451, 5803.593748437611, 5809.506191973687, 4997.150484417622, 5031.371078615173, 5095.668781529226, 5096.51583099605, 5096.898062038776, 25308.620370694454, 25581.744182558123, 25700.971961121533, 25766.09818656338, 26234.21297361082, 2295.2425699519117, 2777.388974425623, 2795.343094372821, 2798.916032519028, 2818.070036887822, 8620.741377758677, 15719.292631831595, 15778.684426311409, 15902.840971590253, 15905.739323438667, 1790.5881647221213, 1833.9633207335912, 1854.5085552328644, 1859.0518835393912, 1871.8315351618419, 130775.0, 131681.0, 132440.6755932438, 134555.65444345528, 134617.65382346246, 11331.036861866669, 11453.59912403062, 11456.312621242752, 11571.76856462866, 11771.587994420153, 14341.56975290743, 14416.42334306637, 14416.567502974927, 14425.134491930517, 14489.20309382973, 8365.1216622255, 8616.526091065052, 8628.26659733917, 8758.649654013769, 8759.824803503894, 7111.431085513146, 7638.388928885787, 8522.914770852336, 8523.06246312905, 8621.05168431472, 5772.740226689809, 5982.73077711504, 7146.499745017799, 7202.96398518004, 7278.417726581861, 1946.912388942501, 1968.832649224832, 1983.5239542509983, 1989.8209161175273, 2000.7098970649174, 1046.40877903984, 1049.511976930731, 1053.9156867450738, 1059.3485006720812, 1093.1528065749108, 16580.502584922473, 17773.7333939991, 20627.17491300361, 22213.77824219651, 22292.888535557544, 1004.6634377483479, 1057.862477877871, 1088.450332582041, 1090.4711215060688, 1093.7101668057971, 10620.468976551141, 11544.480498377594, 11560.24858384219, 11569.132315076404, 11602.825957610643, 686092.0, 689594.0, 695375.0, 710836.4458177676, 715474.0, 115490.8450915497, 137411.0, 138697.0, 140820.0, 141909.0, 932.2821427500786, 1037.372389704218, 1049.9842502362471, 1055.5408397347178, 1061.4374381577622, 18580.628387432447, 19191.424257272305, 19262.32581859628, 19291.070892910597, 19365.32221372245, 46703.29945050759, 55006.0, 55179.724101380845, 55545.889082218935, 55885.16172257338, 55581.722091390904, 67785.66107169433, 74399.0, 75069.0, 76058.15476607133, 8240.83518329642, 8413.747587572383, 8463.534505602005, 8563.015253245707, 8703.521306328214, 10439.321444106108, 11501.48243329069, 12026.458809353775, 13373.732525349633, 13400.664983375493, 9962.402255864672, 10922.781544368909, 10927.344359338465, 11233.943830280796, 11481.253718508271, 10322.741931451774, 10961.232713709964, 11070.0, 11303.378314192798, 11543.76912461763, 9358.953205234202, 10912.345259284468, 11193.328400296008, 11255.887441125484, 11358.375289359165, 8411.285040771603, 8489.83020339602, 8647.610857511552, 8697.826043479221, 8792.868106978529, 8329.0, 10046.497675116361, 11816.291022538675, 11975.221610595283, 12038.699032523906], "value": 9911.812110458653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.3813007886292, 1455.3887367305738, 1457.6210185351806, 1473.3738161281453, 1487.5091219897436, 7535.9623201883915, 7782.338501227388, 7881.802954926123, 8223.958880205599, 8249.422540422172, 7963.60181990901, 8186.590670466483, 8257.38069644776, 8285.91714082859, 8301.252887240147, 2278.305116939333, 2312.4912519245822, 2317.606006978809, 2325.3953971967326, 2334.159702507096, 2078.5842831433697, 2148.946276343096, 2294.7705229477087, 2326.499802542453, 2337.2871274261342, 2245.5733410652006, 2303.078768492608, 2310.6187479066016, 2327.5577640248384, 2332.463533387322, 2288.862668239911, 2296.322584837477, 2309.2379514760087, 2311.075569772088, 2312.3409828198883, 2286.371247906822, 2306.0660432524855, 2335.859848409101, 2358.752331005237, 2366.1008816649564, 7143.464240181956, 7897.854811052365, 8371.706990255372, 8443.746687599381, 8461.53461559614, 5025.673331233458, 5123.180291153398, 5160.174372100483, 5161.974190129063, 5164.0, 3279.754018448626, 3458.654134586546, 3535.6464353564693, 3544.2202715402827, 3556.751027428081, 1149.7298134938283, 1182.278809925953, 1214.4413569757921, 1231.1751126745103, 1232.8890399863965, 10737.194710396752, 10818.945905270502, 10876.67369978894, 10892.074173695246, 10902.0, 4568.611668008257, 4657.278121891112, 4664.4869064403565, 4672.415948006499, 4719.315699223662, 9424.623015079456, 9550.95224523873, 9561.330706850593, 9568.808623827623, 9586.0, 5203.739813009334, 5227.398849132398, 5232.450592687713, 5232.555232805178, 5241.73791310433, 4559.928416822044, 4698.8355407560575, 4753.263244197085, 4796.1127191468995, 4807.423109226916, 3209.406259841937, 3861.0, 3884.8251828667776, 3964.266610677034, 3969.6030396960073, 1167.2821214952912, 1175.9235649682744, 1181.2440038375446, 1216.841810564621, 1249.743802520481, 775.7595145504912, 915.6886658535997, 919.2737737187547, 930.8231436027133, 935.2751617496494, 5545.279113715191, 5749.0, 5766.971165144231, 5820.796272130539, 5831.533477321804, 854.2909385210261, 973.7711637765119, 984.8621193032981, 990.3810118675827, 1042.08296698906, 3020.909372718822, 3224.6936541028563, 3837.1174629835295, 3857.267119247334, 3885.0287428142965, 9703.223742100616, 9977.700668979942, 10057.59769609222, 10057.994200579884, 10080.840703319065, 9796.804063918682, 10028.44843533598, 10031.542272143372, 10043.397396156253, 10044.497775111215, 7652.387808975269, 7967.322777563856, 7987.520748755093, 7998.680052797939, 8003.799905002422, 4482.484514280899, 5528.889422211614, 5547.528460080938, 5607.439256074523, 5616.241807356118, 9076.909230907871, 9120.589573469077, 9222.95388523053, 9285.72142835716, 9308.929473110407, 9236.30727695439, 9384.436933783994, 9400.435973841591, 9544.713658590254, 9547.904520954979, 6708.060871477899, 6799.184097908283, 6838.897416538656, 6843.726250950105, 6852.897206542006, 7762.5730584818375, 7769.300762931363, 7778.727744528915, 7821.0, 7839.294463498312, 6505.21937367519, 7139.250378710369, 7183.353498185188, 7192.748253811092, 7217.7112915484895, 7023.508354415142, 7052.612106334201, 7101.8579628406105, 7158.355747982707, 7193.136823581203, 6414.775482858077, 6432.45324147434, 6498.220213574212, 6503.414692677682, 6511.511636627367, 4940.407151141886, 5003.774830132726, 5041.269015992734, 5084.51697088776, 5194.194899790538, 4995.650304478797, 5052.69683818972, 5103.821366252163, 5110.79556817738, 5282.339707536558], "value": 4412.363596684676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.56049333399915, 348.09148123397944, 357.5869870299803, 358.90176061252566, 365.5686290177593, 5050.29295898574, 5102.693838369701, 5153.948460515394, 5193.350831146106, 5442.510174084332, 4292.570742925705, 5049.343585333911, 5151.81968631098, 5177.249298851664, 5270.657407268525, 3204.759643026771, 3602.369585322558, 3750.8747375787293, 4168.916621667565, 4174.37384392342, 3965.583613720561, 4145.611220241223, 4185.895352616194, 4210.157968406331, 4256.425382573344, 3290.6873846984618, 4095.508538975312, 4115.506139263292, 4153.667706583481, 4155.4182414462, 3748.582164503893, 4122.175564887005, 4123.8969025774295, 4126.1128857295525, 4131.607497287768, 3158.384115097557, 3678.70570354371, 3697.8705745298785, 3714.8699795507027, 3724.9627503724887, 4502.16709908668, 4878.195097808857, 5075.198304601887, 5121.564667003309, 5145.382554093533, 4524.343970124313, 4810.278458231258, 4823.324734537167, 4848.6848354857175, 4850.871188083702, 4596.4024676791805, 4839.991403567516, 4924.039812236615, 5190.870228244286, 5675.829725108253, 3751.381022131345, 3958.524977002778, 4079.4492743479545, 4091.787946462043, 4171.520275168334, 4985.800567977277, 5664.603477756558, 5742.196092547047, 5746.540276777848, 5767.538596912237, 3504.842282097312, 3799.8100094995693, 3819.1235895566024, 4178.707490475698, 4187.183499217624, 3685.7933597769575, 3960.742551734128, 3996.300647386696, 4246.940233986514, 4262.893427664271, 3977.801109944491, 4509.233430316854, 4750.477447480775, 4770.737609431445, 4826.203676393426, 5114.974425127925, 5145.897082058338, 5482.80810171642, 5674.914876276859, 5681.0, 1224.6570960131178, 1276.9489220431078, 1303.3939218263554, 1336.5255334356164, 1342.992755433425, 960.9711708648751, 980.3431700760508, 980.578351308944, 981.4945303168873, 986.7024862306044, 4331.285337919208, 4471.1728330259, 4601.309803529431, 4676.08816280822, 5005.399352077774, 5055.093321340244, 5253.632245742761, 5431.945680543223, 5467.617266791286, 5481.314835645544, 4830.951690483121, 4974.463023857858, 4994.875128121826, 5001.199808030698, 5019.837502373482, 2293.8552453456073, 2530.708968468613, 2798.818076825, 2823.929401764972, 2829.306819829155, 4842.5157484251295, 5510.669359838423, 5678.971605141948, 5733.77064917407, 5761.378572749389, 4614.630829533629, 4630.629549636021, 4843.564079232886, 5439.2866247132815, 5766.846630673882, 4806.519348065165, 4977.825776097891, 5109.591232701449, 5448.9727551362785, 6025.246844144482, 5334.306540149756, 5499.340079190522, 5797.275280618102, 5800.1589769484035, 5811.912821307599, 4732.408448943882, 5011.974940125276, 5043.638217681279, 5444.509994100392, 5818.149106937654, 5533.944660553504, 5983.790567330123, 6016.969915150396, 6058.606190597597, 6120.510359171167, 3227.72564332025, 3309.387763263804, 3441.380551500754, 3626.437902125175, 3899.980500097481, 5074.965402504944, 5430.289458820459, 5754.2022265304695, 5771.3651498335985, 5792.623479473821, 4844.442889067662, 4913.410390753133, 5090.734623092836, 5614.466625670555, 5668.773249069991, 5453.945460545344, 5565.3599836019375, 5583.7106786217455, 5593.860153496195, 5627.971860140673, 5471.781128754806, 5484.91772623403, 5493.7089783899955, 5517.4275331530325, 5533.474319939599, 4646.86059418218, 4858.514148585114, 5533.667979921057, 5567.103027880419, 5669.433056694297, 4636.629069674485, 4906.975465122651, 5434.10337294342, 5453.018456677836, 5494.5054945055135], "value": 4054.5317575738914, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.2983860897016, 713.2439614009154, 730.5616630021987, 786.8504984053029, 833.1168960901445, 14708.191049492274, 15526.689466210682, 15538.223088845569, 15597.376104955789, 15602.921985390072, 11676.708082297926, 13134.60596182116, 13556.457741690321, 14546.854531454708, 14661.486847960323, 678.0541145102567, 705.5872314695883, 726.4442701333484, 772.934300584451, 842.5787106446777, 869.1569177897429, 881.6385282034336, 882.1266945723719, 882.8190221004679, 884.650563027607, 894.8120894612139, 933.3559843707853, 934.5047125023714, 936.2509992006402, 938.8826396700413, 912.8174365126968, 927.2303987690201, 930.0978051290238, 930.2186163622522, 930.6928713524554, 658.6904155047121, 689.1729924091111, 693.2859155070286, 695.0373732380639, 697.1982220446477, 14035.157890526601, 14143.787843182361, 14182.219977901212, 15361.615959600987, 15767.921160394124, 14085.0, 14351.712965740731, 14385.640358991004, 14451.566453006426, 14476.782848257284, 9107.590158442887, 10817.18871084664, 11739.413029348583, 11744.0, 11875.703107422298, 4492.393526873896, 4539.4098767160385, 4545.704529205591, 4570.634349252052, 4636.072785442925, 112736.87263127428, 114319.42840285745, 114992.0, 115462.0, 116042.0, 10783.622573210057, 10944.124470042378, 11017.228793984345, 11097.1122310215, 11194.44027798623, 21297.57404851894, 21548.245811396526, 21580.56838863214, 21593.02831372592, 21642.675359869616, 7585.924140758521, 7611.124720657195, 7729.768106956801, 7799.06411230656, 7958.3235424989525, 4177.248095342868, 4239.130978149534, 4251.192273468031, 4263.786810659454, 4361.476622805284, 3275.4268003099837, 3320.3027364253294, 3466.1507930557177, 3519.9472007919903, 3546.219831637036, 646.8350570604466, 651.1469974333638, 655.52474456019, 655.8589903170841, 664.0603545982477, 518.6272801931179, 530.8672831792052, 541.8103663717667, 543.6900966449086, 544.8964696707612, 8616.879805625229, 9139.725808225763, 9903.504824758733, 10035.849462258071, 10064.094231519199, 447.55133968354454, 517.5730022731186, 538.5244430261057, 543.3344153412118, 591.4765432592187, 4732.432108146975, 4796.640251981115, 4802.0, 4805.327254184417, 4807.471178170468, 86247.56876215579, 104711.0, 104838.0, 106686.0, 110370.44814775875, 95358.0464195363, 96092.07815843644, 96420.0, 98435.0, 98699.50650246846, 83942.0, 83986.16013839905, 84922.15077849143, 85088.0, 86004.56997715097, 7710.653020613973, 8418.663253469793, 9275.76810579741, 9277.721668349961, 9413.949216585568, 54353.18470223029, 54507.18660167479, 54956.0, 56311.87376252534, 56613.716931416726, 65354.0, 68275.29311767047, 70947.0, 72814.0, 73537.0, 9678.370905891095, 10867.184961127788, 10986.945065274622, 11006.834897476385, 11020.669379918616, 11978.221415607957, 12049.578264760692, 12094.213876098025, 12336.691582710504, 12532.749345012866, 11683.766324673288, 11834.408279586158, 11963.820542691692, 12298.323592202514, 12314.199577027464, 10997.230193886351, 11260.774784504429, 11489.425528723363, 11600.071994240272, 11855.0, 10198.133158681596, 10637.468126593485, 11619.535218591162, 11761.941190293994, 12055.21641093326, 9731.978142294956, 9776.120149186607, 9893.65372211969, 9950.800983980425, 10007.899921000697, 9180.770480738034, 9196.218321442751, 9199.954000229956, 9215.354925155174, 9219.308551858772], "value": 7241.828150124229, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 118.0, 119.0, 119.0, 118.0, 119.0, 119.0, 118.0, 121.0], "value": 117.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 147.0, 150.0, 147.0, 116.0, 114.0, 114.0, 126.0, 135.0, 116.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 208.0, 223.0, 199.0, 197.0, 200.0, 202.0, 197.0, 198.0, 250.0], "value": 208.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 78.0, 84.0, 61.0, 63.0, 75.0, 57.0, 77.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 90.0, 85.0, 94.0, 74.0, 83.0, 72.0, 101.0, 116.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 90.0, 126.0, 106.0, 129.0, 125.0, 135.0, 118.0, 132.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 128.0, 153.0, 96.0, 97.0, 96.0, 111.0, 155.0, 114.0, 98.0], "value": 114.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 94.0, 93.0, 102.0, 92.0, 93.0, 93.0, 92.0, 79.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 55.0, 50.0, 96.0, 96.0, 97.0, 96.0, 97.0, 59.0], "value": 77.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 69.0, 78.0, 73.0, 73.0, 71.0, 70.0, 74.0, 73.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 91.0, 90.0, 89.0, 91.0, 90.0, 89.0, 92.0, 89.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 163.0, 168.0, 160.0, 144.0, 143.0, 157.0, 152.0, 225.0, 157.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 174.0, 176.0, 176.0, 176.0, 240.0, 241.0, 191.0, 179.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 66.0, 69.0, 69.0, 67.0, 69.0, 68.0, 68.0, 68.0], "value": 68.5, "unit": "score"}]}]} 23:57:16 INFO - Return code: 0 23:57:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:57:16 ERROR - # TBPL SUCCESS # 23:57:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:57:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:57:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:57:16 INFO - 2017-01-13 23:57:16.893 screenresolution[1674:14732] starting screenresolution argv=screenresolution get 23:57:16 INFO - 2017-01-13 23:57:16.895 screenresolution[1674:14732] Display 0: 1600x1200x32@60 23:57:16 INFO - 2017-01-13 23:57:16.901 screenresolution[1675:14735] starting screenresolution argv=screenresolution list 23:57:16 INFO - Available Modes on Display 0 23:57:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:57:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:57:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:57:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:57:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:57:17 INFO - Intel Iris: 23:57:17 INFO - Chipset Model: Intel Iris 23:57:17 INFO - Type: GPU 23:57:17 INFO - Bus: Built-In 23:57:17 INFO - VRAM (Dynamic, Max): 1536 MB 23:57:17 INFO - Vendor: Intel (0x8086) 23:57:17 INFO - Device ID: 0x0a2e 23:57:17 INFO - Revision ID: 0x0009 23:57:17 INFO - Displays: 23:57:17 INFO - Display: 23:57:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:57:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:57:17 INFO - Display Serial Number: 1600x1200 60 23:57:17 INFO - Main Display: Yes 23:57:17 INFO - Mirror: Off 23:57:17 INFO - Online: Yes 23:57:17 INFO - Rotation: Supported 23:57:17 INFO - Return code: 0 23:57:17 INFO - Running post-action listener: _resource_record_post_action 23:57:17 INFO - [mozharness: 2017-01-14 07:57:17.135939Z] Finished run-tests step (success) 23:57:17 INFO - Running post-run listener: _resource_record_post_run 23:57:17 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 32174592; Write bytes: 558354432; Read time: 201; Write time: 1700 23:57:17 INFO - TinderboxPrint: CPU usage
54.5% 23:57:17 INFO - TinderboxPrint: I/O read bytes / time
32,174,592 / 201 23:57:17 INFO - TinderboxPrint: I/O write bytes / time
558,354,432 / 1,700 23:57:17 INFO - TinderboxPrint: CPU idle
2,187.0 (45.5%) 23:57:17 INFO - TinderboxPrint: CPU system
967.3 (20.1%) 23:57:17 INFO - TinderboxPrint: CPU user
1,647.5 (34.3%) 23:57:17 INFO - TinderboxPrint: Swap in / out
279,670,784 / 0 23:57:17 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243726848; Write bytes: 237651456; Read time: 17852; Write time: 520 23:57:17 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30188032; Write bytes: 303135232; Read time: 183; Write time: 1135 23:57:17 INFO - Running post-run listener: _upload_blobber_files 23:57:17 INFO - Blob upload gear active. 23:57:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:57:17 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 23:57:17 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:57:17 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:57:18 INFO - (blobuploader) - INFO - Open directory for files ... 23:57:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:57:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:57:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:57:19 INFO - (blobuploader) - INFO - Done attempting. 23:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:57:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:57:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:57:20 INFO - (blobuploader) - INFO - Done attempting. 23:57:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:57:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:57:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:57:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:57:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:57:21 INFO - (blobuploader) - INFO - Done attempting. 23:57:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:57:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:57:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:57:23 INFO - (blobuploader) - INFO - Done attempting. 23:57:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:57:23 INFO - Return code: 0 23:57:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:57:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:57:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/167296c12dfa44c42959066561c6d21b8f3449fbb25ac947ed0fc502b669b5247072a9506e3ec5254c0b30a9c34ac86a4d05f0ed5711bb8eecbdf01b50a2b143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c1da93f7c379728e0d9859642614f9f1513ee9d64857da5348979f2de7daa2c904b008da14cdb724870a0f70863d83bb9f39e586419af305481d8837d0ccfc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1968b3fdcf460012b1a5bd0ffcb144f154866ad30d7d450863c4ae46b332e82a7ff8c55927b25a3fc1c34066c0e748892d93826423ec6e56f273a7ab38c6c514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8af3dde1dabdc084e8246872ba50fa73d6ebf6ab7bc0bb3c59f715debf6a780905f6199370e7fa7b91f408e5b7b5c062ac90016d478ce961ac1222f916c60bfd"} 23:57:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:57:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:57:23 INFO - Contents: 23:57:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/167296c12dfa44c42959066561c6d21b8f3449fbb25ac947ed0fc502b669b5247072a9506e3ec5254c0b30a9c34ac86a4d05f0ed5711bb8eecbdf01b50a2b143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c1da93f7c379728e0d9859642614f9f1513ee9d64857da5348979f2de7daa2c904b008da14cdb724870a0f70863d83bb9f39e586419af305481d8837d0ccfc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1968b3fdcf460012b1a5bd0ffcb144f154866ad30d7d450863c4ae46b332e82a7ff8c55927b25a3fc1c34066c0e748892d93826423ec6e56f273a7ab38c6c514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8af3dde1dabdc084e8246872ba50fa73d6ebf6ab7bc0bb3c59f715debf6a780905f6199370e7fa7b91f408e5b7b5c062ac90016d478ce961ac1222f916c60bfd"} 23:57:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:57:23 INFO - Copying logs to upload dir... 23:57:23 INFO - mkdir: /builds/slave/test/build/upload/logs 23:57:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.802746 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-13 23:57:23.431610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 23:57:23.435211) ========= 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.sLELspbehJ/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.KYC9SbrA7M/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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/Graphics/sha512/167296c12dfa44c42959066561c6d21b8f3449fbb25ac947ed0fc502b669b5247072a9506e3ec5254c0b30a9c34ac86a4d05f0ed5711bb8eecbdf01b50a2b143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c1da93f7c379728e0d9859642614f9f1513ee9d64857da5348979f2de7daa2c904b008da14cdb724870a0f70863d83bb9f39e586419af305481d8837d0ccfc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1968b3fdcf460012b1a5bd0ffcb144f154866ad30d7d450863c4ae46b332e82a7ff8c55927b25a3fc1c34066c0e748892d93826423ec6e56f273a7ab38c6c514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8af3dde1dabdc084e8246872ba50fa73d6ebf6ab7bc0bb3c59f715debf6a780905f6199370e7fa7b91f408e5b7b5c062ac90016d478ce961ac1222f916c60bfd"} build_url:https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/SnLOAzYBQeqq7u24jsN5Gg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/167296c12dfa44c42959066561c6d21b8f3449fbb25ac947ed0fc502b669b5247072a9506e3ec5254c0b30a9c34ac86a4d05f0ed5711bb8eecbdf01b50a2b143", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c1da93f7c379728e0d9859642614f9f1513ee9d64857da5348979f2de7daa2c904b008da14cdb724870a0f70863d83bb9f39e586419af305481d8837d0ccfc9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1968b3fdcf460012b1a5bd0ffcb144f154866ad30d7d450863c4ae46b332e82a7ff8c55927b25a3fc1c34066c0e748892d93826423ec6e56f273a7ab38c6c514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8af3dde1dabdc084e8246872ba50fa73d6ebf6ab7bc0bb3c59f715debf6a780905f6199370e7fa7b91f408e5b7b5c062ac90016d478ce961ac1222f916c60bfd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 23:57:23.474195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 23:57:23.474528) ========= 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.sLELspbehJ/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.KYC9SbrA7M/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.005288 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 23:57:23.526927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 23:57:23.527768) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 23:57:23.528561) ========= ========= Total master_lag: 0.19 =========