builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0123 starttime: 1491561181.85 results: success (0) buildid: 20170407021633 builduid: e019530f213b46e28969dbf59e4032f9 revision: 21fda0371ac39ccfffc63b703d89c9f55ad62da4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:01.853267) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:01.853810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:01.854147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:01.883236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:01.883762) ========= 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.JQieJ01SC8/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.iFG8iJvdVH/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-04-07 03:33:01-- 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% 7.55M=0.002s 2017-04-07 03:33:02 (7.55 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:02.083158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:02.086518) ========= 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.JQieJ01SC8/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.iFG8iJvdVH/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.023043 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:02.135167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 03:33:02.135539) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 21fda0371ac39ccfffc63b703d89c9f55ad62da4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 21fda0371ac39ccfffc63b703d89c9f55ad62da4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JQieJ01SC8/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.iFG8iJvdVH/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-04-07 03:33:02,224 truncating revision to first 12 chars 2017-04-07 03:33:02,225 Setting DEBUG logging. 2017-04-07 03:33:02,225 attempt 1/10 2017-04-07 03:33:02,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/21fda0371ac3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 03:33:03,978 unpacking tar archive at: mozilla-beta-21fda0371ac3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.015272 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 03:33:04.178023) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:04.178364) ========= script_repo_revision: 21fda0371ac39ccfffc63b703d89c9f55ad62da4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:04.178789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:04.179079) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 03:33:04.199344) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-04-07 03:33:04.199782) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JQieJ01SC8/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.iFG8iJvdVH/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:04 INFO - MultiFileLogger online at 20170407 03:33:04 in /builds/slave/test 03:33:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:33:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:04 INFO - {'append_to_log': False, 03:33:04 INFO - 'base_work_dir': '/builds/slave/test', 03:33:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:33:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:04 INFO - 'branch': 'Mozilla-Beta', 03:33:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:04 INFO - 'config_files': ('talos/mac_config.py',), 03:33:04 INFO - 'default_actions': ('clobber', 03:33:04 INFO - 'read-buildbot-config', 03:33:04 INFO - 'download-and-extract', 03:33:04 INFO - 'populate-webroot', 03:33:04 INFO - 'create-virtualenv', 03:33:04 INFO - 'install', 03:33:04 INFO - 'run-tests'), 03:33:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:04 INFO - 'download_minidump_stackwalk': True, 03:33:04 INFO - 'download_symbols': 'ondemand', 03:33:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:04 INFO - 'installer_path': 'installer.exe', 03:33:04 INFO - 'log_level': 'info', 03:33:04 INFO - 'log_name': 'talos', 03:33:04 INFO - 'log_to_console': True, 03:33:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:33:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:33:04 INFO - 'opt_config_files': (), 03:33:04 INFO - 'pip_index': False, 03:33:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:33:04 INFO - 'cmd': ('bash', 03:33:04 INFO - '-c', 03:33:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:33:04 INFO - 'enabled': True, 03:33:04 INFO - 'halt_on_failure': False, 03:33:04 INFO - 'name': 'check_screen_resolution'},), 03:33:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:33:04 INFO - 'cmd': ('bash', 03:33:04 INFO - '-c', 03:33:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:33:04 INFO - 'enabled': True, 03:33:04 INFO - 'halt_on_failure': False, 03:33:04 INFO - 'name': 'check_screen_resolution'},), 03:33:04 INFO - 'run_cmd_checks_enabled': True, 03:33:04 INFO - 'sps_profile': False, 03:33:04 INFO - 'sps_profile_interval': 0, 03:33:04 INFO - 'suite': 'dromaeojs-e10s', 03:33:04 INFO - 'system_bits': '32', 03:33:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:04 INFO - 'title': 't-yosemite-r7-0123', 03:33:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:04 INFO - 'use_talos_json': True, 03:33:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:04 INFO - 'work_dir': 'build'} 03:33:04 INFO - [mozharness: 2017-04-07 10:33:04.413751Z] Running clobber step. 03:33:04 INFO - Running pre-action listener: _resource_record_pre_action 03:33:04 INFO - Running main action method: clobber 03:33:04 INFO - rmtree: /builds/slave/test/build 03:33:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:05 INFO - Running post-action listener: _resource_record_post_action 03:33:05 INFO - [mozharness: 2017-04-07 10:33:05.087292Z] Finished clobber step (success) 03:33:05 INFO - [mozharness: 2017-04-07 10:33:05.087457Z] Running read-buildbot-config step. 03:33:05 INFO - Running pre-action listener: _resource_record_pre_action 03:33:05 INFO - Running main action method: read_buildbot_config 03:33:05 INFO - Using buildbot properties: 03:33:05 INFO - { 03:33:05 INFO - "project": "", 03:33:05 INFO - "product": "firefox", 03:33:05 INFO - "script_repo_revision": "production", 03:33:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 03:33:05 INFO - "repository": "", 03:33:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 03:33:05 INFO - "buildid": "20170407021633", 03:33:05 INFO - "pgo_build": "False", 03:33:05 INFO - "basedir": "/builds/slave/test", 03:33:05 INFO - "buildnumber": 29, 03:33:05 INFO - "slavename": "t-yosemite-r7-0123", 03:33:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:33:05 INFO - "platform": "yosemite_r7", 03:33:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:33:05 INFO - "branch": "mozilla-beta", 03:33:05 INFO - "repo_path": "releases/mozilla-beta", 03:33:05 INFO - "revision": "21fda0371ac39ccfffc63b703d89c9f55ad62da4", 03:33:05 INFO - "stage_platform": "macosx64", 03:33:05 INFO - "builduid": "e019530f213b46e28969dbf59e4032f9", 03:33:05 INFO - "slavebuilddir": "test" 03:33:05 INFO - } 03:33:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 03:33:05 INFO - Running post-action listener: _resource_record_post_action 03:33:05 INFO - [mozharness: 2017-04-07 10:33:05.090876Z] Finished read-buildbot-config step (success) 03:33:05 INFO - [mozharness: 2017-04-07 10:33:05.091011Z] Running download-and-extract step. 03:33:05 INFO - Running pre-action listener: _resource_record_pre_action 03:33:05 INFO - Running main action method: download_and_extract 03:33:05 INFO - mkdir: /builds/slave/test/build/tests 03:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:05 INFO - trying https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 03:33:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 03:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 03:33:05 INFO - Downloaded 1165 bytes. 03:33:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 03:33:05 INFO - Using the following test package requirements: 03:33:05 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 03:33:05 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:33:05 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 03:33:05 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:33:05 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 03:33:05 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:33:05 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:33:05 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 03:33:05 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 03:33:05 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:33:05 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 03:33:05 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:33:05 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 03:33:05 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:33:05 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 03:33:05 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:33:05 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 03:33:05 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 03:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 03:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 03:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 03:33:06 INFO - Expected file size: 16116408 03:33:06 INFO - Obtained file size: 16116408 03:33:13 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 03:33:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 03:33:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 03:33:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 03:33:14 INFO - Expected file size: 16116408 03:33:14 INFO - Obtained file size: 16116408 03:33:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 03:33:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 03:33:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 03:33:21 INFO - Expected file size: 14403650 03:33:21 INFO - Obtained file size: 14403650 03:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:22 INFO - trying https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:33:22 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 03:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 03:33:23 INFO - Downloaded 58740780 bytes. 03:33:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:33:23 INFO - mkdir: /builds/slave/test/properties 03:33:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:23 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:23 INFO - Contents: 03:33:23 INFO - build_url:https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:33:24 INFO - Running post-action listener: _resource_record_post_action 03:33:24 INFO - Running post-action listener: set_extra_try_arguments 03:33:24 INFO - [mozharness: 2017-04-07 10:33:24.566764Z] Finished download-and-extract step (success) 03:33:24 INFO - [mozharness: 2017-04-07 10:33:24.566909Z] Running populate-webroot step. 03:33:24 INFO - Running pre-action listener: _resource_record_pre_action 03:33:24 INFO - Running main action method: populate_webroot 03:33:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:24 INFO - '--tppagecycles', 03:33:24 INFO - '7'], 03:33:24 INFO - 'tests': ['tsvgm']}}, 03:33:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:33:24 INFO - 'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:33:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:33:24 INFO - 'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['damp', 'tps']}, 03:33:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:33:24 INFO - 'tests': ['damp', 'tps']}, 03:33:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['dromaeo_dom']}, 03:33:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['basic_compositor_video']}, 03:33:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['a11yr', 03:33:24 INFO - 'ts_paint', 03:33:24 INFO - 'tpaint', 03:33:24 INFO - 'sessionrestore', 03:33:24 INFO - 'sessionrestore_no_auto_restore', 03:33:24 INFO - 'tabpaint']}, 03:33:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:24 INFO - 'ts_paint', 03:33:24 INFO - 'tpaint', 03:33:24 INFO - 'sessionrestore', 03:33:24 INFO - 'sessionrestore_no_auto_restore', 03:33:24 INFO - 'tabpaint']}, 03:33:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:24 INFO - 'ts_paint', 03:33:24 INFO - 'tpaint', 03:33:24 INFO - 'sessionrestore', 03:33:24 INFO - 'sessionrestore_no_auto_restore', 03:33:24 INFO - 'tabpaint']}, 03:33:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:24 INFO - 'ts_paint', 03:33:24 INFO - 'tpaint', 03:33:24 INFO - 'sessionrestore', 03:33:24 INFO - 'sessionrestore_no_auto_restore', 03:33:24 INFO - 'tabpaint']}, 03:33:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['a11yr', 03:33:24 INFO - 'ts_paint', 03:33:24 INFO - 'tpaint', 03:33:24 INFO - 'sessionrestore', 03:33:24 INFO - 'sessionrestore_no_auto_restore', 03:33:24 INFO - 'tabpaint']}, 03:33:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['a11yr', 03:33:24 INFO - 'ts_paint', 03:33:24 INFO - 'tpaint', 03:33:24 INFO - 'sessionrestore', 03:33:24 INFO - 'sessionrestore_no_auto_restore', 03:33:24 INFO - 'tabpaint']}, 03:33:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['tsvgx', 03:33:24 INFO - 'tsvgr_opacity', 03:33:24 INFO - 'tart', 03:33:24 INFO - 'tscrollx', 03:33:24 INFO - 'cart', 03:33:24 INFO - 'tsvg_static']}, 03:33:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:24 INFO - 'tsvgr_opacity', 03:33:24 INFO - 'tart', 03:33:24 INFO - 'tscrollx', 03:33:24 INFO - 'cart', 03:33:24 INFO - 'tsvg_static']}, 03:33:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:33:24 INFO - 'talos_options': ['--disable-e10s'], 03:33:24 INFO - 'tests': ['tp5o']}, 03:33:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:33:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:33:24 INFO - 'talos_options': ['--disable-e10s', 03:33:24 INFO - '--xperf_path', 03:33:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:24 INFO - 'tests': ['tp5n']}, 03:33:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:33:24 INFO - 'talos_options': ['--xperf_path', 03:33:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:24 INFO - 'tests': ['tp5n']}}, 03:33:24 INFO - 'talos.zip': {'path': '', 03:33:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:24 INFO - Running post-action listener: _resource_record_post_action 03:33:24 INFO - [mozharness: 2017-04-07 10:33:24.585618Z] Finished populate-webroot step (success) 03:33:24 INFO - [mozharness: 2017-04-07 10:33:24.585708Z] Running create-virtualenv step. 03:33:24 INFO - Running pre-action listener: _resource_record_pre_action 03:33:24 INFO - Running main action method: create_virtualenv 03:33:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:24 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 03:33:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:24 INFO - Using real prefix '/tools/python27' 03:33:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:28 INFO - Installing pip.................done. 03:33:28 INFO - Return code: 0 03:33:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:28 INFO - Reading from file tmpfile_stdout 03:33:28 INFO - Output received: 03:33:28 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) 03:33:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:28 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')]} 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 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')]} 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:28 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 03:33:28 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 03:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:28 INFO - 'HOME': '/Users/cltbld', 03:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PAGER': '/bin/cat', 03:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:28 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - 'XPC_FLAGS': '0x0', 03:33:28 INFO - 'XPC_SERVICE_NAME': '0', 03:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:28 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 03:33:28 INFO - Cleaning up... 03:33:28 INFO - Return code: 0 03:33:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:28 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')]} 03:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 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')]} 03:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:28 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:28 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 03:33:28 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 03:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:28 INFO - 'HOME': '/Users/cltbld', 03:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PAGER': '/bin/cat', 03:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:28 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - 'XPC_FLAGS': '0x0', 03:33:28 INFO - 'XPC_SERVICE_NAME': '0', 03:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:29 INFO - Downloading/unpacking psutil>=3.1.1 03:33:29 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 03:33:29 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 03:33:29 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 03:33:29 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 03:33:29 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 03:33:29 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 03:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:32 INFO - Installing collected packages: psutil 03:33:32 INFO - Running setup.py install for psutil 03:33:32 INFO - building 'psutil._psutil_osx' extension 03:33:32 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 03:33:33 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 03:33:33 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 03:33:33 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 03:33:33 INFO - building 'psutil._psutil_posix' extension 03:33:33 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 03:33:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:33:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:33:33 INFO - ^ 03:33:33 INFO - 1 warning generated. 03:33:33 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 03:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:33 INFO - Successfully installed psutil 03:33:33 INFO - Cleaning up... 03:33:33 INFO - Return code: 0 03:33:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:33 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')]} 03:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:33 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')]} 03:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:33 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:33 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 03:33:33 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 03:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:33 INFO - 'HOME': '/Users/cltbld', 03:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:33 INFO - 'LOGNAME': 'cltbld', 03:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:33 INFO - 'MOZ_NO_REMOTE': '1', 03:33:33 INFO - 'NO_EM_RESTART': '1', 03:33:33 INFO - 'PAGER': '/bin/cat', 03:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:33 INFO - 'PWD': '/builds/slave/test', 03:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:33 INFO - 'SHELL': '/bin/bash', 03:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:33 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:33 INFO - 'USER': 'cltbld', 03:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:33 INFO - 'XPC_FLAGS': '0x0', 03:33:33 INFO - 'XPC_SERVICE_NAME': '0', 03:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:33 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 03:33:33 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 03:33:33 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 03:33:33 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 03:33:33 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 03:33:33 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 03:33:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:36 INFO - Installing collected packages: mozsystemmonitor 03:33:36 INFO - Running setup.py install for mozsystemmonitor 03:33:36 INFO - Successfully installed mozsystemmonitor 03:33:36 INFO - Cleaning up... 03:33:36 INFO - Return code: 0 03:33:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:36 INFO - 'HOME': '/Users/cltbld', 03:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:36 INFO - 'LOGNAME': 'cltbld', 03:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:36 INFO - 'MOZ_NO_REMOTE': '1', 03:33:36 INFO - 'NO_EM_RESTART': '1', 03:33:36 INFO - 'PAGER': '/bin/cat', 03:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:36 INFO - 'PWD': '/builds/slave/test', 03:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:36 INFO - 'SHELL': '/bin/bash', 03:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:36 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:36 INFO - 'USER': 'cltbld', 03:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:36 INFO - 'XPC_FLAGS': '0x0', 03:33:36 INFO - 'XPC_SERVICE_NAME': '0', 03:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:36 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:36 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 03:33:36 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 03:33:36 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 03:33:36 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 03:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 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 03:33:39 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 03:33:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:40 INFO - warning: no files found matching '*.txt' 03:33:40 INFO - no previously-included directories found matching 'build' 03:33:40 INFO - no previously-included directories found matching 'dist' 03:33:40 INFO - no previously-included directories found matching '.git*' 03:33:40 INFO - Installing collected packages: jsonschema, functools32 03:33:40 INFO - Running setup.py install for functools32 03:33:40 INFO - warning: no files found matching '*.txt' 03:33:40 INFO - no previously-included directories found matching 'build' 03:33:40 INFO - no previously-included directories found matching 'dist' 03:33:40 INFO - no previously-included directories found matching '.git*' 03:33:40 INFO - Successfully installed jsonschema functools32 03:33:40 INFO - Cleaning up... 03:33:40 INFO - Return code: 0 03:33:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33:40 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')]} 03:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:40 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')]} 03:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:40 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:40 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 03:33:40 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 03:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:40 INFO - 'HOME': '/Users/cltbld', 03:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:40 INFO - 'LOGNAME': 'cltbld', 03:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:40 INFO - 'MOZ_NO_REMOTE': '1', 03:33:40 INFO - 'NO_EM_RESTART': '1', 03:33:40 INFO - 'PAGER': '/bin/cat', 03:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:40 INFO - 'PWD': '/builds/slave/test', 03:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:40 INFO - 'SHELL': '/bin/bash', 03:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:40 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:40 INFO - 'USER': 'cltbld', 03:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:40 INFO - 'XPC_FLAGS': '0x0', 03:33:40 INFO - 'XPC_SERVICE_NAME': '0', 03:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:40 INFO - Cleaning up... 03:33:40 INFO - Return code: 0 03:33:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:40 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')]} 03:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:40 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')]} 03:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:40 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:40 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 03:33:40 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 03:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:40 INFO - 'HOME': '/Users/cltbld', 03:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:40 INFO - 'LOGNAME': 'cltbld', 03:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:40 INFO - 'MOZ_NO_REMOTE': '1', 03:33:40 INFO - 'NO_EM_RESTART': '1', 03:33:40 INFO - 'PAGER': '/bin/cat', 03:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:40 INFO - 'PWD': '/builds/slave/test', 03:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:40 INFO - 'SHELL': '/bin/bash', 03:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:40 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:40 INFO - 'USER': 'cltbld', 03:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:40 INFO - 'XPC_FLAGS': '0x0', 03:33:40 INFO - 'XPC_SERVICE_NAME': '0', 03:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:41 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 03:33:41 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 03:33:41 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 03:33:41 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 03:33:41 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 03:33:41 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 03:33:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:44 INFO - Downloading docopt-0.6.1.tar.gz 03:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:44 INFO - Running setup.py install for blobuploader 03:33:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:45 INFO - Running setup.py install for requests 03:33:45 INFO - Running setup.py install for docopt 03:33:45 INFO - Successfully installed blobuploader requests docopt 03:33:45 INFO - Cleaning up... 03:33:45 INFO - Return code: 0 03:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:45 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')]} 03:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:45 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')]} 03:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:45 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:45 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 03:33:45 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 03:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:45 INFO - 'HOME': '/Users/cltbld', 03:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:45 INFO - 'LOGNAME': 'cltbld', 03:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:45 INFO - 'MOZ_NO_REMOTE': '1', 03:33:45 INFO - 'NO_EM_RESTART': '1', 03:33:45 INFO - 'PAGER': '/bin/cat', 03:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:45 INFO - 'PWD': '/builds/slave/test', 03:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:45 INFO - 'SHELL': '/bin/bash', 03:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:45 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:45 INFO - 'USER': 'cltbld', 03:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:45 INFO - 'XPC_FLAGS': '0x0', 03:33:45 INFO - 'XPC_SERVICE_NAME': '0', 03:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-anCD07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-RU0ZBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-aWuPGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-UDz6aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-lMGsT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-LCudAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-NcqGaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-DwTtC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:46 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-t18gO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-qml8I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jOuOYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-hkQXsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-K_PnSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-TRGBT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-YrSs9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-SUCYRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:47 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-07F5xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:47 INFO - Running setup.py install for manifestparser 03:33:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Running setup.py install for mozcrash 03:33:48 INFO - Running setup.py install for mozdebug 03:33:48 INFO - Running setup.py install for mozdevice 03:33:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Running setup.py install for mozfile 03:33:48 INFO - Running setup.py install for mozhttpd 03:33:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Running setup.py install for mozinfo 03:33:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Running setup.py install for mozInstall 03:33:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozleak 03:33:49 INFO - Running setup.py install for mozlog 03:33:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for moznetwork 03:33:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozprocess 03:33:49 INFO - Running setup.py install for mozprofile 03:33:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozrunner 03:33:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:50 INFO - Running setup.py install for mozscreenshot 03:33:50 INFO - Running setup.py install for moztest 03:33:50 INFO - Running setup.py install for mozversion 03:33:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:50 INFO - Cleaning up... 03:33:50 INFO - Return code: 0 03:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:50 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')]} 03:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:50 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')]} 03:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:50 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:50 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 03:33:50 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 03:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:50 INFO - 'HOME': '/Users/cltbld', 03:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:50 INFO - 'LOGNAME': 'cltbld', 03:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:50 INFO - 'MOZ_NO_REMOTE': '1', 03:33:50 INFO - 'NO_EM_RESTART': '1', 03:33:50 INFO - 'PAGER': '/bin/cat', 03:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:50 INFO - 'PWD': '/builds/slave/test', 03:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:50 INFO - 'SHELL': '/bin/bash', 03:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:50 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:50 INFO - 'USER': 'cltbld', 03:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:50 INFO - 'XPC_FLAGS': '0x0', 03:33:50 INFO - 'XPC_SERVICE_NAME': '0', 03:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-rIkygn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-I4Qgni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:50 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-7d81pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-k76GvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-xep5LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-bZIKdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-otFAUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Aii2O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-h_70W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-izXp2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-0rn9S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:51 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-pnlivY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:52 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)) 03:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:52 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jQferd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:52 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)) 03:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:52 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-EjmGX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:52 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)) 03:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:52 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-gs0wvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:52 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)) 03:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:52 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-n8zBUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:52 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)) 03:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:52 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ytoAfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:52 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)) 03:33:52 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)) 03:33:52 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)) 03:33:52 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)) 03:33:52 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)) 03:33:52 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)) 03:33:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:55 INFO - Downloading blessings-1.6.tar.gz 03:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:55 INFO - Installing collected packages: blessings 03:33:55 INFO - Running setup.py install for blessings 03:33:55 INFO - Successfully installed blessings 03:33:55 INFO - Cleaning up... 03:33:55 INFO - Return code: 0 03:33:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:55 INFO - Reading from file tmpfile_stdout 03:33:55 INFO - Current package versions: 03:33:55 INFO - blessings == 1.6 03:33:55 INFO - blobuploader == 1.2.4 03:33:55 INFO - docopt == 0.6.1 03:33:55 INFO - functools32 == 3.2.3-2 03:33:55 INFO - jsonschema == 2.5.1 03:33:55 INFO - manifestparser == 1.1 03:33:55 INFO - mozInstall == 1.12 03:33:55 INFO - mozcrash == 1.0 03:33:55 INFO - mozdebug == 0.1 03:33:55 INFO - mozdevice == 0.49 03:33:55 INFO - mozfile == 1.2 03:33:55 INFO - mozhttpd == 0.7 03:33:55 INFO - mozinfo == 0.9 03:33:55 INFO - mozleak == 0.1 03:33:55 INFO - mozlog == 3.4 03:33:55 INFO - moznetwork == 0.27 03:33:55 INFO - mozprocess == 0.24 03:33:55 INFO - mozprofile == 0.28 03:33:55 INFO - mozrunner == 6.13 03:33:55 INFO - mozscreenshot == 0.1 03:33:55 INFO - mozsystemmonitor == 0.3 03:33:55 INFO - moztest == 0.8 03:33:55 INFO - mozversion == 1.4 03:33:55 INFO - psutil == 3.1.1 03:33:55 INFO - requests == 1.2.3 03:33:55 INFO - wsgiref == 0.1.2 03:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:55 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 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33:55 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 03:33:55 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 03:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:55 INFO - 'HOME': '/Users/cltbld', 03:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:55 INFO - 'LOGNAME': 'cltbld', 03:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:55 INFO - 'MOZ_NO_REMOTE': '1', 03:33:55 INFO - 'NO_EM_RESTART': '1', 03:33:55 INFO - 'PAGER': '/bin/cat', 03:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:55 INFO - 'PWD': '/builds/slave/test', 03:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:55 INFO - 'SHELL': '/bin/bash', 03:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:55 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:55 INFO - 'USER': 'cltbld', 03:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:55 INFO - 'XPC_FLAGS': '0x0', 03:33:55 INFO - 'XPC_SERVICE_NAME': '0', 03:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 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)) 03:33:56 INFO - Cleaning up... 03:33:56 INFO - Return code: 0 03:33:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b5bba80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, '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.JQieJ01SC8/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.iFG8iJvdVH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 03:33: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'] in /builds/slave/test/build 03:33: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 03:33:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:33:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:56 INFO - 'HOME': '/Users/cltbld', 03:33:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:56 INFO - 'LOGNAME': 'cltbld', 03:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:56 INFO - 'MOZ_NO_REMOTE': '1', 03:33:56 INFO - 'NO_EM_RESTART': '1', 03:33:56 INFO - 'PAGER': '/bin/cat', 03:33:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:56 INFO - 'PWD': '/builds/slave/test', 03:33:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:56 INFO - 'SHELL': '/bin/bash', 03:33:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:33:56 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:33:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:56 INFO - 'USER': 'cltbld', 03:33:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:56 INFO - 'XPC_FLAGS': '0x0', 03:33:56 INFO - 'XPC_SERVICE_NAME': '0', 03:33:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:56 INFO - Cleaning up... 03:33:56 INFO - Return code: 0 03:33:56 INFO - Running post-action listener: _resource_record_post_action 03:33:56 INFO - Running post-action listener: _start_resource_monitoring 03:33:56 INFO - Starting resource monitoring. 03:33:56 INFO - [mozharness: 2017-04-07 10:33:56.462260Z] Finished create-virtualenv step (success) 03:33:56 INFO - [mozharness: 2017-04-07 10:33:56.463206Z] Running install step. 03:33:56 INFO - Running pre-action listener: _resource_record_pre_action 03:33:56 INFO - Running main action method: install 03:33:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:56 INFO - Reading from file tmpfile_stdout 03:33:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:56 INFO - Reading from file tmpfile_stdout 03:33:56 INFO - Output received: 03:33:56 INFO - Usage: mozinstall [options] installer 03:33:56 INFO - Options: 03:33:56 INFO - -h, --help show this help message and exit 03:33:56 INFO - -d DEST, --destination=DEST 03:33:56 INFO - Directory to install application into. [default: 03:33:56 INFO - "/builds/slave/test"] 03:33:56 INFO - --app=APP Application being installed. [default: firefox] 03:33:56 INFO - mkdir: /builds/slave/test/build/application 03:33:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:34:11 INFO - Reading from file tmpfile_stdout 03:34:11 INFO - Output received: 03:34:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:34:11 INFO - Running post-action listener: _resource_record_post_action 03:34:11 INFO - [mozharness: 2017-04-07 10:34:11.454912Z] Finished install step (success) 03:34:11 INFO - [mozharness: 2017-04-07 10:34:11.455058Z] Running run-tests step. 03:34:11 INFO - Running pre-action listener: _resource_record_pre_action 03:34:11 INFO - Running main action method: run_tests 03:34:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:34:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:34:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:34:11 INFO - 2017-04-07 03:34:11.469 screenresolution[6630:121715] starting screenresolution argv=screenresolution get 03:34:11 INFO - 2017-04-07 03:34:11.472 screenresolution[6630:121715] Display 0: 1600x1200x32@60 03:34:11 INFO - 2017-04-07 03:34:11.478 screenresolution[6631:121717] starting screenresolution argv=screenresolution list 03:34:11 INFO - Available Modes on Display 0 03:34:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:34:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:34:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:34:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:34:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:34:11 INFO - Intel Iris: 03:34:11 INFO - Chipset Model: Intel Iris 03:34:11 INFO - Type: GPU 03:34:11 INFO - Bus: Built-In 03:34:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:34:11 INFO - Vendor: Intel (0x8086) 03:34:11 INFO - Device ID: 0x0a2e 03:34:11 INFO - Revision ID: 0x0009 03:34:11 INFO - Displays: 03:34:11 INFO - Display: 03:34:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:34:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:34:11 INFO - Display Serial Number: 1600x1200 60 03:34:11 INFO - Main Display: Yes 03:34:11 INFO - Mirror: Off 03:34:11 INFO - Online: Yes 03:34:11 INFO - Rotation: Supported 03:34:11 INFO - Return code: 0 03:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:11 INFO - Python 2.7.3 03:34:11 INFO - Return code: 0 03:34:11 INFO - grabbing minidump binary from tooltool 03:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:11 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 0x10a1c4d30>, '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 0x10a0ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:11 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 03:34:11 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 03:34:11 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 03:34:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:11 INFO - Return code: 0 03:34:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:34:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:34:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 03:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --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 03:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JQieJ01SC8/Render', 03:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:11 INFO - 'HOME': '/Users/cltbld', 03:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:11 INFO - 'LOGNAME': 'cltbld', 03:34:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:11 INFO - 'MOZ_NO_REMOTE': '1', 03:34:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:11 INFO - 'NO_EM_RESTART': '1', 03:34:11 INFO - 'PAGER': '/bin/cat', 03:34:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:11 INFO - 'PWD': '/builds/slave/test', 03:34:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:11 INFO - 'SHELL': '/bin/bash', 03:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFG8iJvdVH/Listeners', 03:34:11 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 03:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:11 INFO - 'USER': 'cltbld', 03:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:11 INFO - 'XPC_FLAGS': '0x0', 03:34:11 INFO - 'XPC_SERVICE_NAME': '0', 03:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 03:34:12 INFO - mozversion application_buildid: 20170407021633 03:34:12 INFO - mozversion application_changeset: 21fda0371ac39ccfffc63b703d89c9f55ad62da4 03:34:12 INFO - mozversion application_display_name: Firefox 03:34:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:12 INFO - mozversion application_name: Firefox 03:34:12 INFO - mozversion application_remotingname: firefox 03:34:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:34:12 INFO - mozversion application_vendor: Mozilla 03:34:12 INFO - mozversion application_version: 53.0 03:34:12 INFO - mozversion platform_buildid: 20170407021633 03:34:12 INFO - mozversion platform_changeset: 21fda0371ac39ccfffc63b703d89c9f55ad62da4 03:34:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:34:12 INFO - mozversion platform_version: 53.0 03:34:12 INFO - using testdate: 1491561252 03:34:12 INFO - actual date: 1491561252 03:34:12 INFO - starting webserver on 'localhost:58086' 03:34:12 INFO - SUITE-START | Running 2 tests 03:34:12 INFO - TEST-START | dromaeo_css 03:34:12 INFO - operating with platform_type : mac_ 03:34:12 INFO - Initialising browser for dromaeo_css test... 03:34:12 INFO - TEST-INFO | started process 6641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpcJFILC/profile http://localhost:58086/getInfo.html) 03:34:14 INFO - PROCESS | 6641 | 2017-04-07 03:34:14.733 plugin-container[6644:121879] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.tsm.portname' 03:34:14 INFO - PROCESS | 6641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:14 INFO - PROCESS | 6641 | 2017-04-07 03:34:14.733 plugin-container[6644:121879] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 03:34:14 INFO - PROCESS | 6641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:14 INFO - PROCESS | 6641 | 2017-04-07 03:34:14.733 plugin-container[6644:121879] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:34:14 INFO - PROCESS | 6641 | __metrics Screen width/height:1600/1200 03:34:14 INFO - PROCESS | 6641 | colorDepth:24 03:34:14 INFO - PROCESS | 6641 | Browser inner width/height: 1024/689 03:34:14 INFO - PROCESS | 6641 | __metrics 03:34:14 ERROR - PROCESS | 6641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 03:34:15 INFO - TEST-INFO | 6641: exit 0 03:34:15 INFO - Browser initialized. 03:34:15 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:15 INFO - TEST-INFO | started process 6646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpcJFILC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:17 INFO - PROCESS | 6646 | 2017-04-07 03:34:17.711 plugin-container[6647:122020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 03:34:17 INFO - PROCESS | 6646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:17 INFO - PROCESS | 6646 | 2017-04-07 03:34:17.711 plugin-container[6647:122020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880f, name = 'com.apple.CFPasteboardClient' 03:34:17 INFO - PROCESS | 6646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:34:17 INFO - PROCESS | 6646 | 2017-04-07 03:34:17.711 plugin-container[6647:122020] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:34:27 INFO - PROCESS | 6646 | RSS: Main: 172843008 03:34:27 INFO - PROCESS | 6646 | 03:37:29 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58086/tests/dromaeo/cssquery-ext.html) 03:37:31 INFO - PROCESS | 6646 | RSS: Main: 189071360 03:37:31 INFO - PROCESS | 6646 | 03:40:33 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-ext.html (next: http://localhost:58086/tests/dromaeo/cssquery-jquery.html) 03:40:34 INFO - PROCESS | 6646 | RSS: Main: 200269824 03:40:34 INFO - PROCESS | 6646 | 03:43:35 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58086/tests/dromaeo/cssquery-mootools.html) 03:43:36 INFO - PROCESS | 6646 | RSS: Main: 202264576 03:43:36 INFO - PROCESS | 6646 | 03:46:38 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58086/tests/dromaeo/cssquery-prototype.html) 03:46:38 INFO - PROCESS | 6646 | RSS: Main: 205877248 03:46:38 INFO - PROCESS | 6646 | 03:49:41 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58086/tests/dromaeo/cssquery-yui.html) 03:49:42 INFO - PROCESS | 6646 | RSS: Main: 207990784 03:49:42 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-yui.html (next: http://localhost:58086/tests/dromaeo/cssquery-dojo.html) 03:52:45 INFO - PROCESS | 6646 | RSS: Main: 209096704 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | __start_tp_report 03:52:45 INFO - PROCESS | 6646 | _x_x_mozilla_page_load 03:52:45 INFO - PROCESS | 6646 | _x_x_mozilla_page_load_details 03:52:45 INFO - PROCESS | 6646 | |i|pagename|runs| 03:52:45 INFO - PROCESS | 6646 | |0;dojo.html;3095.969040309597;3555.288942211558;3572;3573.0710015396007;3577.2845430913817;5981;6060.727267272967;6073.423024812647;6080.543959203061;6104.938950610493;6007.15899774032;6082.361352058037;6089;6104.694765261741;6107.450329470346;5346.625736198468;5426.186072089179;5431.2396264522995;5436.3476382834115;5477.287952566161;4533.523979982104;5484.122540393538;5491.807786727465;5528.474794894479;5547.417521160281;5360.65155764874;5380.031594313022;5482.451754824526;5488.17677348399;5504;5352.973235133819;5395.919061214085;5413.133898576229;5464.016477034133;5510.586705997066;5258.763355648966;5431.185322201662;5434.7826086956475;5441.156620723755;5454.209139674765;5874.471297583238;5990.9101363479585;6044.2746870375395;6144.446999769997;6161.106639537287;6213.658248796314;6213.68931553425;6214.627122372672;6282.937170628326;6377.1709677742065;6390.073439351315;6409.3590640936;6430.517711171681;6442.130312407812;6448.484121270334;6153.323134455206;6166.044263139221;6184.412480814361;6224.346443623354;6226.875462490815;6362.331955144736;6362.9045564316575;6512;6512.185976752906;6514.315996820361;6309.810705678745;6317.9052314214405;6321.241451025814;6322.241331040213;6356.300806911236;6410.275543351218;6450.290468048511;6470.6441145737435;6497.02544618311;6499.772507962199;4920.6555541111775;5631.7184140793615;6172.197614310111;6205;6392;6332.176817013758;6335.239771227482;6337.6197428154455;6363.490920726424;6406.903896441557;5210.739463026834;5215.24378965048;5219;5228.63399562027;5232.476752324813;4537.568930951555;4587.610053145453;4632.119897219518;4649.163150632919;4691.483936766953;5140.588752899759;5180.663256888291;6132.846678832976;6152.692365381802;6194.938050619436;6466.676666166767;6484.578502397329;6487.967560162263;6503.349665033554;6530.020496925499;6074.362191969868;6111.95640283616;6125.235451818339;6128.754849806047;6168.753249870045;5709.143628455765;5717.313922329347;5726.942730572724;5732.856678582985;5734.197212390269;6648.785011317201;6664.300248473841;6666.433353165035;6669.933300667029;6687.431568316651;6112.898653789679;6205.5345849060595;6230.15892854477;6322.33615470369;6405.871882562229;5824.970875145597;6612.669366531558;6623.271440141484;6649.800505984828;6672.399484046265;6274.090256912813;6278.434940855345;6284.591501552384;6316.242050953915;6319.05214217871;5510.338759348904;5982.222311099529;6215.254169499689;6306.842328941813;6376.808695739135;4805.543473370024;5945.40545945402;6234.220722409699;6257.030160325156;6258.061290806233;6255.24937007562;6262.686865656608;6264.185655864709;6269.843253918689;6307.558470906993;6070.878582428415;6119.624418755179;6121.42248870793;6141.969290153521;6207.65857877803;6175.660338681416;6191.4118158774845;6208.627482351073;6267.749290028348;6286.5599408041;6206.224221972254;6228.283747369111;6233.189685340877;6248.562600617913;6251.593646412968 03:52:45 INFO - PROCESS | 6646 | |1;ext.html;497.2342592407691;501.7156080434089;523.3327507428031;530.2682298428169;556.8162506372895;34395.48406773897;44090;44094.559054409445;44225;44241.55758442415;44944.775276123655;45525;45581;45640.31539526901;45646.54353456465;9393.765155871106;9551.426914385125;9611.183049440806;11557.884421155806;11949.22330048544;11715;11725.472353744059;11833.349165795878;11845.703857403547;11848.763024739543;11705.946464818164;11765.352905590189;11818.468168932375;11870.228435151688;11872.287662740264;11746.706332341675;11807.940960295144;11827;11835.644930652008;11837.171398002143;10819.918008199116;11678.29930204182;11688.883111168949;11763.823542646867;11774.529018839236;35528;39631.009224769325;39886;40005.39991900095;40138.99652508681;3837.501124853779;3855.1904100139004;4105.384192371138;4121.711480196387;4183.247015537202;29208.561871571943;31109.68890311113;31361;31478.842605787053;31564.684353156405;3246.756493263015;3405.0976491229844;3428.7599868009247;3566.5911964774027;3573.6605022522817;521266;524806;525261;528044;528495.3575232137;59197;59479.702601486715;63013.68493157597;63083.369166308665;63224.68387658124;65480.69038619296;65903;65940.67029664821;66228;66557;17260.136993150543;17463;17572.03353815527;17595.94424334544;17745.290188392577;9870.703878883645;12284.201526900722;12614.495420183273;13041.413136408884;13082.607521774362;19137.61724765497;19328.323508677127;19418.90290548538;19456.513587160433;19559.706604400944;8224.38317126218;8316.501009939422;8326.833463330699;8327.417790619764;8388.622511986976;898.5327629632554;899.8875140607424;901.5537309032071;921.447131720962;940.520334629344;31521.684783152334;32011.51982720261;32037.51943720846;32639.51040734391;32900.67099329024;892.790194304338;919.6067957045082;1092.464692300767;1139.7663478986788;1206.089402501106;16665.416710415077;16711.83288167127;16757.748633770505;16779;16918;644011;650582;651950;652968;655465;66589.66705166444;67272.66363668151;67294;67297.99053014208;67309.3269067303;1340.7318536292585;1472.3521650473758;1509.524499782565;1525.0925699208954;1532.111375402264;29907.70092299049;31760.841195793873;31840.203994900312;32060.6793932067;32542.51186232161;56630;56957.715211423674;57230.71384643217;57271.713641431525;57332.71333643305;524221;525661;528297;529937;531883;24222.51554968926;25007.374815629755;29132.417351653272;29379.824807008335;29477;39310.719429121375;51840;52569.47430525646;53207.4679253218;53784.92430151297;30750.692493074785;34748;34759.82620086883;34921.65078349184;36040.27919441544;34495.655043449246;34656.82671586626;35137;35511.82244088763;35638.10904727299;40055.799721002375;40986;41329.58670413258;41609.79195104005;41619;34744;34764.82617586896;34780.30439391147;35354.46968295426;35414.64585354114;21257.68113478268;25526.617100743875;26453;27106.051288204817;27439.45121097527 03:52:45 INFO - PROCESS | 6646 | |2;jquery.html;345.29215109026495;395.73485764537776;398.76672146794124;404.49034216886713;424.92563801334757;20654.380368588947;21505.67741483879;21952.45118872027;22052.889735551318;22144.22495212668;21987.23044693436;22155.892205389708;22468.88765556174;22627.773722262773;22863.657045144337;5658.236138121362;5835.912461313083;5893.852653683649;5965.135055416962;5968.462838344548;5586.692731899744;5718.485336319731;5743.081107022877;5817.1565123057135;5864.237649105632;5759.942400576004;5810.477057064863;5821.825345239628;5831.883362332751;5845.327787304451;5545.972270138644;5685.772569097231;5751.597388182829;5765.481106700375;5820;5092.745362731848;5123.1546794778815;5133.101707201262;5134.383873935151;5143.562797162245;25118.748812512007;26336.8683156583;26350.341241468926;26712.065077722382;26787.598186027226;2433.549793288247;2699.7975151863493;2782.777377809791;2790.8046436749437;2816.366317578549;10438.478076096164;10527.631532896388;10600.522976466;10887.237893347468;10887.455627218687;1834.7064469684785;1886.9716954245698;1887.509247595635;1893.933712320076;1917.673995420782;116192;117392;123529.76470235363;126634;134679;11939.880601193878;12316;12339.69150771238;12345.444454999368;12363.505459781509;16027.519174424786;16275.59311017234;16314.184290785413;16330.918345408434;16383.83616163847;9167.587458564381;9209.76975575616;9360.812783744286;9362.297827662953;9441.008694087159;9085.727428177166;9096.681616143404;9149.679761208326;9226.723198304062;9251.259899208047;4951.603871690256;4956.4547899731;4958.9008219835405;5054.721990290495;5062.215356619729;1739.4259894235124;1789.5168304557697;2089.6552068908763;2101.821345185646;2113.218109299569;905.9909400906039;959.7984423271051;1000.2398177385239;1002.3735165521549;1021.5454122915231;17877.28490860351;21582.555259382527;21888.405617000124;21944.45138871541;22072.896355182176;1038.2783965144304;1038.5482315192914;1065.1159537583942;1065.5524679634573;1077.450500244865;11454.48454819535;11676.591319303783;11677.065834733201;11678.357690326944;11770.94114529439;765454.1727291328;769454;781247;793969;800763;153365;157631.21184394005;158627;159958;161232.19383903005;888.6045709659269;1032.3599368391644;1066.7706443114769;1071.919606029551;1077.6766969908997;18731.250749969848;19534.413967580997;19561.82629042262;19644.803551964298;19662.606747865248;46307.53692463167;47420.814479638284;51934.740326298124;59346.70326648339;60534.48663783441;65839;85582.7162592574;87319.56340218258;93089.5345523268;93700;7437.962810185914;7779.96110019469;8065.274125328514;8163.3469322452875;8995.55022248898;9495.340075351918;13735.313234338044;13780.586582402544;13892.16647001183;13909.234992075533;9884.209263258777;11230.83153752678;11606.24559403636;11790.823137653113;11800.232984855957;10784.544086548529;10797.62208322705;10827.296225745302;11114.999650031536;11150;11474.94262528682;11680.94159529197;11945.641630751092;12013.279203247834;12111.394430278628;7781.766547003599;7803.063632364153;8000.359971202406;8038.799030024296;8106.229908158715;8534.615942282488;11327.886721132683;11738.471768770596;11913.891758722264;12002.75994480123 03:52:45 INFO - PROCESS | 6646 | |3;mootools.html;1337.7057047449562;1437.209534755884;1497.715434067527;1499.6175975126334;1504.6313653154975;7797;7838.294553490185;8004.079530853954;8245.670173193073;8404.1175676554;8212.712555060574;8435.662573497053;8486.193811587904;8609.483430994145;8613.612387442565;2232.3079845247944;2262.6492893601517;2268.875211863347;2269.9886500567472;2277.3168049585142;2309.595820731365;2416.4442178298914;2435.062500937143;2437.9756202437925;2452.8773561321864;2385.0936644075227;2392.377981724747;2408.6748288981025;2410.09621391978;2423.248792874215;2336.3575016870327;2347.366211122996;2355.3993731598503;2359.5634807560655;2360.6813080234206;1999.5600967787063;2377.465070359173;2393.4614711689733;2395.988020059906;2399.8560086394873;8615.6984505542;8628.921384826897;8654.437461564978;8690.565471726388;8730.126987301219;4713.882152946169;5017.49825017499;5372.328458942632;5375.65058271215;5402.837914862561;3439.7764145330725;3631.1103779574173;3693.464447655102;3715.6655900969045;3722.1997270586685;1151.6429906728856;1215.1251099208555;1270.5743575902084;1288.6005338345144;1326.9469221231236;9504.524773761354;10942.4528773561;11210.663680089528;11216.831747523795;11223.046041086436;4136.855210067633;4537.909241815211;4824.589909857701;4891.1685013547785;4907.68100073494;9748.025197480196;9819.950900245452;9828.852567211497;9848.458334791656;9850.261230407748;5356.3572371315695;5433.185022246695;5459.262999495097;5466.671999680032;5477.945220547823;4297.8495752648505;4479.70881892676;4928.827491037797;4998.6500944933505;5003.449620541737;3275.7051865332232;3968.1865217630316;4019.8593049243136;4075.1645912587846;4095.447114639545;1298.68831480444;1306.660268330241;1311.540960663779;1315.7565850317721;1317.6771690935782;747.7794050755041;753.0962844586409;773.3194788586121;781.6990458673338;793.4414152525917;5631.465010823965;5681.318241810926;5781.93034288658;5828.88342233153;5967.1347654589845;547.1928904865372;568.5366426362501;574.9942500575024;580.3065336922338;583.5798225277794;3745.831437585315;3905.414187871842;3917.981324855558;4007.8998025049023;4203.43253660758;8743.213110820057;10120.240981926385;10441.634542790965;10458.52936617854;10474.214433917487;8703.521306328214;10324.948375258076;10423.166146708245;10429.426381548936;10462.895371046345;7739.961300193463;8130.75607731769;8185.754427367188;8245.628946697292;8248;5066.544011039025;5786.710664466844;5862.706864656835;6039.577229593886;6052.334243233329;9442.763930901783;9494.525273736424;9522.52387380642;9566.565015247768;9633;9485.19781241562;9576.329656923948;9592.23262139041;9677.854832177663;9799.902000980184;6017;6870.038194652852;7088.574685518885;7422.035135432359;7565.092188937363;7029;7987.32107770846;8270.586470676322;8275.83448331018;8319.708810191614;7065.505414621133;7190;7204.53170543913;7217.314355136254;7306.96346518264;6434.385933390276;6922.203946546211;7035.929640703527;7132.465065120241;7305.853882922418;6379.617222966637;6578.802635920739;6632.403083722488;6674.766383176566;6777.6272305023695;4999.925016121551;5095.617828662939;5108.106081435808;5157.742112894265;5203.921941170961;4656.1851675955895;5095.541401273903;5144.228365745168;5196.012757576049;5253.159494481018 03:52:45 INFO - PROCESS | 6646 | |4;prototype.html;362.28991177292505;367.16836365631843;374.5561509611111;377.23797928185047;382.12112142073244;4729.952700472999;4877.829275975333;5255.579553635709;5255.684658920458;5460.699661518614;5125.666831655949;5267.26258323835;5356.303680521536;5372.247885296062;5390.757415916283;3899.883003509899;4180.268453020717;4229.323308270662;4231;4242.724222925515;3946.605339466045;4200.97899510502;4204.759595919211;4217.831286748542;4255.404243405926;3480.495328177413;3682.808728806356;3690.3910854709075;3988.8603898863544;4159.625633692967;3508.544019186554;4154.231467178582;4192.287311157111;4202.075543380452;4331.783410829462;3066.0188739603336;3108.5958825352786;3159.4786860168047;3717.4609681596016;3720.660562197607;4531.682782205247;5067.594592432597;5117.257997590365;5165.974170129163;5258.316418865561;4645.744484053375;4812.326274321597;4862.100511405401;4868;4896.461389247215;4689.20283551797;5271.492873593061;5664.705794153375;5729.934485050478;5784.537237021028;3965.7620542767236;4087.5299340575916;4127.277726397869;4139.9172016559805;4160.771157586331;5897.941020589825;5925.4963328117165;5928.377520360386;5942.77146070228;5971.820845374646;3688.4222304364725;3700.796456194935;4095.9590404096175;4189.476315460567;4215.852445164404;3389.034125274285;3860.6718428933855;4206.747595144301;4257.318828987409;4266.701330906869;3773.735838491279;4547.613452856544;4860.878478038077;4875;4925.7783399747095;4573.5426457354;5443.591730620219;5677.744501497443;5768.74040668171;5776.757997030659;1277.5847849448967;1323.6360000999803;1347.5553067487706;1377.4008306386754;1386.9791953120712;842.0380513403754;983.257640481432;987.5753426026878;987.6938149173635;996.4370130876176;4372.562743725602;4615.891856247942;5069.9746501267255;5071.670341427795;5075;5240.667902783301;5337.973310133424;5505.3208771324325;5530.364008139116;5534.308211473566;4373.409589705349;4633.4671512775785;4711.419321315756;4996.275540046673;5066.544011039025;2302.9751760466766;2345.6247000479843;2536.847789132658;2727.754502094821;2798.258461507702;4951.3810773653295;5722.599418040781;5746.913796293059;5776.826695199151;5818.5636077294375;5242.266082748418;5379.327584051994;5483.451654834565;5667.90287593593;5737.770489180386;4751.762411879392;4834.371531700997;5151.892343146242;5237.790488380499;5767.336756273083;4696.1546921554445;4992.301077849177;5477.069767674275;5612.943870561242;5625.718714064198;4767.73777442244;4790.401199850019;5031.446540880427;5116.4627714090975;5469.781208751605;5124.743762811919;5667.744951477276;5749.453801888814;5752.511036561772;5847;3206.695363940422;3237.7733558650666;3714.368557345204;3734.57052438973;3802.1255111324;4601.792919318706;4810.302506136661;5537.390887002507;5545.698535107885;5557.305336832896;4813.614910807197;5092.668976516515;5470.64440811346;5593.524550413261;5618.606697531133;4784.15809913179;4966.726830024383;5608;5620.550355971594;5653.462921022497;4360.651147908223;4576.39826060876;4848.521201033718;5527;5541.727891564439;4366.104948485617;5066.670666406671;5478.342598888159;5665.150227465913;5733.71331433435;4933.975330123327;5530.336359636869;5577.163425486209;5611.438856114356;5618.915716264178 03:52:45 INFO - PROCESS | 6646 | |5;yui.html;706.2795948132901;710.6482291265825;798.2217338095354;885.1900511032405;889.8754174415582;15461.768073478906;16628.833711662908;16695.83304166958;16703.248353824078;16705.081220532866;14032.158070515776;15258.923705381458;15300;15409.152496612682;15494.69010619787;893.3389291923978;903.1735961595166;911.1799380557485;914.4604683236889;921.3458444504377;884.2174675412242;906.4108329585789;907.7231444409452;909.995450022749;911.2983003087619;970.7864269860619;975.4586204656413;976.843705007199;978.0659470205936;978.1392374710281;935.228436539854;949.430341794921;965.5799727118691;965.8454647256475;968.1045033344128;708.252793303065;721.0518168608263;722.0180554445949;727.9526830756037;728.2244409703702;14296.499622513162;14486.565403037926;14542.709145817025;14858.628534286621;14912;12293.938530307381;12400.875991240153;12408.81386779199;12524.81212781809;12704.364781760874;10990.670279891616;11168.329900206014;11247.943760281147;11398.60104896333;11569.768604627945;3503.754737168399;3685.8157092145284;3742.644448777362;3758.4926034985474;3844.461775351425;100283;105545.47227263814;110963.89036109616;111358.99999999919;111716;9407.247420206368;9418.905810941802;9487.098725621056;9602.9039709602;9820.852687209697;20753.896230518752;21053.157873684882;21105.26131585387;21110.89444552798;21111.68332475014;7979.680812767424;8128.109421827711;8173.918260817316;8281.668733250603;8484.618192181366;4460.130274596488;4474.7762611869275;4483.058557702919;4494.942690478688;4555.997680510282;3691.501647277637;3764.265968136242;3770.736048476635;3813.0657988792923;3818.121831978605;681.3765404654785;686.3136863136863;689.2418339826152;691.339770519153;692.9653517324215;693.9063226464464;705.336983235767;727.2509315405141;734.3941248470034;761.1969372312263;10628.202884783517;10720.142388609049;11027.117830573536;11074.446277686084;11255.963110876392;543.2014938041074;574.8332983434841;603.1856993059334;611.729946510815;618.6102755264154;5088.6946783193125;5235.424103348629;5237.764300606482;5240.502152295526;5251.8161864335325;105658;106983.46508267408;108196.45901770599;109605.45197273963;110248;59940.70029649824;68860.96708549376;70608.2939170612;87989;90748.73128171716;79573.4085318302;82455.17544824595;82567.99999999879;84045.57977210075;86641.56679216564;11129.721756956142;11181.32912025281;11263.49314280843;11394.715132121763;11407;49749.50250497449;51186;51687.74156129195;51709.22436163385;51794.48205517897;62785.174667141;64428.67785661042;65810.01284980633;65827;66938.66122677617;10608.681739547827;13970.441182352592;14189.148651080968;14305.785413218602;14404.207768572829;14743;14783;14890.404383824525;14935.029223100464;15036.097834129987;13895.305234738425;14353.712925741218;14512;14520.491782787552;14846.331915063633;13679.86320136786;14396.280185990869;14474.710505790035;14695;14844.781542554656;13131.540396086091;13771.724565508834;13982.930085349508;13998.214639952634;14049.859501404855;9787.51062446889;10009.5495702695;10220.846687299547;10237.488125593542;10590.470476475992;11217.214794964275;11368;11579.247348922294;11592.768144637228;11753.236039657395 03:52:45 INFO - PROCESS | 6646 | __end_tp_report 03:52:45 INFO - PROCESS | 6646 | __start_cc_report 03:52:45 INFO - PROCESS | 6646 | _x_x_mozilla_cycle_collect,373 03:52:45 INFO - PROCESS | 6646 | __end_cc_report 03:52:45 INFO - PROCESS | 6646 | __startTimestamp1491562365488__endTimestamp 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | ------- Summary: start ------- 03:52:45 INFO - PROCESS | 6646 | Number of tests: 6 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | [#0] dojo.html Cycles:165 Average:5923.86 Median:6168.75 stddev:657.61 (10.7%) stddev-sans-first:621.08 03:52:45 INFO - PROCESS | 6646 | Values: 3096.0 3555.3 3572.0 3573.1 3577.3 5981.0 6060.7 6073.4 6080.5 6104.9 6007.2 6082.4 6089.0 6104.7 6107.5 5346.6 5426.2 5431.2 5436.3 5477.3 4533.5 5484.1 5491.8 5528.5 5547.4 5360.7 5380.0 5482.5 5488.2 5504.0 5353.0 5395.9 5413.1 5464.0 5510.6 5258.8 5431.2 5434.8 5441.2 5454.2 5874.5 5990.9 6044.3 6144.4 6161.1 6213.7 6213.7 6214.6 6282.9 6377.2 6390.1 6409.4 6430.5 6442.1 6448.5 6153.3 6166.0 6184.4 6224.3 6226.9 6362.3 6362.9 6512.0 6512.2 6514.3 6309.8 6317.9 6321.2 6322.2 6356.3 6410.3 6450.3 6470.6 6497.0 6499.8 4920.7 5631.7 6172.2 6205.0 6392.0 6332.2 6335.2 6337.6 6363.5 6406.9 5210.7 5215.2 5219.0 5228.6 5232.5 4537.6 4587.6 4632.1 4649.2 4691.5 5140.6 5180.7 6132.8 6152.7 6194.9 6466.7 6484.6 6488.0 6503.3 6530.0 6074.4 6112.0 6125.2 6128.8 6168.8 5709.1 5717.3 5726.9 5732.9 5734.2 6648.8 6664.3 6666.4 6669.9 6687.4 6112.9 6205.5 6230.2 6322.3 6405.9 5825.0 6612.7 6623.3 6649.8 6672.4 6274.1 6278.4 6284.6 6316.2 6319.1 5510.3 5982.2 6215.3 6306.8 6376.8 4805.5 5945.4 6234.2 6257.0 6258.1 6255.2 6262.7 6264.2 6269.8 6307.6 6070.9 6119.6 6121.4 6142.0 6207.7 6175.7 6191.4 6208.6 6267.7 6286.6 6206.2 6228.3 6233.2 6248.6 6251.6 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | [#1] ext.html Cycles:180 Average:71375.06 Median:35519.91 stddev:152347.90 (428.9%) stddev-sans-first:152682.33 03:52:45 INFO - PROCESS | 6646 | Values: 497.2 501.7 523.3 530.3 556.8 34395.5 44090.0 44094.6 44225.0 44241.6 44944.8 45525.0 45581.0 45640.3 45646.5 9393.8 9551.4 9611.2 11557.9 11949.2 11715.0 11725.5 11833.3 11845.7 11848.8 11705.9 11765.4 11818.5 11870.2 11872.3 11746.7 11807.9 11827.0 11835.6 11837.2 10819.9 11678.3 11688.9 11763.8 11774.5 35528.0 39631.0 39886.0 40005.4 40139.0 3837.5 3855.2 4105.4 4121.7 4183.2 29208.6 31109.7 31361.0 31478.8 31564.7 3246.8 3405.1 3428.8 3566.6 3573.7 521266.0 524806.0 525261.0 528044.0 528495.4 59197.0 59479.7 63013.7 63083.4 63224.7 65480.7 65903.0 65940.7 66228.0 66557.0 17260.1 17463.0 17572.0 17595.9 17745.3 9870.7 12284.2 12614.5 13041.4 13082.6 19137.6 19328.3 19418.9 19456.5 19559.7 8224.4 8316.5 8326.8 8327.4 8388.6 898.5 899.9 901.6 921.4 940.5 31521.7 32011.5 32037.5 32639.5 32900.7 892.8 919.6 1092.5 1139.8 1206.1 16665.4 16711.8 16757.7 16779.0 16918.0 644011.0 650582.0 651950.0 652968.0 655465.0 66589.7 67272.7 67294.0 67298.0 67309.3 1340.7 1472.4 1509.5 1525.1 1532.1 29907.7 31760.8 31840.2 32060.7 32542.5 56630.0 56957.7 57230.7 57271.7 57332.7 524221.0 525661.0 528297.0 529937.0 531883.0 24222.5 25007.4 29132.4 29379.8 29477.0 39310.7 51840.0 52569.5 53207.5 53784.9 30750.7 34748.0 34759.8 34921.7 36040.3 34495.7 34656.8 35137.0 35511.8 35638.1 40055.8 40986.0 41329.6 41609.8 41619.0 34744.0 34764.8 34780.3 35354.5 35414.6 21257.7 25526.6 26453.0 27106.1 27439.5 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | [#2] jquery.html Cycles:180 Average:41661.58 Median:22312.39 stddev:129934.05 (582.3%) stddev-sans-first:130261.51 03:52:45 INFO - PROCESS | 6646 | Values: 345.3 395.7 398.8 404.5 424.9 20654.4 21505.7 21952.5 22052.9 22144.2 21987.2 22155.9 22468.9 22627.8 22863.7 5658.2 5835.9 5893.9 5965.1 5968.5 5586.7 5718.5 5743.1 5817.2 5864.2 5759.9 5810.5 5821.8 5831.9 5845.3 5546.0 5685.8 5751.6 5765.5 5820.0 5092.7 5123.2 5133.1 5134.4 5143.6 25118.7 26336.9 26350.3 26712.1 26787.6 2433.5 2699.8 2782.8 2790.8 2816.4 10438.5 10527.6 10600.5 10887.2 10887.5 1834.7 1887.0 1887.5 1893.9 1917.7 116192.0 117392.0 123529.8 126634.0 134679.0 11939.9 12316.0 12339.7 12345.4 12363.5 16027.5 16275.6 16314.2 16330.9 16383.8 9167.6 9209.8 9360.8 9362.3 9441.0 9085.7 9096.7 9149.7 9226.7 9251.3 4951.6 4956.5 4958.9 5054.7 5062.2 1739.4 1789.5 2089.7 2101.8 2113.2 906.0 959.8 1000.2 1002.4 1021.5 17877.3 21582.6 21888.4 21944.5 22072.9 1038.3 1038.5 1065.1 1065.6 1077.5 11454.5 11676.6 11677.1 11678.4 11770.9 765454.2 769454.0 781247.0 793969.0 800763.0 153365.0 157631.2 158627.0 159958.0 161232.2 888.6 1032.4 1066.8 1071.9 1077.7 18731.3 19534.4 19561.8 19644.8 19662.6 46307.5 47420.8 51934.7 59346.7 60534.5 65839.0 85582.7 87319.6 93089.5 93700.0 7438.0 7780.0 8065.3 8163.3 8995.6 9495.3 13735.3 13780.6 13892.2 13909.2 9884.2 11230.8 11606.2 11790.8 11800.2 10784.5 10797.6 10827.3 11115.0 11150.0 11474.9 11680.9 11945.6 12013.3 12111.4 7781.8 7803.1 8000.4 8038.8 8106.2 8534.6 11327.9 11738.5 11913.9 12002.8 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | [#3] mootools.html Cycles:180 Average:5535.48 Median:5364.34 stddev:3035.80 (56.6%) stddev-sans-first:3027.92 03:52:45 INFO - PROCESS | 6646 | Values: 1337.7 1437.2 1497.7 1499.6 1504.6 7797.0 7838.3 8004.1 8245.7 8404.1 8212.7 8435.7 8486.2 8609.5 8613.6 2232.3 2262.6 2268.9 2270.0 2277.3 2309.6 2416.4 2435.1 2438.0 2452.9 2385.1 2392.4 2408.7 2410.1 2423.2 2336.4 2347.4 2355.4 2359.6 2360.7 1999.6 2377.5 2393.5 2396.0 2399.9 8615.7 8628.9 8654.4 8690.6 8730.1 4713.9 5017.5 5372.3 5375.7 5402.8 3439.8 3631.1 3693.5 3715.7 3722.2 1151.6 1215.1 1270.6 1288.6 1326.9 9504.5 10942.5 11210.7 11216.8 11223.0 4136.9 4537.9 4824.6 4891.2 4907.7 9748.0 9820.0 9828.9 9848.5 9850.3 5356.4 5433.2 5459.3 5466.7 5477.9 4297.8 4479.7 4928.8 4998.7 5003.4 3275.7 3968.2 4019.9 4075.2 4095.4 1298.7 1306.7 1311.5 1315.8 1317.7 747.8 753.1 773.3 781.7 793.4 5631.5 5681.3 5781.9 5828.9 5967.1 547.2 568.5 575.0 580.3 583.6 3745.8 3905.4 3918.0 4007.9 4203.4 8743.2 10120.2 10441.6 10458.5 10474.2 8703.5 10324.9 10423.2 10429.4 10462.9 7740.0 8130.8 8185.8 8245.6 8248.0 5066.5 5786.7 5862.7 6039.6 6052.3 9442.8 9494.5 9522.5 9566.6 9633.0 9485.2 9576.3 9592.2 9677.9 9799.9 6017.0 6870.0 7088.6 7422.0 7565.1 7029.0 7987.3 8270.6 8275.8 8319.7 7065.5 7190.0 7204.5 7217.3 7307.0 6434.4 6922.2 7035.9 7132.5 7305.9 6379.6 6578.8 6632.4 6674.8 6777.6 4999.9 5095.6 5108.1 5157.7 5203.9 4656.2 5095.5 5144.2 5196.0 5253.2 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | [#4] prototype.html Cycles:180 Average:4467.16 Median:4887.15 stddev:1344.89 (27.5%) stddev-sans-first:1312.89 03:52:45 INFO - PROCESS | 6646 | Values: 362.3 367.2 374.6 377.2 382.1 4730.0 4877.8 5255.6 5255.7 5460.7 5125.7 5267.3 5356.3 5372.2 5390.8 3899.9 4180.3 4229.3 4231.0 4242.7 3946.6 4201.0 4204.8 4217.8 4255.4 3480.5 3682.8 3690.4 3988.9 4159.6 3508.5 4154.2 4192.3 4202.1 4331.8 3066.0 3108.6 3159.5 3717.5 3720.7 4531.7 5067.6 5117.3 5166.0 5258.3 4645.7 4812.3 4862.1 4868.0 4896.5 4689.2 5271.5 5664.7 5729.9 5784.5 3965.8 4087.5 4127.3 4139.9 4160.8 5897.9 5925.5 5928.4 5942.8 5971.8 3688.4 3700.8 4096.0 4189.5 4215.9 3389.0 3860.7 4206.7 4257.3 4266.7 3773.7 4547.6 4860.9 4875.0 4925.8 4573.5 5443.6 5677.7 5768.7 5776.8 1277.6 1323.6 1347.6 1377.4 1387.0 842.0 983.3 987.6 987.7 996.4 4372.6 4615.9 5070.0 5071.7 5075.0 5240.7 5338.0 5505.3 5530.4 5534.3 4373.4 4633.5 4711.4 4996.3 5066.5 2303.0 2345.6 2536.8 2727.8 2798.3 4951.4 5722.6 5746.9 5776.8 5818.6 5242.3 5379.3 5483.5 5667.9 5737.8 4751.8 4834.4 5151.9 5237.8 5767.3 4696.2 4992.3 5477.1 5612.9 5625.7 4767.7 4790.4 5031.4 5116.5 5469.8 5124.7 5667.7 5749.5 5752.5 5847.0 3206.7 3237.8 3714.4 3734.6 3802.1 4601.8 4810.3 5537.4 5545.7 5557.3 4813.6 5092.7 5470.6 5593.5 5618.6 4784.2 4966.7 5608.0 5620.6 5653.5 4360.7 4576.4 4848.5 5527.0 5541.7 4366.1 5066.7 5478.3 5665.2 5733.7 4934.0 5530.3 5577.2 5611.4 5618.9 03:52:45 INFO - PROCESS | 6646 | 03:52:45 INFO - PROCESS | 6646 | [#5] yui.html Cycles:180 Average:20533.52 Median:3791.90 stddev:29428.37 (776.1%) stddev-sans-first:29473.26 03:52:45 INFO - PROCESS | 6646 | Values: 706.3 710.6 798.2 885.2 889.9 15461.8 16628.8 16695.8 16703.2 16705.1 14032.2 15258.9 15300.0 15409.2 15494.7 893.3 903.2 911.2 914.5 921.3 884.2 906.4 907.7 910.0 911.3 970.8 975.5 976.8 978.1 978.1 935.2 949.4 965.6 965.8 968.1 708.3 721.1 722.0 728.0 728.2 14296.5 14486.6 14542.7 14858.6 14912.0 12293.9 12400.9 12408.8 12524.8 12704.4 10990.7 11168.3 11247.9 11398.6 11569.8 3503.8 3685.8 3742.6 3758.5 3844.5 100283.0 105545.5 110963.9 111359.0 111716.0 9407.2 9418.9 9487.1 9602.9 9820.9 20753.9 21053.2 21105.3 21110.9 21111.7 7979.7 8128.1 8173.9 8281.7 8484.6 4460.1 4474.8 4483.1 4494.9 4556.0 3691.5 3764.3 3770.7 3813.1 3818.1 681.4 686.3 689.2 691.3 693.0 693.9 705.3 727.3 734.4 761.2 10628.2 10720.1 11027.1 11074.4 11256.0 543.2 574.8 603.2 611.7 618.6 5088.7 5235.4 5237.8 5240.5 5251.8 105658.0 106983.5 108196.5 109605.5 110248.0 59940.7 68861.0 70608.3 87989.0 90748.7 79573.4 82455.2 82568.0 84045.6 86641.6 11129.7 11181.3 11263.5 11394.7 11407.0 49749.5 51186.0 51687.7 51709.2 51794.5 62785.2 64428.7 65810.0 65827.0 66938.7 10608.7 13970.4 14189.1 14305.8 14404.2 14743.0 14783.0 14890.4 14935.0 15036.1 13895.3 14353.7 14512.0 14520.5 14846.3 13679.9 14396.3 14474.7 14695.0 14844.8 13131.5 13771.7 13982.9 13998.2 14049.9 9787.5 10009.5 10220.8 10237.5 10590.5 11217.2 11368.0 11579.2 11592.8 11753.2 03:52:45 INFO - PROCESS | 6646 | -------- Summary: end -------- 03:52:45 INFO - PROCESS | 6646 | 03:52:46 INFO - TEST-INFO | 6646: exit 0 03:52:46 INFO - TEST-OK | dromaeo_css | took 1114005ms 03:52:46 INFO - TEST-START | kraken 03:52:46 INFO - operating with platform_type : mac_ 03:52:46 INFO - Initialising browser for kraken test... 03:52:46 INFO - TEST-INFO | started process 6676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpNnb0Ah/profile http://localhost:58086/getInfo.html) 03:52:48 INFO - PROCESS | 6676 | 2017-04-07 03:52:48.762 plugin-container[6678:124028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864f, name = 'com.apple.tsm.portname' 03:52:48 INFO - PROCESS | 6676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:48 INFO - PROCESS | 6676 | 2017-04-07 03:52:48.763 plugin-container[6678:124028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 03:52:48 INFO - PROCESS | 6676 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:48 INFO - PROCESS | 6676 | 2017-04-07 03:52:48.763 plugin-container[6678:124028] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:52:48 INFO - PROCESS | 6676 | __metrics Screen width/height:1600/1200 03:52:48 INFO - PROCESS | 6676 | colorDepth:24 03:52:48 INFO - PROCESS | 6676 | Browser inner width/height: 1024/689 03:52:48 INFO - PROCESS | 6676 | __metrics 03:52:48 ERROR - PROCESS | 6676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 03:52:49 INFO - TEST-INFO | 6676: exit 0 03:52:49 INFO - Browser initialized. 03:52:49 INFO - Running cycle 1/1 for kraken test... 03:52:49 INFO - TEST-INFO | started process 6679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpNnb0Ah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:51 INFO - PROCESS | 6679 | 2017-04-07 03:52:51.773 plugin-container[6680:124155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833b, name = 'com.apple.tsm.portname' 03:52:51 INFO - PROCESS | 6679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:51 INFO - PROCESS | 6679 | 2017-04-07 03:52:51.774 plugin-container[6680:124155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890f, name = 'com.apple.CFPasteboardClient' 03:52:51 INFO - PROCESS | 6679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:52:51 INFO - PROCESS | 6679 | 2017-04-07 03:52:51.774 plugin-container[6680:124155] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:53:01 INFO - PROCESS | 6679 | RSS: Main: 172986368 03:53:01 INFO - PROCESS | 6679 | 03:53:04 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:05 INFO - PROCESS | 6679 | RSS: Main: 185974784 03:53:05 INFO - PROCESS | 6679 | 03:53:08 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-dft) 03:53:08 INFO - PROCESS | 6679 | RSS: Main: 194617344 03:53:08 INFO - PROCESS | 6679 | 03:53:12 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-fft) 03:53:12 INFO - PROCESS | 6679 | RSS: Main: 198017024 03:53:12 INFO - PROCESS | 6679 | 03:53:14 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-oscillator) 03:53:15 INFO - PROCESS | 6679 | RSS: Main: 197881856 03:53:15 INFO - PROCESS | 6679 | 03:53:17 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58086/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:18 INFO - PROCESS | 6679 | RSS: Main: 197873664 03:53:18 INFO - PROCESS | 6679 | 03:53:20 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58086/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:21 INFO - PROCESS | 6679 | RSS: Main: 202399744 03:53:21 INFO - PROCESS | 6679 | 03:53:24 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58086/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:25 INFO - PROCESS | 6679 | RSS: Main: 201125888 03:53:25 INFO - PROCESS | 6679 | 03:53:28 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58086/tests/kraken/driver.html?testName=json-parse-financial) 03:53:28 INFO - PROCESS | 6679 | RSS: Main: 201113600 03:53:28 INFO - PROCESS | 6679 | 03:53:30 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58086/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:31 INFO - PROCESS | 6679 | RSS: Main: 201875456 03:53:31 INFO - PROCESS | 6679 | 03:53:32 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:33 INFO - PROCESS | 6679 | RSS: Main: 201871360 03:53:33 INFO - PROCESS | 6679 | 03:53:35 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:36 INFO - PROCESS | 6679 | RSS: Main: 201871360 03:53:36 INFO - PROCESS | 6679 | 03:53:39 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:40 INFO - PROCESS | 6679 | RSS: Main: 202227712 03:53:40 INFO - PROCESS | 6679 | 03:53:42 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:43 INFO - PROCESS | 6679 | RSS: Main: 202317824 03:53:43 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58086/tests/kraken/driver.html?testName=ai-astar) 03:53:45 INFO - PROCESS | 6679 | RSS: Main: 204259328 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | __start_tp_report 03:53:45 INFO - PROCESS | 6679 | _x_x_mozilla_page_load 03:53:45 INFO - PROCESS | 6679 | _x_x_mozilla_page_load_details 03:53:45 INFO - PROCESS | 6679 | |i|pagename|runs| 03:53:45 INFO - PROCESS | 6679 | |0;ai-astar;129;153;175;172;147;118;117;117;116;116 03:53:45 INFO - PROCESS | 6679 | |1;audio-beat-detection;181;112;113;151;113;115;141;141;146;101 03:53:45 INFO - PROCESS | 6679 | |2;audio-dft;198;206;197;200;198;198;202;251;274;222 03:53:45 INFO - PROCESS | 6679 | |3;audio-fft;83;59;60;86;61;59;59;59;72;58 03:53:45 INFO - PROCESS | 6679 | |4;audio-oscillator;89;70;84;73;72;71;82;70;71;80 03:53:45 INFO - PROCESS | 6679 | |5;imaging-gaussian-blur;91;85;89;86;90;87;89;123;99;88 03:53:45 INFO - PROCESS | 6679 | |6;imaging-darkroom;103;114;98;146;132;95;97;96;95;96 03:53:45 INFO - PROCESS | 6679 | |7;imaging-desaturate;100;95;92;110;144;143;95;92;94;95 03:53:45 INFO - PROCESS | 6679 | |8;json-parse-financial;57;57;58;58;60;62;60;62;61;60 03:53:45 INFO - PROCESS | 6679 | |9;json-stringify-tinderbox;67;75;70;107;80;76;70;70;70;71 03:53:45 INFO - PROCESS | 6679 | |10;stanford-crypto-aes;82;82;85;79;86;82;87;88;88;85 03:53:45 INFO - PROCESS | 6679 | |11;stanford-crypto-ccm;150;151;146;132;135;145;159;161;198;147 03:53:45 INFO - PROCESS | 6679 | |12;stanford-crypto-pbkdf2;166;167;167;166;166;165;192;172;163;166 03:53:45 INFO - PROCESS | 6679 | |13;stanford-crypto-sha256-iterative;67;65;65;65;67;64;64;68;65;66 03:53:45 INFO - PROCESS | 6679 | __end_tp_report 03:53:45 INFO - PROCESS | 6679 | __start_cc_report 03:53:45 INFO - PROCESS | 6679 | _x_x_mozilla_cycle_collect,941 03:53:45 INFO - PROCESS | 6679 | __end_cc_report 03:53:45 INFO - PROCESS | 6679 | __startTimestamp1491562425397__endTimestamp 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | ------- Summary: start ------- 03:53:45 INFO - PROCESS | 6679 | Number of tests: 14 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#0] ai-astar Cycles:10 Average:136.00 Median:138.00 stddev:23.86 (17.3%) stddev-sans-first:25.17 03:53:45 INFO - PROCESS | 6679 | Values: 129.0 153.0 175.0 172.0 147.0 118.0 117.0 117.0 116.0 116.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:141.00 stddev:24.69 (17.5%) stddev-sans-first:18.56 03:53:45 INFO - PROCESS | 6679 | Values: 181.0 112.0 113.0 151.0 113.0 115.0 141.0 141.0 146.0 101.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#2] audio-dft Cycles:10 Average:214.60 Median:204.00 stddev:26.85 (13.2%) stddev-sans-first:27.80 03:53:45 INFO - PROCESS | 6679 | Values: 198.0 206.0 197.0 200.0 198.0 198.0 202.0 251.0 274.0 222.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:10.77 (17.8%) stddev-sans-first:9.41 03:53:45 INFO - PROCESS | 6679 | Values: 83.0 59.0 60.0 86.0 61.0 59.0 59.0 59.0 72.0 58.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:76.50 stddev:6.92 (9.1%) stddev-sans-first:5.59 03:53:45 INFO - PROCESS | 6679 | Values: 89.0 70.0 84.0 73.0 72.0 71.0 82.0 70.0 71.0 80.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:89.00 stddev:11.32 (12.7%) stddev-sans-first:11.99 03:53:45 INFO - PROCESS | 6679 | Values: 91.0 85.0 89.0 86.0 90.0 87.0 89.0 123.0 99.0 88.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:95.50 stddev:18.02 (18.9%) stddev-sans-first:19.05 03:53:45 INFO - PROCESS | 6679 | Values: 103.0 114.0 98.0 146.0 132.0 95.0 97.0 96.0 95.0 96.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:93.00 stddev:20.45 (22.0%) stddev-sans-first:21.58 03:53:45 INFO - PROCESS | 6679 | Values: 100.0 95.0 92.0 110.0 144.0 143.0 95.0 92.0 94.0 95.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:60.00 stddev:1.90 (3.2%) stddev-sans-first:1.79 03:53:45 INFO - PROCESS | 6679 | Values: 57.0 57.0 58.0 58.0 60.0 62.0 60.0 62.0 61.0 60.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#9] json-stringify-tinderbox Cycles:10 Average:75.60 Median:70.50 stddev:11.67 (16.6%) stddev-sans-first:11.96 03:53:45 INFO - PROCESS | 6679 | Values: 67.0 75.0 70.0 107.0 80.0 76.0 70.0 70.0 70.0 71.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.50 stddev:3.03 (3.5%) stddev-sans-first:3.08 03:53:45 INFO - PROCESS | 6679 | Values: 82.0 82.0 85.0 79.0 86.0 82.0 87.0 88.0 88.0 85.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:150.50 stddev:18.40 (12.2%) stddev-sans-first:19.50 03:53:45 INFO - PROCESS | 6679 | Values: 150.0 151.0 146.0 132.0 135.0 145.0 159.0 161.0 198.0 147.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:166.50 stddev:8.39 (5.0%) stddev-sans-first:8.83 03:53:45 INFO - PROCESS | 6679 | Values: 166.0 167.0 167.0 166.0 166.0 165.0 192.0 172.0 163.0 166.0 03:53:45 INFO - PROCESS | 6679 | 03:53:45 INFO - PROCESS | 6679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.35 (2.1%) stddev-sans-first:1.33 03:53:45 INFO - PROCESS | 6679 | Values: 67.0 65.0 65.0 65.0 67.0 64.0 64.0 68.0 65.0 66.0 03:53:45 INFO - PROCESS | 6679 | -------- Summary: end -------- 03:53:45 INFO - PROCESS | 6679 | 03:53:46 INFO - TEST-INFO | 6679: exit 0 03:53:46 INFO - TEST-OK | kraken | took 60357ms 03:53:46 INFO - SUITE-END | took 1174s 03:53:46 INFO - Completed test suite (00:19:34) 03:53:46 INFO - javascript benchmark 03:53:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7464.374638099426, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.969040309597, 3555.288942211558, 3572.0, 3573.0710015396007, 3577.2845430913817, 5981.0, 6060.727267272967, 6073.423024812647, 6080.543959203061, 6104.938950610493, 6007.15899774032, 6082.361352058037, 6089.0, 6104.694765261741, 6107.450329470346, 5346.625736198468, 5426.186072089179, 5431.2396264522995, 5436.3476382834115, 5477.287952566161, 4533.523979982104, 5484.122540393538, 5491.807786727465, 5528.474794894479, 5547.417521160281, 5360.65155764874, 5380.031594313022, 5482.451754824526, 5488.17677348399, 5504.0, 5352.973235133819, 5395.919061214085, 5413.133898576229, 5464.016477034133, 5510.586705997066, 5258.763355648966, 5431.185322201662, 5434.7826086956475, 5441.156620723755, 5454.209139674765, 5874.471297583238, 5990.9101363479585, 6044.2746870375395, 6144.446999769997, 6161.106639537287, 6213.658248796314, 6213.68931553425, 6214.627122372672, 6282.937170628326, 6377.1709677742065, 6390.073439351315, 6409.3590640936, 6430.517711171681, 6442.130312407812, 6448.484121270334, 6153.323134455206, 6166.044263139221, 6184.412480814361, 6224.346443623354, 6226.875462490815, 6362.331955144736, 6362.9045564316575, 6512.0, 6512.185976752906, 6514.315996820361, 6309.810705678745, 6317.9052314214405, 6321.241451025814, 6322.241331040213, 6356.300806911236, 6410.275543351218, 6450.290468048511, 6470.6441145737435, 6497.02544618311, 6499.772507962199, 4920.6555541111775, 5631.7184140793615, 6172.197614310111, 6205.0, 6392.0, 6332.176817013758, 6335.239771227482, 6337.6197428154455, 6363.490920726424, 6406.903896441557, 5210.739463026834, 5215.24378965048, 5219.0, 5228.63399562027, 5232.476752324813, 4537.568930951555, 4587.610053145453, 4632.119897219518, 4649.163150632919, 4691.483936766953, 5140.588752899759, 5180.663256888291, 6132.846678832976, 6152.692365381802, 6194.938050619436, 6466.676666166767, 6484.578502397329, 6487.967560162263, 6503.349665033554, 6530.020496925499, 6074.362191969868, 6111.95640283616, 6125.235451818339, 6128.754849806047, 6168.753249870045, 5709.143628455765, 5717.313922329347, 5726.942730572724, 5732.856678582985, 5734.197212390269, 6648.785011317201, 6664.300248473841, 6666.433353165035, 6669.933300667029, 6687.431568316651, 6112.898653789679, 6205.5345849060595, 6230.15892854477, 6322.33615470369, 6405.871882562229, 5824.970875145597, 6612.669366531558, 6623.271440141484, 6649.800505984828, 6672.399484046265, 6274.090256912813, 6278.434940855345, 6284.591501552384, 6316.242050953915, 6319.05214217871, 5510.338759348904, 5982.222311099529, 6215.254169499689, 6306.842328941813, 6376.808695739135, 4805.543473370024, 5945.40545945402, 6234.220722409699, 6257.030160325156, 6258.061290806233, 6255.24937007562, 6262.686865656608, 6264.185655864709, 6269.843253918689, 6307.558470906993, 6070.878582428415, 6119.624418755179, 6121.42248870793, 6141.969290153521, 6207.65857877803, 6175.660338681416, 6191.4118158774845, 6208.627482351073, 6267.749290028348, 6286.5599408041, 6206.224221972254, 6228.283747369111, 6233.189685340877, 6248.562600617913, 6251.593646412968], "value": 5884.162576400177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.2342592407691, 501.7156080434089, 523.3327507428031, 530.2682298428169, 556.8162506372895, 34395.48406773897, 44090.0, 44094.559054409445, 44225.0, 44241.55758442415, 44944.775276123655, 45525.0, 45581.0, 45640.31539526901, 45646.54353456465, 9393.765155871106, 9551.426914385125, 9611.183049440806, 11557.884421155806, 11949.22330048544, 11715.0, 11725.472353744059, 11833.349165795878, 11845.703857403547, 11848.763024739543, 11705.946464818164, 11765.352905590189, 11818.468168932375, 11870.228435151688, 11872.287662740264, 11746.706332341675, 11807.940960295144, 11827.0, 11835.644930652008, 11837.171398002143, 10819.918008199116, 11678.29930204182, 11688.883111168949, 11763.823542646867, 11774.529018839236, 35528.0, 39631.009224769325, 39886.0, 40005.39991900095, 40138.99652508681, 3837.501124853779, 3855.1904100139004, 4105.384192371138, 4121.711480196387, 4183.247015537202, 29208.561871571943, 31109.68890311113, 31361.0, 31478.842605787053, 31564.684353156405, 3246.756493263015, 3405.0976491229844, 3428.7599868009247, 3566.5911964774027, 3573.6605022522817, 521266.0, 524806.0, 525261.0, 528044.0, 528495.3575232137, 59197.0, 59479.702601486715, 63013.68493157597, 63083.369166308665, 63224.68387658124, 65480.69038619296, 65903.0, 65940.67029664821, 66228.0, 66557.0, 17260.136993150543, 17463.0, 17572.03353815527, 17595.94424334544, 17745.290188392577, 9870.703878883645, 12284.201526900722, 12614.495420183273, 13041.413136408884, 13082.607521774362, 19137.61724765497, 19328.323508677127, 19418.90290548538, 19456.513587160433, 19559.706604400944, 8224.38317126218, 8316.501009939422, 8326.833463330699, 8327.417790619764, 8388.622511986976, 898.5327629632554, 899.8875140607424, 901.5537309032071, 921.447131720962, 940.520334629344, 31521.684783152334, 32011.51982720261, 32037.51943720846, 32639.51040734391, 32900.67099329024, 892.790194304338, 919.6067957045082, 1092.464692300767, 1139.7663478986788, 1206.089402501106, 16665.416710415077, 16711.83288167127, 16757.748633770505, 16779.0, 16918.0, 644011.0, 650582.0, 651950.0, 652968.0, 655465.0, 66589.66705166444, 67272.66363668151, 67294.0, 67297.99053014208, 67309.3269067303, 1340.7318536292585, 1472.3521650473758, 1509.524499782565, 1525.0925699208954, 1532.111375402264, 29907.70092299049, 31760.841195793873, 31840.203994900312, 32060.6793932067, 32542.51186232161, 56630.0, 56957.715211423674, 57230.71384643217, 57271.713641431525, 57332.71333643305, 524221.0, 525661.0, 528297.0, 529937.0, 531883.0, 24222.51554968926, 25007.374815629755, 29132.417351653272, 29379.824807008335, 29477.0, 39310.719429121375, 51840.0, 52569.47430525646, 53207.4679253218, 53784.92430151297, 30750.692493074785, 34748.0, 34759.82620086883, 34921.65078349184, 36040.27919441544, 34495.655043449246, 34656.82671586626, 35137.0, 35511.82244088763, 35638.10904727299, 40055.799721002375, 40986.0, 41329.58670413258, 41609.79195104005, 41619.0, 34744.0, 34764.82617586896, 34780.30439391147, 35354.46968295426, 35414.64585354114, 21257.68113478268, 25526.617100743875, 26453.0, 27106.051288204817, 27439.45121097527], "value": 21102.14865367111, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.29215109026495, 395.73485764537776, 398.76672146794124, 404.49034216886713, 424.92563801334757, 20654.380368588947, 21505.67741483879, 21952.45118872027, 22052.889735551318, 22144.22495212668, 21987.23044693436, 22155.892205389708, 22468.88765556174, 22627.773722262773, 22863.657045144337, 5658.236138121362, 5835.912461313083, 5893.852653683649, 5965.135055416962, 5968.462838344548, 5586.692731899744, 5718.485336319731, 5743.081107022877, 5817.1565123057135, 5864.237649105632, 5759.942400576004, 5810.477057064863, 5821.825345239628, 5831.883362332751, 5845.327787304451, 5545.972270138644, 5685.772569097231, 5751.597388182829, 5765.481106700375, 5820.0, 5092.745362731848, 5123.1546794778815, 5133.101707201262, 5134.383873935151, 5143.562797162245, 25118.748812512007, 26336.8683156583, 26350.341241468926, 26712.065077722382, 26787.598186027226, 2433.549793288247, 2699.7975151863493, 2782.777377809791, 2790.8046436749437, 2816.366317578549, 10438.478076096164, 10527.631532896388, 10600.522976466, 10887.237893347468, 10887.455627218687, 1834.7064469684785, 1886.9716954245698, 1887.509247595635, 1893.933712320076, 1917.673995420782, 116192.0, 117392.0, 123529.76470235363, 126634.0, 134679.0, 11939.880601193878, 12316.0, 12339.69150771238, 12345.444454999368, 12363.505459781509, 16027.519174424786, 16275.59311017234, 16314.184290785413, 16330.918345408434, 16383.83616163847, 9167.587458564381, 9209.76975575616, 9360.812783744286, 9362.297827662953, 9441.008694087159, 9085.727428177166, 9096.681616143404, 9149.679761208326, 9226.723198304062, 9251.259899208047, 4951.603871690256, 4956.4547899731, 4958.9008219835405, 5054.721990290495, 5062.215356619729, 1739.4259894235124, 1789.5168304557697, 2089.6552068908763, 2101.821345185646, 2113.218109299569, 905.9909400906039, 959.7984423271051, 1000.2398177385239, 1002.3735165521549, 1021.5454122915231, 17877.28490860351, 21582.555259382527, 21888.405617000124, 21944.45138871541, 22072.896355182176, 1038.2783965144304, 1038.5482315192914, 1065.1159537583942, 1065.5524679634573, 1077.450500244865, 11454.48454819535, 11676.591319303783, 11677.065834733201, 11678.357690326944, 11770.94114529439, 765454.1727291328, 769454.0, 781247.0, 793969.0, 800763.0, 153365.0, 157631.21184394005, 158627.0, 159958.0, 161232.19383903005, 888.6045709659269, 1032.3599368391644, 1066.7706443114769, 1071.919606029551, 1077.6766969908997, 18731.250749969848, 19534.413967580997, 19561.82629042262, 19644.803551964298, 19662.606747865248, 46307.53692463167, 47420.814479638284, 51934.740326298124, 59346.70326648339, 60534.48663783441, 65839.0, 85582.7162592574, 87319.56340218258, 93089.5345523268, 93700.0, 7437.962810185914, 7779.96110019469, 8065.274125328514, 8163.3469322452875, 8995.55022248898, 9495.340075351918, 13735.313234338044, 13780.586582402544, 13892.16647001183, 13909.234992075533, 9884.209263258777, 11230.83153752678, 11606.24559403636, 11790.823137653113, 11800.232984855957, 10784.544086548529, 10797.62208322705, 10827.296225745302, 11114.999650031536, 11150.0, 11474.94262528682, 11680.94159529197, 11945.641630751092, 12013.279203247834, 12111.394430278628, 7781.766547003599, 7803.063632364153, 8000.359971202406, 8038.799030024296, 8106.229908158715, 8534.615942282488, 11327.886721132683, 11738.471768770596, 11913.891758722264, 12002.75994480123], "value": 10061.183671660898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.7057047449562, 1437.209534755884, 1497.715434067527, 1499.6175975126334, 1504.6313653154975, 7797.0, 7838.294553490185, 8004.079530853954, 8245.670173193073, 8404.1175676554, 8212.712555060574, 8435.662573497053, 8486.193811587904, 8609.483430994145, 8613.612387442565, 2232.3079845247944, 2262.6492893601517, 2268.875211863347, 2269.9886500567472, 2277.3168049585142, 2309.595820731365, 2416.4442178298914, 2435.062500937143, 2437.9756202437925, 2452.8773561321864, 2385.0936644075227, 2392.377981724747, 2408.6748288981025, 2410.09621391978, 2423.248792874215, 2336.3575016870327, 2347.366211122996, 2355.3993731598503, 2359.5634807560655, 2360.6813080234206, 1999.5600967787063, 2377.465070359173, 2393.4614711689733, 2395.988020059906, 2399.8560086394873, 8615.6984505542, 8628.921384826897, 8654.437461564978, 8690.565471726388, 8730.126987301219, 4713.882152946169, 5017.49825017499, 5372.328458942632, 5375.65058271215, 5402.837914862561, 3439.7764145330725, 3631.1103779574173, 3693.464447655102, 3715.6655900969045, 3722.1997270586685, 1151.6429906728856, 1215.1251099208555, 1270.5743575902084, 1288.6005338345144, 1326.9469221231236, 9504.524773761354, 10942.4528773561, 11210.663680089528, 11216.831747523795, 11223.046041086436, 4136.855210067633, 4537.909241815211, 4824.589909857701, 4891.1685013547785, 4907.68100073494, 9748.025197480196, 9819.950900245452, 9828.852567211497, 9848.458334791656, 9850.261230407748, 5356.3572371315695, 5433.185022246695, 5459.262999495097, 5466.671999680032, 5477.945220547823, 4297.8495752648505, 4479.70881892676, 4928.827491037797, 4998.6500944933505, 5003.449620541737, 3275.7051865332232, 3968.1865217630316, 4019.8593049243136, 4075.1645912587846, 4095.447114639545, 1298.68831480444, 1306.660268330241, 1311.540960663779, 1315.7565850317721, 1317.6771690935782, 747.7794050755041, 753.0962844586409, 773.3194788586121, 781.6990458673338, 793.4414152525917, 5631.465010823965, 5681.318241810926, 5781.93034288658, 5828.88342233153, 5967.1347654589845, 547.1928904865372, 568.5366426362501, 574.9942500575024, 580.3065336922338, 583.5798225277794, 3745.831437585315, 3905.414187871842, 3917.981324855558, 4007.8998025049023, 4203.43253660758, 8743.213110820057, 10120.240981926385, 10441.634542790965, 10458.52936617854, 10474.214433917487, 8703.521306328214, 10324.948375258076, 10423.166146708245, 10429.426381548936, 10462.895371046345, 7739.961300193463, 8130.75607731769, 8185.754427367188, 8245.628946697292, 8248.0, 5066.544011039025, 5786.710664466844, 5862.706864656835, 6039.577229593886, 6052.334243233329, 9442.763930901783, 9494.525273736424, 9522.52387380642, 9566.565015247768, 9633.0, 9485.19781241562, 9576.329656923948, 9592.23262139041, 9677.854832177663, 9799.902000980184, 6017.0, 6870.038194652852, 7088.574685518885, 7422.035135432359, 7565.092188937363, 7029.0, 7987.32107770846, 8270.586470676322, 8275.83448331018, 8319.708810191614, 7065.505414621133, 7190.0, 7204.53170543913, 7217.314355136254, 7306.96346518264, 6434.385933390276, 6922.203946546211, 7035.929640703527, 7132.465065120241, 7305.853882922418, 6379.617222966637, 6578.802635920739, 6632.403083722488, 6674.766383176566, 6777.6272305023695, 4999.925016121551, 5095.617828662939, 5108.106081435808, 5157.742112894265, 5203.921941170961, 4656.1851675955895, 5095.541401273903, 5144.228365745168, 5196.012757576049, 5253.159494481018], "value": 4436.761381311393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.28991177292505, 367.16836365631843, 374.5561509611111, 377.23797928185047, 382.12112142073244, 4729.952700472999, 4877.829275975333, 5255.579553635709, 5255.684658920458, 5460.699661518614, 5125.666831655949, 5267.26258323835, 5356.303680521536, 5372.247885296062, 5390.757415916283, 3899.883003509899, 4180.268453020717, 4229.323308270662, 4231.0, 4242.724222925515, 3946.605339466045, 4200.97899510502, 4204.759595919211, 4217.831286748542, 4255.404243405926, 3480.495328177413, 3682.808728806356, 3690.3910854709075, 3988.8603898863544, 4159.625633692967, 3508.544019186554, 4154.231467178582, 4192.287311157111, 4202.075543380452, 4331.783410829462, 3066.0188739603336, 3108.5958825352786, 3159.4786860168047, 3717.4609681596016, 3720.660562197607, 4531.682782205247, 5067.594592432597, 5117.257997590365, 5165.974170129163, 5258.316418865561, 4645.744484053375, 4812.326274321597, 4862.100511405401, 4868.0, 4896.461389247215, 4689.20283551797, 5271.492873593061, 5664.705794153375, 5729.934485050478, 5784.537237021028, 3965.7620542767236, 4087.5299340575916, 4127.277726397869, 4139.9172016559805, 4160.771157586331, 5897.941020589825, 5925.4963328117165, 5928.377520360386, 5942.77146070228, 5971.820845374646, 3688.4222304364725, 3700.796456194935, 4095.9590404096175, 4189.476315460567, 4215.852445164404, 3389.034125274285, 3860.6718428933855, 4206.747595144301, 4257.318828987409, 4266.701330906869, 3773.735838491279, 4547.613452856544, 4860.878478038077, 4875.0, 4925.7783399747095, 4573.5426457354, 5443.591730620219, 5677.744501497443, 5768.74040668171, 5776.757997030659, 1277.5847849448967, 1323.6360000999803, 1347.5553067487706, 1377.4008306386754, 1386.9791953120712, 842.0380513403754, 983.257640481432, 987.5753426026878, 987.6938149173635, 996.4370130876176, 4372.562743725602, 4615.891856247942, 5069.9746501267255, 5071.670341427795, 5075.0, 5240.667902783301, 5337.973310133424, 5505.3208771324325, 5530.364008139116, 5534.308211473566, 4373.409589705349, 4633.4671512775785, 4711.419321315756, 4996.275540046673, 5066.544011039025, 2302.9751760466766, 2345.6247000479843, 2536.847789132658, 2727.754502094821, 2798.258461507702, 4951.3810773653295, 5722.599418040781, 5746.913796293059, 5776.826695199151, 5818.5636077294375, 5242.266082748418, 5379.327584051994, 5483.451654834565, 5667.90287593593, 5737.770489180386, 4751.762411879392, 4834.371531700997, 5151.892343146242, 5237.790488380499, 5767.336756273083, 4696.1546921554445, 4992.301077849177, 5477.069767674275, 5612.943870561242, 5625.718714064198, 4767.73777442244, 4790.401199850019, 5031.446540880427, 5116.4627714090975, 5469.781208751605, 5124.743762811919, 5667.744951477276, 5749.453801888814, 5752.511036561772, 5847.0, 3206.695363940422, 3237.7733558650666, 3714.368557345204, 3734.57052438973, 3802.1255111324, 4601.792919318706, 4810.302506136661, 5537.390887002507, 5545.698535107885, 5557.305336832896, 4813.614910807197, 5092.668976516515, 5470.64440811346, 5593.524550413261, 5618.606697531133, 4784.15809913179, 4966.726830024383, 5608.0, 5620.550355971594, 5653.462921022497, 4360.651147908223, 4576.39826060876, 4848.521201033718, 5527.0, 5541.727891564439, 4366.104948485617, 5066.670666406671, 5478.342598888159, 5665.150227465913, 5733.71331433435, 4933.975330123327, 5530.336359636869, 5577.163425486209, 5611.438856114356, 5618.915716264178], "value": 4064.6546841089244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.2795948132901, 710.6482291265825, 798.2217338095354, 885.1900511032405, 889.8754174415582, 15461.768073478906, 16628.833711662908, 16695.83304166958, 16703.248353824078, 16705.081220532866, 14032.158070515776, 15258.923705381458, 15300.0, 15409.152496612682, 15494.69010619787, 893.3389291923978, 903.1735961595166, 911.1799380557485, 914.4604683236889, 921.3458444504377, 884.2174675412242, 906.4108329585789, 907.7231444409452, 909.995450022749, 911.2983003087619, 970.7864269860619, 975.4586204656413, 976.843705007199, 978.0659470205936, 978.1392374710281, 935.228436539854, 949.430341794921, 965.5799727118691, 965.8454647256475, 968.1045033344128, 708.252793303065, 721.0518168608263, 722.0180554445949, 727.9526830756037, 728.2244409703702, 14296.499622513162, 14486.565403037926, 14542.709145817025, 14858.628534286621, 14912.0, 12293.938530307381, 12400.875991240153, 12408.81386779199, 12524.81212781809, 12704.364781760874, 10990.670279891616, 11168.329900206014, 11247.943760281147, 11398.60104896333, 11569.768604627945, 3503.754737168399, 3685.8157092145284, 3742.644448777362, 3758.4926034985474, 3844.461775351425, 100283.0, 105545.47227263814, 110963.89036109616, 111358.99999999919, 111716.0, 9407.247420206368, 9418.905810941802, 9487.098725621056, 9602.9039709602, 9820.852687209697, 20753.896230518752, 21053.157873684882, 21105.26131585387, 21110.89444552798, 21111.68332475014, 7979.680812767424, 8128.109421827711, 8173.918260817316, 8281.668733250603, 8484.618192181366, 4460.130274596488, 4474.7762611869275, 4483.058557702919, 4494.942690478688, 4555.997680510282, 3691.501647277637, 3764.265968136242, 3770.736048476635, 3813.0657988792923, 3818.121831978605, 681.3765404654785, 686.3136863136863, 689.2418339826152, 691.339770519153, 692.9653517324215, 693.9063226464464, 705.336983235767, 727.2509315405141, 734.3941248470034, 761.1969372312263, 10628.202884783517, 10720.142388609049, 11027.117830573536, 11074.446277686084, 11255.963110876392, 543.2014938041074, 574.8332983434841, 603.1856993059334, 611.729946510815, 618.6102755264154, 5088.6946783193125, 5235.424103348629, 5237.764300606482, 5240.502152295526, 5251.8161864335325, 105658.0, 106983.46508267408, 108196.45901770599, 109605.45197273963, 110248.0, 59940.70029649824, 68860.96708549376, 70608.2939170612, 87989.0, 90748.73128171716, 79573.4085318302, 82455.17544824595, 82567.99999999879, 84045.57977210075, 86641.56679216564, 11129.721756956142, 11181.32912025281, 11263.49314280843, 11394.715132121763, 11407.0, 49749.50250497449, 51186.0, 51687.74156129195, 51709.22436163385, 51794.48205517897, 62785.174667141, 64428.67785661042, 65810.01284980633, 65827.0, 66938.66122677617, 10608.681739547827, 13970.441182352592, 14189.148651080968, 14305.785413218602, 14404.207768572829, 14743.0, 14783.0, 14890.404383824525, 14935.029223100464, 15036.097834129987, 13895.305234738425, 14353.712925741218, 14512.0, 14520.491782787552, 14846.331915063633, 13679.86320136786, 14396.280185990869, 14474.710505790035, 14695.0, 14844.781542554656, 13131.540396086091, 13771.724565508834, 13982.930085349508, 13998.214639952634, 14049.859501404855, 9787.51062446889, 10009.5495702695, 10220.846687299547, 10237.488125593542, 10590.470476475992, 11217.214794964275, 11368.0, 11579.247348922294, 11592.768144637228, 11753.236039657395], "value": 7676.454353490867, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 153.0, 175.0, 172.0, 147.0, 118.0, 117.0, 117.0, 116.0, 116.0], "value": 136.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 112.0, 113.0, 151.0, 113.0, 115.0, 141.0, 141.0, 146.0, 101.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 206.0, 197.0, 200.0, 198.0, 198.0, 202.0, 251.0, 274.0, 222.0], "value": 214.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 86.0, 61.0, 59.0, 59.0, 59.0, 72.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 84.0, 73.0, 72.0, 71.0, 82.0, 70.0, 71.0, 80.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 89.0, 86.0, 90.0, 87.0, 89.0, 123.0, 99.0, 88.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 98.0, 146.0, 132.0, 95.0, 97.0, 96.0, 95.0, 96.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 92.0, 110.0, 144.0, 143.0, 95.0, 92.0, 94.0, 95.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 58.0, 60.0, 62.0, 60.0, 62.0, 61.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 70.0, 107.0, 80.0, 76.0, 70.0, 70.0, 70.0, 71.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 79.0, 86.0, 82.0, 87.0, 88.0, 88.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 146.0, 132.0, 135.0, 145.0, 159.0, 161.0, 198.0, 147.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 167.0, 166.0, 166.0, 165.0, 192.0, 172.0, 163.0, 166.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 67.0, 64.0, 64.0, 68.0, 65.0, 66.0], "value": 65.6, "unit": "score"}]}]} 03:53:46 INFO - Return code: 0 03:53:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:46 ERROR - # TBPL SUCCESS # 03:53:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:53:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:53:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:53:46 INFO - 2017-04-07 03:53:46.748 screenresolution[6684:124534] starting screenresolution argv=screenresolution get 03:53:46 INFO - 2017-04-07 03:53:46.750 screenresolution[6684:124534] Display 0: 1600x1200x32@60 03:53:46 INFO - 2017-04-07 03:53:46.757 screenresolution[6685:124537] starting screenresolution argv=screenresolution list 03:53:46 INFO - Available Modes on Display 0 03:53:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:53:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:53:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:53:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:53:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:53:46 INFO - Intel Iris: 03:53:46 INFO - Chipset Model: Intel Iris 03:53:46 INFO - Type: GPU 03:53:46 INFO - Bus: Built-In 03:53:46 INFO - VRAM (Dynamic, Max): 1536 MB 03:53:46 INFO - Vendor: Intel (0x8086) 03:53:46 INFO - Device ID: 0x0a2e 03:53:46 INFO - Revision ID: 0x0009 03:53:46 INFO - Displays: 03:53:46 INFO - Display: 03:53:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:53:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:53:46 INFO - Display Serial Number: 1600x1200 60 03:53:46 INFO - Main Display: Yes 03:53:46 INFO - Mirror: Off 03:53:46 INFO - Online: Yes 03:53:46 INFO - Rotation: Supported 03:53:46 INFO - Return code: 0 03:53:46 INFO - Running post-action listener: _resource_record_post_action 03:53:46 INFO - [mozharness: 2017-04-07 10:53:46.995444Z] Finished run-tests step (success) 03:53:46 INFO - Running post-run listener: _resource_record_post_run 03:53:47 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 1735680; Write bytes: 426021376; Read time: 24; Write time: 1485 03:53:47 INFO - TinderboxPrint: CPU usage
54.4% 03:53:47 INFO - TinderboxPrint: I/O read bytes / time
1,735,680 / 24 03:53:47 INFO - TinderboxPrint: I/O write bytes / time
426,021,376 / 1,485 03:53:47 INFO - TinderboxPrint: CPU idle
2,173.1 (45.6%) 03:53:47 INFO - TinderboxPrint: CPU system
962.9 (20.2%) 03:53:47 INFO - TinderboxPrint: CPU user
1,625.8 (34.1%) 03:53:47 INFO - TinderboxPrint: Swap in / out
123,695,104 / 0 03:53:47 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 109564416; Write bytes: 102100992; Read time: 9840; Write time: 195 03:53:47 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1735680; Write bytes: 303383040; Read time: 24; Write time: 1233 03:53:47 INFO - Running post-run listener: _upload_blobber_files 03:53:47 INFO - Blob upload gear active. 03:53:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:47 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 03:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:48 INFO - (blobuploader) - INFO - Done attempting. 03:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:49 INFO - (blobuploader) - INFO - Done attempting. 03:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:50 INFO - (blobuploader) - INFO - Done attempting. 03:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:52 INFO - (blobuploader) - INFO - Done attempting. 03:53:52 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:52 INFO - Return code: 0 03:53:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a4b672cdadba9d7d7eb1e124f60004130aeaf94fc4375bc5a65c2af90430b8010694f8b62b8ecd53b05425a6630477acbc7a65bea27c6e237e573f2d6ed16d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcd434a0ffb743ae995ecd72bd84b45cbf1991bb358bb9068c2f255a76b767de27c9924d75fba2881ee3373a1dc0f725c93e5633acd878001b23551446d67dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97fb910b7e550397b0a72d849177e66c0c34cea9c2bcf36fea7bd911ad391d60513dc9d71a9eacbc1b0c35d8e4d5696e31db5e40911dc8525ae237de8a5360c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1caac39c3fdb1a99a04e48e7a9eec52b5fa70a59c9cc4ea0ed63b54339f6a5cb8ceba661acea58c5fdd49d3b72abb9a516aeed31077a1dd265b0e701aa485e6"} 03:53:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:52 INFO - Contents: 03:53:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a4b672cdadba9d7d7eb1e124f60004130aeaf94fc4375bc5a65c2af90430b8010694f8b62b8ecd53b05425a6630477acbc7a65bea27c6e237e573f2d6ed16d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcd434a0ffb743ae995ecd72bd84b45cbf1991bb358bb9068c2f255a76b767de27c9924d75fba2881ee3373a1dc0f725c93e5633acd878001b23551446d67dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97fb910b7e550397b0a72d849177e66c0c34cea9c2bcf36fea7bd911ad391d60513dc9d71a9eacbc1b0c35d8e4d5696e31db5e40911dc8525ae237de8a5360c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1caac39c3fdb1a99a04e48e7a9eec52b5fa70a59c9cc4ea0ed63b54339f6a5cb8ceba661acea58c5fdd49d3b72abb9a516aeed31077a1dd265b0e701aa485e6"} 03:53:52 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:52 INFO - Copying logs to upload dir... 03:53:52 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.368658 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-04-07 03:53:52.616926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 03:53:52.625789) ========= 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.JQieJ01SC8/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.iFG8iJvdVH/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a4b672cdadba9d7d7eb1e124f60004130aeaf94fc4375bc5a65c2af90430b8010694f8b62b8ecd53b05425a6630477acbc7a65bea27c6e237e573f2d6ed16d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcd434a0ffb743ae995ecd72bd84b45cbf1991bb358bb9068c2f255a76b767de27c9924d75fba2881ee3373a1dc0f725c93e5633acd878001b23551446d67dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97fb910b7e550397b0a72d849177e66c0c34cea9c2bcf36fea7bd911ad391d60513dc9d71a9eacbc1b0c35d8e4d5696e31db5e40911dc8525ae237de8a5360c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1caac39c3fdb1a99a04e48e7a9eec52b5fa70a59c9cc4ea0ed63b54339f6a5cb8ceba661acea58c5fdd49d3b72abb9a516aeed31077a1dd265b0e701aa485e6"} build_url:https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011583 build_url: 'https://queue.taskcluster.net/v1/task/ZYd8o0eiQ0amXu7XfMH8Jg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a4b672cdadba9d7d7eb1e124f60004130aeaf94fc4375bc5a65c2af90430b8010694f8b62b8ecd53b05425a6630477acbc7a65bea27c6e237e573f2d6ed16d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bcd434a0ffb743ae995ecd72bd84b45cbf1991bb358bb9068c2f255a76b767de27c9924d75fba2881ee3373a1dc0f725c93e5633acd878001b23551446d67dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97fb910b7e550397b0a72d849177e66c0c34cea9c2bcf36fea7bd911ad391d60513dc9d71a9eacbc1b0c35d8e4d5696e31db5e40911dc8525ae237de8a5360c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1caac39c3fdb1a99a04e48e7a9eec52b5fa70a59c9cc4ea0ed63b54339f6a5cb8ceba661acea58c5fdd49d3b72abb9a516aeed31077a1dd265b0e701aa485e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 03:53:52.661229) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 03:53:52.661573) ========= 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.JQieJ01SC8/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.iFG8iJvdVH/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005461 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 03:53:52.710529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 03:53:52.710883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 03:53:52.711233) ========= ========= Total master_lag: 0.19 =========