builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0061 starttime: 1485313128.05 results: success (0) buildid: 20170117083128 builduid: 766930557a084bc7938a387b284f4528 revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.054185) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.055307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.055844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.083292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.084013) ========= 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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 18:58:48-- 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% 15.3M=0.001s 2017-01-24 18:58:48 (15.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122412 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.235909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.236276) ========= 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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.027937 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:48.288635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-24 18:58:48.289451) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6a23526fe5168087d7e4132c0705aefcaed5f571 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6a23526fe5168087d7e4132c0705aefcaed5f571 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mr48Xlskmc/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.R0BYiI8xwy/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 18:58:48,393 truncating revision to first 12 chars 2017-01-24 18:58:48,393 Setting DEBUG logging. 2017-01-24 18:58:48,393 attempt 1/10 2017-01-24 18:58:48,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6a23526fe516?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 18:58:49,754 unpacking tar archive at: mozilla-central-6a23526fe516/testing/mozharness/ program finished with exit code 0 elapsedTime=1.616205 ========= master_lag: 0.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-24 18:58:50.519628) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:50.520046) ========= script_repo_revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:50.520549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-01-24 18:58:50.520881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-01-24 18:58:51.709001) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 18:58:51.709886) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Mr48Xlskmc/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.R0BYiI8xwy/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:58:51 INFO - MultiFileLogger online at 20170124 18:58:51 in /builds/slave/test 18:58:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:58:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:58:51 INFO - {'append_to_log': False, 18:58:51 INFO - 'base_work_dir': '/builds/slave/test', 18:58:51 INFO - 'blob_upload_branch': 'Firefox', 18:58:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:58:51 INFO - 'branch': 'Firefox', 18:58:51 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:51 INFO - 'config_files': ('talos/mac_config.py',), 18:58:51 INFO - 'default_actions': ('clobber', 18:58:51 INFO - 'read-buildbot-config', 18:58:51 INFO - 'download-and-extract', 18:58:51 INFO - 'populate-webroot', 18:58:51 INFO - 'create-virtualenv', 18:58:51 INFO - 'install', 18:58:51 INFO - 'run-tests'), 18:58:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:51 INFO - 'download_minidump_stackwalk': True, 18:58:51 INFO - 'download_symbols': 'ondemand', 18:58:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:51 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:51 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:51 INFO - 'installer_path': 'installer.exe', 18:58:51 INFO - 'log_level': 'info', 18:58:51 INFO - 'log_name': 'talos', 18:58:51 INFO - 'log_to_console': True, 18:58:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:58:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:58:51 INFO - 'opt_config_files': (), 18:58:51 INFO - 'pip_index': False, 18:58:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:51 INFO - 'cmd': ('bash', 18:58:51 INFO - '-c', 18:58:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:51 INFO - 'enabled': True, 18:58:51 INFO - 'halt_on_failure': False, 18:58:51 INFO - 'name': 'check_screen_resolution'},), 18:58:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:51 INFO - 'cmd': ('bash', 18:58:51 INFO - '-c', 18:58:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:51 INFO - 'enabled': True, 18:58:51 INFO - 'halt_on_failure': False, 18:58:51 INFO - 'name': 'check_screen_resolution'},), 18:58:51 INFO - 'run_cmd_checks_enabled': True, 18:58:51 INFO - 'sps_profile': False, 18:58:51 INFO - 'sps_profile_interval': 0, 18:58:51 INFO - 'suite': 'dromaeojs-e10s', 18:58:51 INFO - 'system_bits': '32', 18:58:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:51 INFO - 'title': 't-yosemite-r7-0061', 18:58:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:51 INFO - 'use_talos_json': True, 18:58:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:58:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:51 INFO - 'work_dir': 'build'} 18:58:51 INFO - [mozharness: 2017-01-25 02:58:51.926735Z] Running clobber step. 18:58:51 INFO - Running pre-action listener: _resource_record_pre_action 18:58:51 INFO - Running main action method: clobber 18:58:51 INFO - rmtree: /builds/slave/test/build 18:58:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:58:54 INFO - Running post-action listener: _resource_record_post_action 18:58:54 INFO - [mozharness: 2017-01-25 02:58:54.060888Z] Finished clobber step (success) 18:58:54 INFO - [mozharness: 2017-01-25 02:58:54.061061Z] Running read-buildbot-config step. 18:58:54 INFO - Running pre-action listener: _resource_record_pre_action 18:58:54 INFO - Running main action method: read_buildbot_config 18:58:54 INFO - Using buildbot properties: 18:58:54 INFO - { 18:58:54 INFO - "project": "", 18:58:54 INFO - "product": "firefox", 18:58:54 INFO - "script_repo_revision": "production", 18:58:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:58:54 INFO - "repository": "", 18:58:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:58:54 INFO - "buildid": "20170117083128", 18:58:54 INFO - "pgo_build": "False", 18:58:54 INFO - "basedir": "/builds/slave/test", 18:58:54 INFO - "buildnumber": 126, 18:58:54 INFO - "slavename": "t-yosemite-r7-0061", 18:58:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 18:58:54 INFO - "platform": "yosemite_r7", 18:58:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:58:54 INFO - "branch": "mozilla-central", 18:58:54 INFO - "repo_path": "mozilla-central", 18:58:54 INFO - "revision": "6a23526fe5168087d7e4132c0705aefcaed5f571", 18:58:54 INFO - "stage_platform": "macosx64", 18:58:54 INFO - "builduid": "766930557a084bc7938a387b284f4528", 18:58:54 INFO - "slavebuilddir": "test" 18:58:54 INFO - } 18:58:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:58:54 INFO - Running post-action listener: _resource_record_post_action 18:58:54 INFO - [mozharness: 2017-01-25 02:58:54.064155Z] Finished read-buildbot-config step (success) 18:58:54 INFO - [mozharness: 2017-01-25 02:58:54.064291Z] Running download-and-extract step. 18:58:54 INFO - Running pre-action listener: _resource_record_pre_action 18:58:54 INFO - Running main action method: download_and_extract 18:58:54 INFO - mkdir: /builds/slave/test/build/tests 18:58:54 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')]} 18:58:54 INFO - trying https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 18:58:55 INFO - Downloaded 1199 bytes. 18:58:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:55 INFO - Using the following test package requirements: 18:58:55 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:55 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:58:55 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:58:55 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'jsshell-mac.zip'], 18:58:55 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:58:55 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:55 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:58:55 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:58:55 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:58:55 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:55 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:58:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:58:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:58:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:58:55 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:58:55 INFO - Expected file size: 16326298 18:58:55 INFO - Obtained file size: 16326298 18:59:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:59:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:59:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:02 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:59:03 INFO - Expected file size: 16326298 18:59:03 INFO - Obtained file size: 16326298 18:59:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:59:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:59:10 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:59:10 INFO - Expected file size: 14403463 18:59:10 INFO - Obtained file size: 14403463 18:59: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')]} 18:59:11 INFO - trying https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:59:11 INFO - Downloading https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 18:59:13 INFO - Downloaded 70132302 bytes. 18:59:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:59:13 INFO - mkdir: /builds/slave/test/properties 18:59:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:13 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:13 INFO - Contents: 18:59:13 INFO - build_url:https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:59:13 INFO - Running post-action listener: _resource_record_post_action 18:59:13 INFO - Running post-action listener: set_extra_try_arguments 18:59:13 INFO - [mozharness: 2017-01-25 02:59:13.912088Z] Finished download-and-extract step (success) 18:59:13 INFO - [mozharness: 2017-01-25 02:59:13.912207Z] Running populate-webroot step. 18:59:13 INFO - Running pre-action listener: _resource_record_pre_action 18:59:13 INFO - Running main action method: populate_webroot 18:59:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:13 INFO - '--tppagecycles', 18:59:13 INFO - '7'], 18:59:13 INFO - 'tests': ['tsvgm']}}, 18:59:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:59:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:59:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:59:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:59:13 INFO - 'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:59:13 INFO - 'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['damp', 'tps']}, 18:59:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:59:13 INFO - 'tests': ['damp', 'tps']}, 18:59:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['dromaeo_dom']}, 18:59:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['basic_compositor_video']}, 18:59:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:59:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['a11yr', 18:59:13 INFO - 'ts_paint', 18:59:13 INFO - 'tpaint', 18:59:13 INFO - 'sessionrestore', 18:59:13 INFO - 'sessionrestore_no_auto_restore', 18:59:13 INFO - 'tabpaint']}, 18:59:13 INFO - 'other-e10s': {'tests': ['a11yr', 18:59:13 INFO - 'ts_paint', 18:59:13 INFO - 'tpaint', 18:59:13 INFO - 'sessionrestore', 18:59:13 INFO - 'sessionrestore_no_auto_restore', 18:59:13 INFO - 'tabpaint']}, 18:59:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:59:13 INFO - 'ts_paint', 18:59:13 INFO - 'tpaint', 18:59:13 INFO - 'sessionrestore', 18:59:13 INFO - 'sessionrestore_no_auto_restore', 18:59:13 INFO - 'tabpaint']}, 18:59:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:59:13 INFO - 'ts_paint', 18:59:13 INFO - 'tpaint', 18:59:13 INFO - 'sessionrestore', 18:59:13 INFO - 'sessionrestore_no_auto_restore', 18:59:13 INFO - 'tabpaint']}, 18:59:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['a11yr', 18:59:13 INFO - 'ts_paint', 18:59:13 INFO - 'tpaint', 18:59:13 INFO - 'sessionrestore', 18:59:13 INFO - 'sessionrestore_no_auto_restore', 18:59:13 INFO - 'tabpaint']}, 18:59:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['a11yr', 18:59:13 INFO - 'ts_paint', 18:59:13 INFO - 'tpaint', 18:59:13 INFO - 'sessionrestore', 18:59:13 INFO - 'sessionrestore_no_auto_restore', 18:59:13 INFO - 'tabpaint']}, 18:59:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['tsvgx', 18:59:13 INFO - 'tsvgr_opacity', 18:59:13 INFO - 'tart', 18:59:13 INFO - 'tscrollx', 18:59:13 INFO - 'cart', 18:59:13 INFO - 'tsvg_static']}, 18:59:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:59:13 INFO - 'tsvgr_opacity', 18:59:13 INFO - 'tart', 18:59:13 INFO - 'tscrollx', 18:59:13 INFO - 'cart', 18:59:13 INFO - 'tsvg_static']}, 18:59:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:59:13 INFO - 'talos_options': ['--disable-e10s'], 18:59:13 INFO - 'tests': ['tp5o']}, 18:59:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:59:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:59:13 INFO - 'talos_options': ['--disable-e10s', 18:59:13 INFO - '--xperf_path', 18:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:13 INFO - 'tests': ['tp5n']}, 18:59:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:59:13 INFO - 'talos_options': ['--xperf_path', 18:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:13 INFO - 'tests': ['tp5n']}}, 18:59:13 INFO - 'talos.zip': {'path': '', 18:59:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:13 INFO - Running post-action listener: _resource_record_post_action 18:59:13 INFO - [mozharness: 2017-01-25 02:59:13.930272Z] Finished populate-webroot step (success) 18:59:13 INFO - [mozharness: 2017-01-25 02:59:13.930409Z] Running create-virtualenv step. 18:59:13 INFO - Running pre-action listener: _resource_record_pre_action 18:59:13 INFO - Running main action method: create_virtualenv 18:59:13 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:13 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 18:59:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:14 INFO - Using real prefix '/tools/python27' 18:59:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:14 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:17 INFO - Installing pip.................done. 18:59:17 INFO - Return code: 0 18:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:59:17 INFO - Reading from file tmpfile_stdout 18:59:17 INFO - Output received: 18:59:17 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) 18:59:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59:17 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')]} 18:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:17 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')]} 18:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:17 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:17 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 18:59:17 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 18:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:17 INFO - 'HOME': '/Users/cltbld', 18:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:17 INFO - 'LOGNAME': 'cltbld', 18:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:17 INFO - 'MOZ_NO_REMOTE': '1', 18:59:17 INFO - 'NO_EM_RESTART': '1', 18:59:17 INFO - 'PAGER': '/bin/cat', 18:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:17 INFO - 'PWD': '/builds/slave/test', 18:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:17 INFO - 'SHELL': '/bin/bash', 18:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:17 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:17 INFO - 'USER': 'cltbld', 18:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:17 INFO - 'XPC_FLAGS': '0x0', 18:59:17 INFO - 'XPC_SERVICE_NAME': '0', 18:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:18 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 18:59:18 INFO - Cleaning up... 18:59:18 INFO - Return code: 0 18:59:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:18 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 18:59:18 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 18:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:18 INFO - 'HOME': '/Users/cltbld', 18:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:18 INFO - 'LOGNAME': 'cltbld', 18:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:18 INFO - 'MOZ_NO_REMOTE': '1', 18:59:18 INFO - 'NO_EM_RESTART': '1', 18:59:18 INFO - 'PAGER': '/bin/cat', 18:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:18 INFO - 'PWD': '/builds/slave/test', 18:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:18 INFO - 'SHELL': '/bin/bash', 18:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:18 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:18 INFO - 'USER': 'cltbld', 18:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:18 INFO - 'XPC_FLAGS': '0x0', 18:59:18 INFO - 'XPC_SERVICE_NAME': '0', 18:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:18 INFO - Downloading/unpacking psutil>=3.1.1 18:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:22 INFO - Installing collected packages: psutil 18:59:22 INFO - Running setup.py install for psutil 18:59:22 INFO - building 'psutil._psutil_osx' extension 18:59:22 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 18:59:22 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 18:59:22 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 18:59:22 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 18:59:22 INFO - building 'psutil._psutil_posix' extension 18:59:22 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 18:59:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:59:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:59:22 INFO - ^ 18:59:23 INFO - 1 warning generated. 18:59:23 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 18:59:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:23 INFO - Successfully installed psutil 18:59:23 INFO - Cleaning up... 18:59:23 INFO - Return code: 0 18:59:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:23 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:23 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 18:59:23 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 18:59:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:23 INFO - 'HOME': '/Users/cltbld', 18:59:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:23 INFO - 'LOGNAME': 'cltbld', 18:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:23 INFO - 'MOZ_NO_REMOTE': '1', 18:59:23 INFO - 'NO_EM_RESTART': '1', 18:59:23 INFO - 'PAGER': '/bin/cat', 18:59:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:23 INFO - 'PWD': '/builds/slave/test', 18:59:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:23 INFO - 'SHELL': '/bin/bash', 18:59:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:23 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:23 INFO - 'USER': 'cltbld', 18:59:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:23 INFO - 'XPC_FLAGS': '0x0', 18:59:23 INFO - 'XPC_SERVICE_NAME': '0', 18:59:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:59:23 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 18:59:23 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 18:59:23 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 18:59:23 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 18:59:23 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 18:59:23 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 18:59:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:59:26 INFO - Installing collected packages: mozsystemmonitor 18:59:26 INFO - Running setup.py install for mozsystemmonitor 18:59:26 INFO - Successfully installed mozsystemmonitor 18:59:26 INFO - Cleaning up... 18:59:26 INFO - Return code: 0 18:59:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:59:26 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')]} 18:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:26 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')]} 18:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:26 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:26 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 18:59:26 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 18:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:26 INFO - 'HOME': '/Users/cltbld', 18:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:26 INFO - 'LOGNAME': 'cltbld', 18:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:26 INFO - 'MOZ_NO_REMOTE': '1', 18:59:26 INFO - 'NO_EM_RESTART': '1', 18:59:26 INFO - 'PAGER': '/bin/cat', 18:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:26 INFO - 'PWD': '/builds/slave/test', 18:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:26 INFO - 'SHELL': '/bin/bash', 18:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:26 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:26 INFO - 'USER': 'cltbld', 18:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:26 INFO - 'XPC_FLAGS': '0x0', 18:59:26 INFO - 'XPC_SERVICE_NAME': '0', 18:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:26 INFO - Downloading/unpacking jsonschema==2.5.1 18:59:26 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 18:59:26 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 18:59:26 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 18:59:26 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 18:59:26 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 18:59:26 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 18:59:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:29 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:29 INFO - warning: no files found matching '*.txt' 18:59:29 INFO - no previously-included directories found matching 'build' 18:59:29 INFO - no previously-included directories found matching 'dist' 18:59:29 INFO - no previously-included directories found matching '.git*' 18:59:29 INFO - Installing collected packages: jsonschema, functools32 18:59:29 INFO - Running setup.py install for functools32 18:59:30 INFO - warning: no files found matching '*.txt' 18:59:30 INFO - no previously-included directories found matching 'build' 18:59:30 INFO - no previously-included directories found matching 'dist' 18:59:30 INFO - no previously-included directories found matching '.git*' 18:59:30 INFO - Successfully installed jsonschema functools32 18:59:30 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59:30 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')]} 18:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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')]} 18:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:30 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 18:59:30 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 18:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:30 INFO - 'HOME': '/Users/cltbld', 18:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:30 INFO - 'LOGNAME': 'cltbld', 18:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:30 INFO - 'MOZ_NO_REMOTE': '1', 18:59:30 INFO - 'NO_EM_RESTART': '1', 18:59:30 INFO - 'PAGER': '/bin/cat', 18:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:30 INFO - 'PWD': '/builds/slave/test', 18:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:30 INFO - 'SHELL': '/bin/bash', 18:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:30 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:30 INFO - 'USER': 'cltbld', 18:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:30 INFO - 'XPC_FLAGS': '0x0', 18:59:30 INFO - 'XPC_SERVICE_NAME': '0', 18:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:30 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:30 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')]} 18:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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')]} 18:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:30 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 18:59:30 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 18:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:30 INFO - 'HOME': '/Users/cltbld', 18:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:30 INFO - 'LOGNAME': 'cltbld', 18:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:30 INFO - 'MOZ_NO_REMOTE': '1', 18:59:30 INFO - 'NO_EM_RESTART': '1', 18:59:30 INFO - 'PAGER': '/bin/cat', 18:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:30 INFO - 'PWD': '/builds/slave/test', 18:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:30 INFO - 'SHELL': '/bin/bash', 18:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:30 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:30 INFO - 'USER': 'cltbld', 18:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:30 INFO - 'XPC_FLAGS': '0x0', 18:59:30 INFO - 'XPC_SERVICE_NAME': '0', 18:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:30 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 18:59:30 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 18:59:30 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 18:59:30 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 18:59:30 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 18:59:30 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 18:59:33 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 INFO - Downloading docopt-0.6.1.tar.gz 18:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:34 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:34 INFO - Running setup.py install for blobuploader 18:59:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:34 INFO - Running setup.py install for requests 18:59:35 INFO - Running setup.py install for docopt 18:59:35 INFO - Successfully installed blobuploader requests docopt 18:59:35 INFO - Cleaning up... 18:59:35 INFO - Return code: 0 18:59:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:35 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')]} 18:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:35 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')]} 18:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:35 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:35 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 18:59:35 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 18:59:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:35 INFO - 'HOME': '/Users/cltbld', 18:59:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:35 INFO - 'LOGNAME': 'cltbld', 18:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:35 INFO - 'MOZ_NO_REMOTE': '1', 18:59:35 INFO - 'NO_EM_RESTART': '1', 18:59:35 INFO - 'PAGER': '/bin/cat', 18:59:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:35 INFO - 'PWD': '/builds/slave/test', 18:59:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:35 INFO - 'SHELL': '/bin/bash', 18:59:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:35 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:35 INFO - 'USER': 'cltbld', 18:59:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:35 INFO - 'XPC_FLAGS': '0x0', 18:59:35 INFO - 'XPC_SERVICE_NAME': '0', 18:59:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-DuVzlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-f1jx3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-j1qmAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SFZqq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-PGeXT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-kerS28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-KS97nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-OxeVOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5pjKwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Td9zOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:36 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-eWagPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:37 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-3M4RlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:37 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7VcrBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:37 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7eGnzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:37 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9GQ4hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:37 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-6yysY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:37 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Y0m2dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:37 INFO - Running setup.py install for manifestparser 18:59:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:37 INFO - Running setup.py install for mozcrash 18:59:37 INFO - Running setup.py install for mozdebug 18:59:38 INFO - Running setup.py install for mozdevice 18:59:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Running setup.py install for mozfile 18:59:38 INFO - Running setup.py install for mozhttpd 18:59:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Running setup.py install for mozinfo 18:59:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Running setup.py install for mozInstall 18:59:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:38 INFO - Running setup.py install for mozleak 18:59:38 INFO - Running setup.py install for mozlog 18:59:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:39 INFO - Running setup.py install for moznetwork 18:59:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:39 INFO - Running setup.py install for mozprocess 18:59:39 INFO - Running setup.py install for mozprofile 18:59:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:39 INFO - Running setup.py install for mozrunner 18:59:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:39 INFO - Running setup.py install for mozscreenshot 18:59:39 INFO - Running setup.py install for moztest 18:59:40 INFO - Running setup.py install for mozversion 18:59:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:40 INFO - Cleaning up... 18:59:40 INFO - Return code: 0 18:59:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:40 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:40 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 18:59:40 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 18:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:40 INFO - 'HOME': '/Users/cltbld', 18:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:40 INFO - 'LOGNAME': 'cltbld', 18:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:40 INFO - 'MOZ_NO_REMOTE': '1', 18:59:40 INFO - 'NO_EM_RESTART': '1', 18:59:40 INFO - 'PAGER': '/bin/cat', 18:59:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:40 INFO - 'PWD': '/builds/slave/test', 18:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:40 INFO - 'SHELL': '/bin/bash', 18:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:40 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:40 INFO - 'USER': 'cltbld', 18:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:40 INFO - 'XPC_FLAGS': '0x0', 18:59:40 INFO - 'XPC_SERVICE_NAME': '0', 18:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-tvDWUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:40 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)) 18:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-f7PT8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:40 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)) 18:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-3YkRdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:40 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)) 18:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-vw6NgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:40 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)) 18:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:40 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Jv_D9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-JLL_1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-lXbci9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-XYo2bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-lJNoNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Qj0xT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-KUxN7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ck5bO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-G_1GxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-C3dUZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:41 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)) 18:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:41 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-sNmYUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:42 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)) 18:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:42 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Kxtfeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:42 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)) 18:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:42 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-utrM2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:42 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)) 18:59:42 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)) 18:59:42 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)) 18:59:42 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)) 18:59:42 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)) 18:59:42 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)) 18:59:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:44 INFO - Downloading blessings-1.6.tar.gz 18:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:44 INFO - Installing collected packages: blessings 18:59:44 INFO - Running setup.py install for blessings 18:59:45 INFO - Successfully installed blessings 18:59:45 INFO - Cleaning up... 18:59:45 INFO - Return code: 0 18:59:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:45 INFO - Reading from file tmpfile_stdout 18:59:45 INFO - Current package versions: 18:59:45 INFO - blessings == 1.6 18:59:45 INFO - blobuploader == 1.2.4 18:59:45 INFO - docopt == 0.6.1 18:59:45 INFO - functools32 == 3.2.3-2 18:59:45 INFO - jsonschema == 2.5.1 18:59:45 INFO - manifestparser == 1.1 18:59:45 INFO - mozInstall == 1.12 18:59:45 INFO - mozcrash == 1.0 18:59:45 INFO - mozdebug == 0.1 18:59:45 INFO - mozdevice == 0.49 18:59:45 INFO - mozfile == 1.2 18:59:45 INFO - mozhttpd == 0.7 18:59:45 INFO - mozinfo == 0.9 18:59:45 INFO - mozleak == 0.1 18:59:45 INFO - mozlog == 3.4 18:59:45 INFO - moznetwork == 0.27 18:59:45 INFO - mozprocess == 0.24 18:59:45 INFO - mozprofile == 0.28 18:59:45 INFO - mozrunner == 6.13 18:59:45 INFO - mozscreenshot == 0.1 18:59:45 INFO - mozsystemmonitor == 0.3 18:59:45 INFO - moztest == 0.8 18:59:45 INFO - mozversion == 1.4 18:59:45 INFO - psutil == 3.1.1 18:59:45 INFO - requests == 1.2.3 18:59:45 INFO - wsgiref == 0.1.2 18:59:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:46 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:46 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 18:59:46 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 18:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:46 INFO - 'HOME': '/Users/cltbld', 18:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:46 INFO - 'LOGNAME': 'cltbld', 18:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:46 INFO - 'MOZ_NO_REMOTE': '1', 18:59:46 INFO - 'NO_EM_RESTART': '1', 18:59:46 INFO - 'PAGER': '/bin/cat', 18:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:46 INFO - 'PWD': '/builds/slave/test', 18:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:46 INFO - 'SHELL': '/bin/bash', 18:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:46 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:46 INFO - 'USER': 'cltbld', 18:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:46 INFO - 'XPC_FLAGS': '0x0', 18:59:46 INFO - 'XPC_SERVICE_NAME': '0', 18:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 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)) 18:59:46 INFO - Cleaning up... 18:59:46 INFO - Return code: 0 18:59:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:46 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 0x10fc69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe51b5d9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, '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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 18:59:46 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 18:59:46 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 18:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 18:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:46 INFO - 'HOME': '/Users/cltbld', 18:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:46 INFO - 'LOGNAME': 'cltbld', 18:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:46 INFO - 'MOZ_NO_REMOTE': '1', 18:59:46 INFO - 'NO_EM_RESTART': '1', 18:59:46 INFO - 'PAGER': '/bin/cat', 18:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:46 INFO - 'PWD': '/builds/slave/test', 18:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:46 INFO - 'SHELL': '/bin/bash', 18:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 18:59:46 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 18:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:46 INFO - 'USER': 'cltbld', 18:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:46 INFO - 'XPC_FLAGS': '0x0', 18:59:46 INFO - 'XPC_SERVICE_NAME': '0', 18:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:59:47 INFO - Cleaning up... 18:59:47 INFO - Return code: 0 18:59:47 INFO - Running post-action listener: _resource_record_post_action 18:59:47 INFO - Running post-action listener: _start_resource_monitoring 18:59:47 INFO - Starting resource monitoring. 18:59:47 INFO - [mozharness: 2017-01-25 02:59:47.165399Z] Finished create-virtualenv step (success) 18:59:47 INFO - [mozharness: 2017-01-25 02:59:47.166347Z] Running install step. 18:59:47 INFO - Running pre-action listener: _resource_record_pre_action 18:59:47 INFO - Running main action method: install 18:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:47 INFO - Reading from file tmpfile_stdout 18:59:47 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:47 INFO - Reading from file tmpfile_stdout 18:59:47 INFO - Output received: 18:59:47 INFO - Usage: mozinstall [options] installer 18:59:47 INFO - Options: 18:59:47 INFO - -h, --help show this help message and exit 18:59:47 INFO - -d DEST, --destination=DEST 18:59:47 INFO - Directory to install application into. [default: 18:59:47 INFO - "/builds/slave/test"] 18:59:47 INFO - --app=APP Application being installed. [default: firefox] 18:59:47 INFO - mkdir: /builds/slave/test/build/application 18:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:00:09 INFO - Reading from file tmpfile_stdout 19:00:09 INFO - Output received: 19:00:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:00:09 INFO - Running post-action listener: _resource_record_post_action 19:00:09 INFO - [mozharness: 2017-01-25 03:00:09.494695Z] Finished install step (success) 19:00:09 INFO - [mozharness: 2017-01-25 03:00:09.494794Z] Running run-tests step. 19:00:09 INFO - Running pre-action listener: _resource_record_pre_action 19:00:09 INFO - Running main action method: run_tests 19:00:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:00:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:00:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:00:09 INFO - 2017-01-24 19:00:09.508 screenresolution[1621:7542] starting screenresolution argv=screenresolution get 19:00:09 INFO - 2017-01-24 19:00:09.511 screenresolution[1621:7542] Display 0: 1600x1200x32@60 19:00:09 INFO - 2017-01-24 19:00:09.517 screenresolution[1622:7544] starting screenresolution argv=screenresolution list 19:00:09 INFO - Available Modes on Display 0 19:00:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:00:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:00:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:00:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:00:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:00:09 INFO - Intel Iris: 19:00:09 INFO - Chipset Model: Intel Iris 19:00:09 INFO - Type: GPU 19:00:09 INFO - Bus: Built-In 19:00:09 INFO - VRAM (Dynamic, Max): 1536 MB 19:00:09 INFO - Vendor: Intel (0x8086) 19:00:09 INFO - Device ID: 0x0a2e 19:00:09 INFO - Revision ID: 0x0009 19:00:09 INFO - Displays: 19:00:09 INFO - Display: 19:00:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:00:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:00:09 INFO - Display Serial Number: 1600x1200 60 19:00:09 INFO - Main Display: Yes 19:00:09 INFO - Mirror: Off 19:00:09 INFO - Online: Yes 19:00:09 INFO - Rotation: Supported 19:00:09 INFO - Return code: 0 19:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:09 INFO - Python 2.7.3 19:00:09 INFO - Return code: 0 19:00:09 INFO - grabbing minidump binary from tooltool 19:00:09 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')]} 19:00:09 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 0x10fa47d30>, '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 0x10f96edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:09 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 19:00:09 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 19:00:09 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 19:00:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:09 INFO - Return code: 0 19:00:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:00:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:00:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 19:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 19:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Mr48Xlskmc/Render', 19:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:09 INFO - 'HOME': '/Users/cltbld', 19:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:09 INFO - 'LOGNAME': 'cltbld', 19:00:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:09 INFO - 'MOZ_NO_REMOTE': '1', 19:00:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:09 INFO - 'NO_EM_RESTART': '1', 19:00:09 INFO - 'PAGER': '/bin/cat', 19:00:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:09 INFO - 'PWD': '/builds/slave/test', 19:00:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:09 INFO - 'SHELL': '/bin/bash', 19:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R0BYiI8xwy/Listeners', 19:00:09 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 19:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:09 INFO - 'USER': 'cltbld', 19:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:09 INFO - 'XPC_FLAGS': '0x0', 19:00:09 INFO - 'XPC_SERVICE_NAME': '0', 19:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 19:00:10 INFO - mozversion application_buildid: 20170117083128 19:00:10 INFO - mozversion application_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 19:00:10 INFO - mozversion application_display_name: Nightly 19:00:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:10 INFO - mozversion application_name: Firefox 19:00:10 INFO - mozversion application_remotingname: firefox 19:00:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:00:10 INFO - mozversion application_vendor: Mozilla 19:00:10 INFO - mozversion application_version: 53.0a1 19:00:10 INFO - mozversion platform_buildid: 20170117083128 19:00:10 INFO - mozversion platform_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 19:00:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:00:10 INFO - mozversion platform_version: 53.0a1 19:00:10 INFO - using testdate: 1485313210 19:00:10 INFO - actual date: 1485313210 19:00:10 INFO - starting webserver on 'localhost:49235' 19:00:10 INFO - SUITE-START | Running 2 tests 19:00:10 INFO - TEST-START | dromaeo_css 19:00:10 INFO - operating with platform_type : mac_ 19:00:10 INFO - Initialising browser for dromaeo_css test... 19:00:10 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpPfvoP6/profile http://localhost:49235/getInfo.html) 19:00:13 INFO - PROCESS | 1632 | 2017-01-24 19:00:13.267 plugin-container[1634:7708] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 19:00:13 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:00:13 INFO - PROCESS | 1632 | 2017-01-24 19:00:13.269 plugin-container[1634:7708] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 19:00:13 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:00:13 INFO - PROCESS | 1632 | 2017-01-24 19:00:13.269 plugin-container[1634:7708] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:00:13 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 19:00:13 INFO - PROCESS | 1632 | colorDepth:24 19:00:13 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 19:00:13 INFO - PROCESS | 1632 | __metrics 19:00:13 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3253: TypeError: this.tabs is undefined 19:00:14 INFO - TEST-INFO | 1632: exit 0 19:00:14 INFO - Browser initialized. 19:00:14 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:14 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpPfvoP6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:16 INFO - PROCESS | 1635 | 2017-01-24 19:00:16.710 plugin-container[1636:7832] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 19:00:16 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:00:16 INFO - PROCESS | 1635 | 2017-01-24 19:00:16.711 plugin-container[1636:7832] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 19:00:16 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:00:16 INFO - PROCESS | 1635 | 2017-01-24 19:00:16.711 plugin-container[1636:7832] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:00:26 INFO - PROCESS | 1635 | RSS: Main: 233979904 19:00:26 INFO - PROCESS | 1635 | 19:03:28 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 19:03:30 INFO - PROCESS | 1635 | RSS: Main: 254427136 19:03:30 INFO - PROCESS | 1635 | 19:05:14 INFO - PROCESS | 1635 | ************************* 19:05:14 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 19:05:14 INFO - PROCESS | 1635 | 19:05:14 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:05:14 INFO - PROCESS | 1635 | Full stack: 19:05:14 INFO - PROCESS | 1635 | ************************* 19:06:33 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 19:06:33 INFO - PROCESS | 1635 | RSS: Main: 261832704 19:06:33 INFO - PROCESS | 1635 | 19:09:35 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 19:09:36 INFO - PROCESS | 1635 | RSS: Main: 269365248 19:09:36 INFO - PROCESS | 1635 | 19:12:38 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 19:12:38 INFO - PROCESS | 1635 | RSS: Main: 266100736 19:12:38 INFO - PROCESS | 1635 | 19:15:41 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 19:15:42 INFO - PROCESS | 1635 | RSS: Main: 271110144 19:15:42 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 19:18:45 INFO - PROCESS | 1635 | RSS: Main: 273833984 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | __start_tp_report 19:18:45 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 19:18:45 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 19:18:45 INFO - PROCESS | 1635 | |i|pagename|runs| 19:18:45 INFO - PROCESS | 1635 | |0;dojo.html;3331.2504686445554;3340.131565792894;3367.7137443317315;3370.090075679567;3393.0669066006844;4558.977205113978;4766.523347665236;5479.506844384005;5531.585131115167;5632.577556683244;4781.545753153454;5530.253415788868;5542.528885044776;5597.832065038046;5602.943970560294;4221.978890105545;5053.267276244942;5068.0370729561355;5110.463401342861;5204.843854684365;5159.406668233164;5178.792848286064;5186.377634683843;5195.324607800981;5196.974015129938;5081.237814327862;5186.7147306898105;5197.064528384889;5210.270562121306;5213.2701421800975;3810;4640.744759038252;5077.213031980012;5094.6433749637545;5124.769385377648;4963;5001.949980500185;5040.294358789773;5123.257127716461;5152.716600587004;5312.574994000471;5595.63628364155;5598.524125449342;5661.660300381949;5666.886662266773;6079.20970273866;6098.9695051524905;6165.7533698652;6173.629582225081;6210.9068363974575;6102.084687296897;6231.937680623181;6255.468285195764;6258.937410625881;6272.306477251117;5635.380108188096;5677.574181936371;5721.485066344049;5731.8567035824435;5804.767809287666;6231.906521402183;6270.31026587075;6281.403266689657;6284.937150628435;6285.96857015712;6001.849953751103;6027.065804800175;6057.030875059969;6068.726907289182;6112.113743507167;6053.878922421615;6054.7275372607455;6077.726502307407;6079.574429789872;6118.357572454828;5249.737513124329;6071.6660583667435;6072.787452439232;6161.106639537242;6170.845728856814;6150.415710507495;6168.074788781719;6174.197354343906;6174.413430724074;6197.690115494207;4869.977304766039;4875.536824001714;4919.704817710949;4946.9010619787405;4977.32806071183;4436.00189957257;4441.089576636782;4446.999425129385;4453.643708503312;4457.264551349056;5815.476607105381;5827.3007239131575;5876.706164691748;5890.705464726747;5917.911231331534;6081.726322315506;6104.095385180791;6105.459747278077;6111.1967345965195;6192.040233763774;5835.328937172195;5843.503302219359;5855.59010869235;5960.4635582797755;5968.910466343008;5428.375736790241;5434.592405569598;5440.075187218104;5459.727013649302;5463.399026107125;6320.525960553069;6327.082573026885;6330.240371155491;6331.493480521455;6337.42963133311;6016.488598469179;6103.42017508336;6107.511399088151;6111.358307377662;6144.2319710036245;5350.357957045024;6268.780592679234;6322.715477803418;6340.9365906340345;6353.269374022047;6103.23709536308;6127.877442451037;6139.754409823557;6147.84630384244;6163.476104531165;6038.184845045863;6100.633961962297;6182.072689096672;6194.752209911553;6203.441690247719;5978.013627751372;5978.432048955342;5986.880262394815;5988.520918326436;5991;5334.919976200437;5732.369439361751;5830.125481177688;5976.372480889444;6007.189029480965;5291.206319052019;5764.798232061858;5834.591578589628;5923.555733320104;5950.672713000653;6003.519718422603;6038.245219347582;6042.969785151046;6050.304215015153;6056.9697151513965;5569.526590239713;5701.458361455655;5855.121731740273;5879.911801322898;5881.441263080001 19:18:45 INFO - PROCESS | 1635 | |1;ext.html;469.1812786687231;480.15013426235566;497.1548367774781;504.42495555067217;519.6803965561179;38657.033574160625;41589.3761593576;41780.58219417805;41930;43782.12435751283;42316.788416057956;42365.7881710591;42621.7868910655;42625;42932.71201863949;8343.123971982945;8533.445326053787;9119.316051296162;9318.394304370195;9334.906650933506;11007.834882476769;11342.262752921033;11349.432528373589;11447.370394628291;11480.138989575773;11257;11278.266912650652;11286.66140015801;11296.096312295038;11298.604548840793;11224.102071834233;11297;11299.548018079267;11337.94331028348;11344.716382090432;11093.667189984313;11194.272372295856;11195.552177912874;11200.775984480346;11210.215284930058;39791;39945.201095978206;39978.800635980966;40125.398119028236;40154;4029.97985010076;4061.208064427438;4066.715329926906;4084.836606535735;4116.259073366793;27517;29144.854275728696;29251.41497170066;30334.696653033407;30367;3079.707427794356;3243.594550681165;3249.1389781707867;3263.983680081584;3287.6876696713775;452787;456373.71813141054;458472;458672;458810;52829.943401131764;56929.14606280909;58410.70794646085;59444;59536;62031.689841550506;62178.68910655508;62508;62645.74708505804;62768.686156568925;15506.5348039559;15986;16030.438934637232;16067.919660401623;16090.275937582837;11233.943830280796;11517.48171332292;12321.876781232073;12519.93740031294;12579.496820127093;15322.23388830554;15513.612159696098;15568.766468502981;15655.68688626221;15740.842591574166;5587.888242235133;5698.629589076697;6495.967520162463;6596.934030659728;6620.702068406933;770.2874840772263;832.0680837461961;867.9132086791396;896.7713233125511;905.4160066756905;28454.146375608765;29720.131691014074;30061;30062.797488100667;30128.69871301303;958.6644674363916;974.332582181194;1053.8577292065472;1086.6305456144948;1209.6673414810998;15082.17048062367;15545.766813497807;15678.843211567966;15679.995240975195;16040;496634;581200;583413;585517;585578;59221.11168332479;59854.10218846721;59872.40127598668;60006;60085.39914600798;1401.9299035048207;1444.8627380398846;1456.4756687592458;1456.5120684570575;1462.4881291547872;29412.852935735184;29681.85159074191;29762.553561697026;30341.393172136875;30469.821332750467;48670.26994595013;48914.266286005026;49084;49169;49282.50717492779;467638;504679;507065;508413;510355;32010.51984220192;32873.50689739608;33756.49365259474;38453;39783;38794.6120538791;45033.549664502934;45862;46474;46795;37392.25215495729;38863.2227355457;38931.805340973115;39984.800076000596;40061.79969100136;37862.62137378591;38017.809910950265;38285;39091.804540977115;39580.80209598933;36009.279814404086;36049.098772530895;36084;36110.27779444344;36258;32936.01191964245;33814;34059.3188136231;34181.487277691354;34497.827510862284;24638.630420543348;25134.497310054063;25311.275274858697;25329;25362 19:18:45 INFO - PROCESS | 1635 | |2;jquery.html;377.75445960125916;384.3024909788733;386.29115572923683;398.16981593377807;411.0381706806073;19455.805441945577;19827;20961.999999999964;21467.785322146774;21701.34895953122;21122.943852807373;21207.575848483022;21544.676829847525;21811.67282490764;22092.337229883087;5623.80316688917;5793.826185214451;6016.398360163992;6112.327643959161;6159.076138579204;3837.0982819037645;4035.778032208227;5130.256112863633;5823.155642431845;6104.114903339013;6049.213602231704;6074.544409169308;6156.045812899008;6160.476359509425;6175.876482470348;6139.754409823602;6266.216722909637;6614.404703576653;6697.129373181455;6731.697073631698;5111.7699703513435;5942.078977758454;5957.523398128139;5966.612170208922;5988.640681559077;13554.118982266122;13757.931210343884;19510.51223719404;25516.74483255181;26337.604935925978;2400.1599440195964;2443.5235129149823;2640.762331390165;2677.9866100669374;2685;9773.35774935862;10322.58709651613;10333.379997200193;10483.266171368008;10555.788884222273;1824.5165031266724;1830.2221555838848;1851.5000949743628;1865.654853852028;1887.1319193171157;106553.46723266334;109720;116970;123435;132074;11726.70683232926;12189.451474683661;12210.938945305394;12213.69465763363;12229;15363.308651110727;15436.768448473058;15446.0732356059;15461.072335659896;15461.304241309168;7203.927960720326;7922.603869806487;8644.524551149621;8708.17272359125;8788.209061184396;8408.2432581068;8413.3269338454;8421.15788421153;8576.828463430697;8602.397832151815;4017.3371393720295;4717.481077081518;4788.353572267699;4794.137055330004;4882.9755851221225;1724.2671864457554;1835.5476764336836;1925.2010415677337;1967.7245185674017;2032.888191149501;882.3823323673454;997.6209040564539;1005.7636455432968;1006.5571148694551;1053.052252972331;21522.246721364678;21865.674998875555;22006.779932200792;22028.669569956463;22160.77839221587;1012.5038731021747;1015.5227043289642;1024.7438140464883;1043.446973104256;1063.6543123484744;11290.47578576898;11524.711882202844;11525.769484610428;11535.596254131233;11587.88412115885;666295.0055749167;691785;712172;722901;738897;112675;130486.69513304745;136676.31661841628;144806;147202;966.2077096780713;1016.6543375252302;1047.0053449223117;1051.7265510967204;1053.0575135253905;20035.899820500803;20118.899405502878;20388.776673399643;20550.84216157342;20565.38303850887;58603.70698146482;59473.810523788416;59771.70114149575;60410;60485;86584;90675;91728.54135729278;92613.61079583946;92704.60943085724;8176.386770992318;8319.833603328021;8476.745697629081;8591.484510929364;8602.311815054905;9120.45277283365;11067.944660276647;11503.48234329474;13376.996725245452;13579.52471663487;10927.398993055458;11295.152863535104;11412.48643811014;11438.771224575295;11555.942220289182;9559.522023898639;11421.200515963803;11469.770604587695;11525.250858694159;11837.82243266369;11690.824637630272;11740.119491038377;11794.351310677652;11798.41007949582;12068.698282543006;8273.214044665747;8393.286570641563;8641.783955401166;8764.824703506021;8767.21095101444;11030.613928512785;11142.777144456903;11164.441777911234;11426.885731142915;11477.426128693698 19:18:45 INFO - PROCESS | 1635 | |3;mootools.html;1413.356922600217;1456.5630310906724;1482.3477669825277;1486.078631248626;1496.1771025935739;6136.723847426865;7412.888806667905;7965.76102716918;8382.958085209573;8396.202360775724;7843.6862525499055;8127.4310798244;8129.91870081299;8217.958910205456;8259.710910118147;2291.4615065459643;2321.6865723127416;2327.2669109230624;2328;2337.614293641547;2105.8841763703067;2175.1734340950416;2336.9298921032396;2339;2349.964750528735;2297.7357603875516;2301.493671392291;2326.2439707095264;2326.720793504782;2329.2080692564523;2292.3008482412856;2299.367673889677;2311.167979527377;2315.560043591712;2320.8027317678016;2267.1724820440586;2325.6395258734756;2326.1858349577683;2333.6499525071204;2338.3686404670643;8046.436749427542;8116.5941702914615;8123.350131989427;8132.227438393344;8203.794905127419;4943.579795717368;5105.82129625465;5113.923291150636;5114.718690472023;5123.026624941249;3249.4151052810485;3355.261842394669;3475.3396854597545;3528.4001719707453;3564.536610240678;1196.8743281955444;1216.4769149265812;1230.7046308885804;1236.1285293867802;1238.3127364312802;10486.951304869528;10492.370457772558;10557.102646275076;10560.735981600521;10568.577256909715;4344.826206951687;4555.088982203506;4640.466346370211;4641.767911604406;4659.974805542775;9280.628774849065;9289.953550232342;9323.25413966881;9334.393264437926;9345.906540934504;5013.924791128136;5095.31213286209;5177.456367081402;5179.637425380187;5200.843974680765;3760;4231.978840105779;4318.537884815936;4633.0733853229485;4672.813087476463;3798.867039653599;3815.73289869712;3901.1027463683513;3933.665638420709;3954.525456945185;1283.4673610451557;1283.6598301450124;1284.2487145020082;1294.8187253784479;1304.7455746129604;906.664534122379;932.3706498113881;933.5192375926404;936.4942930817418;958.8897276813116;5304.787808487695;5342.2787923630585;5481.424450432727;5593.412691667398;5668.8866222675315;513.1609817947682;569.1008207032878;581.6451964301773;584.1617279204355;593.3354642800092;3593.1915319053005;3669.486271921933;3767.3407153747985;3777.697784177259;3779.829907654162;8026.638801253957;9439.622415103318;9774.218062554979;9795.461249631197;9817.116459518678;8170.428070035159;9319;9507;9604.807903841884;9718.951405242928;7618.961905190438;7694.07671079474;7708.113566939649;7709.306162445407;7745.961270193613;5207.947920520746;5263.947360526499;5286.233496142961;5327.413984461784;5365.256291705289;8898.288136949159;8915.37592368528;8959.372843901125;9060.95798983099;9080.182783549511;8792.868106978529;8988.325875559229;9027.32295077885;9106.954465227896;9263.444193348421;5787.508061814793;6210.596311239755;6408.9745640697265;6862.107925969592;7101.680424380812;7706.884396734165;7858.174891636296;7887.802804929923;7889.763307100796;7896.605169741605;6991.021257023919;7131.536450130725;7160.319769621878;7173.282671732785;7235.059442272471;6798.898016529855;6994.61529615876;7015.894761578683;7031.789046328414;7043.471739619651;6165.784197553064;6279.937200627935;6358.300586935526;6413.807585772434;6416.294207637249;4967.7083958170415;5005.099082165245;5010.549050585465;5052.72210028452;5079.568236699774;4897.41231052276;5004.549590536723;5040.117979353672;5153.098207813543;5163.715995620277 19:18:45 INFO - PROCESS | 1635 | |4;prototype.html;310.81195876494706;349.3083694285315;358.17262124492424;370.32231017238456;376.3432809746992;5031.365194334867;5090.701871022884;5127.589792816575;5350.705711185893;5430.402655707874;4929.186684197103;5086.830029093311;5376.327959005124;5380.461953804627;5410.458954104588;3720.2931443025873;4205.747655140686;4234.343676730112;4240.3851441540955;4254.212970600433;3490.668386503291;3851.2105018471148;3853.2678791029616;3966.980165099185;3984.442178095069;3521.418965870628;3583.552055993001;3983.5418926823495;4172.33242681171;4263.786810659471;3801.4107813288983;4214.115035842477;4222.239996800575;4241.875902885707;4263.936040959388;2803.3600343798903;3272.083816531375;3583.8924832255075;3701.2042410881522;3724.7279159712552;4812.350332705075;4927.827526036572;5230.267762513251;5237.580993520509;5296.602754793367;4272.786360681985;4830.512286172624;4865.781039853215;4866.153300319317;4866.3673722416215;5651.9152212716845;5716.28546431696;5717.9714101429645;5734.139879018139;5781.682007489587;3825.480557886751;3829.483019792348;4065.7560546367313;4084.6936479764136;4092.202020605983;4912.484189160123;4934.851954441337;5561.249231353796;5721.227634269362;5886.323072846634;3782.413725872494;4177.394277829698;4187.099773548702;4187.309093999456;4192.664586833046;3940.2907476653904;4228.556001619847;4241.985057097915;4244.8514301999285;4246.490421149482;4480.574345437179;4653.139169253699;4827.42070951481;4892.8532144035735;4900.26496025599;5774.68239246837;5797.507211886952;5800.303963524404;5800.50695690871;5822.505087067647;1340.2829486224823;1348.2517202952456;1383.7716776731727;1388.576484172317;1391.8190635217356;908.3323757038703;970.9804705059801;973.5473005052685;981.283662926068;987.59015008772;5259.737013149327;5272.314599102092;5272.868178295496;5297.576193904555;5344.087472327591;5485.341758988867;5541.418151094158;5649.774009039593;5752.539796816328;5782.906145212291;4463.754493502824;4830.951690483121;4959.056176419402;5050.444451110375;5287.4976877196605;2592.4426248356317;2924.195846142328;2926.2976885547314;2932.1558088653974;2943.528235882059;5004.947971331737;5931.406859314034;5958.314793798682;5971.8056388722425;6005.579609427298;5121.8463446096675;5198.818041368534;5284.630075894651;5439.374471935778;5810.983077961339;5519.503244707916;5783.508401785811;5789.305283366023;5869.4717475427415;5923.7926672566255;5032;5318.962802253678;5630.971845140748;5715.828525144252;5747.626404283876;4568.634509239187;5092.9745351273;5333.813316533902;5487.75305111279;5535.833924982096;5197.376314842092;5827.5337972961215;5901.849139417773;5983.9401605983385;6229.50163986889;3447.396705576464;3717.2937141942944;4175.912043978011;4192.329227323614;4213.810378532912;4950.851474455772;5721.342045664635;5796.594238403271;5836.970815145897;5900.409959004237;4645.442546894395;4889.804407823647;5676.545876329967;5713.114467257582;5730.398308177581;4973.68723543554;5108.386993560796;5138.640295179302;5747;5793.333766616893;4740.3837501124635;5474.72626368672;5529.654558991752;5552.50027497511;5628.382801997091;4495.730256184639;5443.836684899459;5717.942820571741;5725.6850873202375;5747.195392645117;5268.6575372600655;5295.629305948547;5559.916601251065;5596.972015139898;5597.496225339739 19:18:45 INFO - PROCESS | 1635 | |5;yui.html;716.3016059342139;734.5739471106755;779.723198264616;835.7158566087531;840.1052878684203;13102.410391532369;14698.853011469882;15618.531444056696;15653.295601697922;15724;11454.656360309184;13513.324333783321;13519.797203041937;13529.120607160528;13552.39014244359;720.7585458871284;847.2078606502939;848.6223630484437;856.4261944497171;867.1978419961542;874.3704532736451;874.9475031498099;875.8248350329959;876.4784952953015;878.275422776209;894.4588523943019;918.3158546882581;918.3663272342062;919.839028170071;920.7329874336434;774.9612519374065;906.2115959115579;906.8639704044446;908.9318301127441;913.018505107006;682.1405029662611;683.723092147681;683.9110915580992;685.1196212866442;687.1547995964941;15097.867659925549;15410.3835846566;15464.768028479582;15648.608784780357;15959.760603590956;13985;14137.010409271355;14208.502702405367;14241.928790356085;14290.428382864673;8524.957375213145;11759.235649682743;11779.411029448493;11787.94106029473;12067.094967877356;3654.543182102237;3680.1167719747336;3703.6851867591286;3705.573859006222;3817.6373244541724;70866.29133708648;74130.14674633123;93318.06681933162;96367.51816240944;98163.99999999929;10420.791584168426;10707.411092389837;10760.740244548733;10771.676849694522;10883.074938630305;21053.894730526557;21089.894550527457;21211.363659090253;21274.468138296666;21280.255191068547;7623.504472209289;7633.274838890296;7660.46376753633;7687.577183254863;7785.532868027936;4262.190183865056;4312.159128969884;4371.388005679208;4378.846740364072;4461.821527138943;3513.4554144107706;3564.803935783505;3581.1047238190454;3592.0121966459433;3605.8197090145386;641.7208514296296;647.9838004049842;653.9182602174728;661.9338066193438;663.9900401493982;648.2933602373436;673.3838537738013;674.2381109346408;697.9147425753002;708.0794966543473;9831.410115393099;9838;10033.44816035125;10129.746756331151;10524.894751052545;673.3737624009718;683.3951952521954;703.2053779229439;715.9391451726661;717.4834119434104;4774.689645173053;5055.266986286968;5055.646104772631;5057.949420505748;5070.7464626768515;105930;107696.46151769347;112236.43881780702;112671.4366428179;112752.43623781829;53999;56991.715041424526;62308;72662.63668681623;91985.54007230054;69718;70314.64842675754;71861.6406917962;72713.54572908512;73139.26860731431;8553.61508732096;9968.750781230237;10654.467276635982;10746;10986.780264394827;46436;47412.52587474219;48451;49483.75258123686;50450;64314;65249.673751632836;66124.33875661182;67304;67554;12514.749705005666;12677.619671409873;12844.486220551447;12939.223646581235;12967.870321296667;14368.353424095732;14618.634534136732;14733.778993314894;15229.390824366901;15308.545688159607;13359.599212023655;13592.45630174782;13659;13692.246926419142;14026.579202623938;13253.602391928258;13459.461621535029;13601.659958501117;13956.930215348859;14078.225697586322;12715.300658463504;13216;13222.933885330896;13698.863011370157;13840.930795346361;10823.891761082288;11034.66066086913;11053.613123540637;11244.212905096565;11518.136139789716;7854.882176767239;9485.434903240888;10724.195685323475;10842.295250808673;10994.780104398027 19:18:45 INFO - PROCESS | 1635 | __end_tp_report 19:18:45 INFO - PROCESS | 1635 | __start_cc_report 19:18:45 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,379 19:18:45 INFO - PROCESS | 1635 | __end_cc_report 19:18:45 INFO - PROCESS | 1635 | __startTimestamp1485314325291__endTimestamp 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | ------- Summary: start ------- 19:18:45 INFO - PROCESS | 1635 | Number of tests: 6 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5638.93 Median:5879.91 stddev:663.97 (11.3%) stddev-sans-first:640.86 19:18:45 INFO - PROCESS | 1635 | Values: 3331.3 3340.1 3367.7 3370.1 3393.1 4559.0 4766.5 5479.5 5531.6 5632.6 4781.5 5530.3 5542.5 5597.8 5602.9 4222.0 5053.3 5068.0 5110.5 5204.8 5159.4 5178.8 5186.4 5195.3 5197.0 5081.2 5186.7 5197.1 5210.3 5213.3 3810.0 4640.7 5077.2 5094.6 5124.8 4963.0 5001.9 5040.3 5123.3 5152.7 5312.6 5595.6 5598.5 5661.7 5666.9 6079.2 6099.0 6165.8 6173.6 6210.9 6102.1 6231.9 6255.5 6258.9 6272.3 5635.4 5677.6 5721.5 5731.9 5804.8 6231.9 6270.3 6281.4 6284.9 6286.0 6001.8 6027.1 6057.0 6068.7 6112.1 6053.9 6054.7 6077.7 6079.6 6118.4 5249.7 6071.7 6072.8 6161.1 6170.8 6150.4 6168.1 6174.2 6174.4 6197.7 4870.0 4875.5 4919.7 4946.9 4977.3 4436.0 4441.1 4447.0 4453.6 4457.3 5815.5 5827.3 5876.7 5890.7 5917.9 6081.7 6104.1 6105.5 6111.2 6192.0 5835.3 5843.5 5855.6 5960.5 5968.9 5428.4 5434.6 5440.1 5459.7 5463.4 6320.5 6327.1 6330.2 6331.5 6337.4 6016.5 6103.4 6107.5 6111.4 6144.2 5350.4 6268.8 6322.7 6340.9 6353.3 6103.2 6127.9 6139.8 6147.8 6163.5 6038.2 6100.6 6182.1 6194.8 6203.4 5978.0 5978.4 5986.9 5988.5 5991.0 5334.9 5732.4 5830.1 5976.4 6007.2 5291.2 5764.8 5834.6 5923.6 5950.7 6003.5 6038.2 6043.0 6050.3 6057.0 5569.5 5701.5 5855.1 5879.9 5881.4 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:65225.23 Median:38555.02 stddev:135735.06 (352.1%) stddev-sans-first:136028.76 19:18:45 INFO - PROCESS | 1635 | Values: 469.2 480.2 497.2 504.4 519.7 38657.0 41589.4 41780.6 41930.0 43782.1 42316.8 42365.8 42621.8 42625.0 42932.7 8343.1 8533.4 9119.3 9318.4 9334.9 11007.8 11342.3 11349.4 11447.4 11480.1 11257.0 11278.3 11286.7 11296.1 11298.6 11224.1 11297.0 11299.5 11337.9 11344.7 11093.7 11194.3 11195.6 11200.8 11210.2 39791.0 39945.2 39978.8 40125.4 40154.0 4030.0 4061.2 4066.7 4084.8 4116.3 27517.0 29144.9 29251.4 30334.7 30367.0 3079.7 3243.6 3249.1 3264.0 3287.7 452787.0 456373.7 458472.0 458672.0 458810.0 52829.9 56929.1 58410.7 59444.0 59536.0 62031.7 62178.7 62508.0 62645.7 62768.7 15506.5 15986.0 16030.4 16067.9 16090.3 11233.9 11517.5 12321.9 12519.9 12579.5 15322.2 15513.6 15568.8 15655.7 15740.8 5587.9 5698.6 6496.0 6596.9 6620.7 770.3 832.1 867.9 896.8 905.4 28454.1 29720.1 30061.0 30062.8 30128.7 958.7 974.3 1053.9 1086.6 1209.7 15082.2 15545.8 15678.8 15680.0 16040.0 496634.0 581200.0 583413.0 585517.0 585578.0 59221.1 59854.1 59872.4 60006.0 60085.4 1401.9 1444.9 1456.5 1456.5 1462.5 29412.9 29681.9 29762.6 30341.4 30469.8 48670.3 48914.3 49084.0 49169.0 49282.5 467638.0 504679.0 507065.0 508413.0 510355.0 32010.5 32873.5 33756.5 38453.0 39783.0 38794.6 45033.5 45862.0 46474.0 46795.0 37392.3 38863.2 38931.8 39984.8 40061.8 37862.6 38017.8 38285.0 39091.8 39580.8 36009.3 36049.1 36084.0 36110.3 36258.0 32936.0 33814.0 34059.3 34181.5 34497.8 24638.6 25134.5 25311.3 25329.0 25362.0 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:38818.13 Median:21756.51 stddev:117395.32 (539.6%) stddev-sans-first:117689.16 19:18:45 INFO - PROCESS | 1635 | Values: 377.8 384.3 386.3 398.2 411.0 19455.8 19827.0 20962.0 21467.8 21701.3 21122.9 21207.6 21544.7 21811.7 22092.3 5623.8 5793.8 6016.4 6112.3 6159.1 3837.1 4035.8 5130.3 5823.2 6104.1 6049.2 6074.5 6156.0 6160.5 6175.9 6139.8 6266.2 6614.4 6697.1 6731.7 5111.8 5942.1 5957.5 5966.6 5988.6 13554.1 13757.9 19510.5 25516.7 26337.6 2400.2 2443.5 2640.8 2678.0 2685.0 9773.4 10322.6 10333.4 10483.3 10555.8 1824.5 1830.2 1851.5 1865.7 1887.1 106553.5 109720.0 116970.0 123435.0 132074.0 11726.7 12189.5 12210.9 12213.7 12229.0 15363.3 15436.8 15446.1 15461.1 15461.3 7203.9 7922.6 8644.5 8708.2 8788.2 8408.2 8413.3 8421.2 8576.8 8602.4 4017.3 4717.5 4788.4 4794.1 4883.0 1724.3 1835.5 1925.2 1967.7 2032.9 882.4 997.6 1005.8 1006.6 1053.1 21522.2 21865.7 22006.8 22028.7 22160.8 1012.5 1015.5 1024.7 1043.4 1063.7 11290.5 11524.7 11525.8 11535.6 11587.9 666295.0 691785.0 712172.0 722901.0 738897.0 112675.0 130486.7 136676.3 144806.0 147202.0 966.2 1016.7 1047.0 1051.7 1053.1 20035.9 20118.9 20388.8 20550.8 20565.4 58603.7 59473.8 59771.7 60410.0 60485.0 86584.0 90675.0 91728.5 92613.6 92704.6 8176.4 8319.8 8476.7 8591.5 8602.3 9120.5 11067.9 11503.5 13377.0 13579.5 10927.4 11295.2 11412.5 11438.8 11555.9 9559.5 11421.2 11469.8 11525.3 11837.8 11690.8 11740.1 11794.4 11798.4 12068.7 8273.2 8393.3 8641.8 8764.8 8767.2 11030.6 11142.8 11164.4 11426.9 11477.4 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5301.35 Median:5204.40 stddev:2851.35 (54.8%) stddev-sans-first:2844.37 19:18:45 INFO - PROCESS | 1635 | Values: 1413.4 1456.6 1482.3 1486.1 1496.2 6136.7 7412.9 7965.8 8383.0 8396.2 7843.7 8127.4 8129.9 8218.0 8259.7 2291.5 2321.7 2327.3 2328.0 2337.6 2105.9 2175.2 2336.9 2339.0 2350.0 2297.7 2301.5 2326.2 2326.7 2329.2 2292.3 2299.4 2311.2 2315.6 2320.8 2267.2 2325.6 2326.2 2333.6 2338.4 8046.4 8116.6 8123.4 8132.2 8203.8 4943.6 5105.8 5113.9 5114.7 5123.0 3249.4 3355.3 3475.3 3528.4 3564.5 1196.9 1216.5 1230.7 1236.1 1238.3 10487.0 10492.4 10557.1 10560.7 10568.6 4344.8 4555.1 4640.5 4641.8 4660.0 9280.6 9290.0 9323.3 9334.4 9345.9 5013.9 5095.3 5177.5 5179.6 5200.8 3760.0 4232.0 4318.5 4633.1 4672.8 3798.9 3815.7 3901.1 3933.7 3954.5 1283.5 1283.7 1284.2 1294.8 1304.7 906.7 932.4 933.5 936.5 958.9 5304.8 5342.3 5481.4 5593.4 5668.9 513.2 569.1 581.6 584.2 593.3 3593.2 3669.5 3767.3 3777.7 3779.8 8026.6 9439.6 9774.2 9795.5 9817.1 8170.4 9319.0 9507.0 9604.8 9719.0 7619.0 7694.1 7708.1 7709.3 7746.0 5207.9 5263.9 5286.2 5327.4 5365.3 8898.3 8915.4 8959.4 9061.0 9080.2 8792.9 8988.3 9027.3 9107.0 9263.4 5787.5 6210.6 6409.0 6862.1 7101.7 7706.9 7858.2 7887.8 7889.8 7896.6 6991.0 7131.5 7160.3 7173.3 7235.1 6798.9 6994.6 7015.9 7031.8 7043.5 6165.8 6279.9 6358.3 6413.8 6416.3 4967.7 5005.1 5010.5 5052.7 5079.6 4897.4 5004.5 5040.1 5153.1 5163.7 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4584.67 Median:5091.84 stddev:1372.37 (27.0%) stddev-sans-first:1338.20 19:18:45 INFO - PROCESS | 1635 | Values: 310.8 349.3 358.2 370.3 376.3 5031.4 5090.7 5127.6 5350.7 5430.4 4929.2 5086.8 5376.3 5380.5 5410.5 3720.3 4205.7 4234.3 4240.4 4254.2 3490.7 3851.2 3853.3 3967.0 3984.4 3521.4 3583.6 3983.5 4172.3 4263.8 3801.4 4214.1 4222.2 4241.9 4263.9 2803.4 3272.1 3583.9 3701.2 3724.7 4812.4 4927.8 5230.3 5237.6 5296.6 4272.8 4830.5 4865.8 4866.2 4866.4 5651.9 5716.3 5718.0 5734.1 5781.7 3825.5 3829.5 4065.8 4084.7 4092.2 4912.5 4934.9 5561.2 5721.2 5886.3 3782.4 4177.4 4187.1 4187.3 4192.7 3940.3 4228.6 4242.0 4244.9 4246.5 4480.6 4653.1 4827.4 4892.9 4900.3 5774.7 5797.5 5800.3 5800.5 5822.5 1340.3 1348.3 1383.8 1388.6 1391.8 908.3 971.0 973.5 981.3 987.6 5259.7 5272.3 5272.9 5297.6 5344.1 5485.3 5541.4 5649.8 5752.5 5782.9 4463.8 4831.0 4959.1 5050.4 5287.5 2592.4 2924.2 2926.3 2932.2 2943.5 5004.9 5931.4 5958.3 5971.8 6005.6 5121.8 5198.8 5284.6 5439.4 5811.0 5519.5 5783.5 5789.3 5869.5 5923.8 5032.0 5319.0 5631.0 5715.8 5747.6 4568.6 5093.0 5333.8 5487.8 5535.8 5197.4 5827.5 5901.8 5983.9 6229.5 3447.4 3717.3 4175.9 4192.3 4213.8 4950.9 5721.3 5796.6 5837.0 5900.4 4645.4 4889.8 5676.5 5713.1 5730.4 4973.7 5108.4 5138.6 5747.0 5793.3 4740.4 5474.7 5529.7 5552.5 5628.4 4495.7 5443.8 5717.9 5725.7 5747.2 5268.7 5295.6 5559.9 5597.0 5597.5 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19232.30 Median:4375.12 stddev:27006.17 (617.3%) stddev-sans-first:27046.14 19:18:45 INFO - PROCESS | 1635 | Values: 716.3 734.6 779.7 835.7 840.1 13102.4 14698.9 15618.5 15653.3 15724.0 11454.7 13513.3 13519.8 13529.1 13552.4 720.8 847.2 848.6 856.4 867.2 874.4 874.9 875.8 876.5 878.3 894.5 918.3 918.4 919.8 920.7 775.0 906.2 906.9 908.9 913.0 682.1 683.7 683.9 685.1 687.2 15097.9 15410.4 15464.8 15648.6 15959.8 13985.0 14137.0 14208.5 14241.9 14290.4 8525.0 11759.2 11779.4 11787.9 12067.1 3654.5 3680.1 3703.7 3705.6 3817.6 70866.3 74130.1 93318.1 96367.5 98164.0 10420.8 10707.4 10760.7 10771.7 10883.1 21053.9 21089.9 21211.4 21274.5 21280.3 7623.5 7633.3 7660.5 7687.6 7785.5 4262.2 4312.2 4371.4 4378.8 4461.8 3513.5 3564.8 3581.1 3592.0 3605.8 641.7 648.0 653.9 661.9 664.0 648.3 673.4 674.2 697.9 708.1 9831.4 9838.0 10033.4 10129.7 10524.9 673.4 683.4 703.2 715.9 717.5 4774.7 5055.3 5055.6 5057.9 5070.7 105930.0 107696.5 112236.4 112671.4 112752.4 53999.0 56991.7 62308.0 72662.6 91985.5 69718.0 70314.6 71861.6 72713.5 73139.3 8553.6 9968.8 10654.5 10746.0 10986.8 46436.0 47412.5 48451.0 49483.8 50450.0 64314.0 65249.7 66124.3 67304.0 67554.0 12514.7 12677.6 12844.5 12939.2 12967.9 14368.4 14618.6 14733.8 15229.4 15308.5 13359.6 13592.5 13659.0 13692.2 14026.6 13253.6 13459.5 13601.7 13956.9 14078.2 12715.3 13216.0 13222.9 13698.9 13840.9 10823.9 11034.7 11053.6 11244.2 11518.1 7854.9 9485.4 10724.2 10842.3 10994.8 19:18:45 INFO - PROCESS | 1635 | -------- Summary: end -------- 19:18:45 INFO - PROCESS | 1635 | 19:18:45 INFO - TEST-INFO | 1635: exit 0 19:18:45 INFO - TEST-OK | dromaeo_css | took 1115853ms 19:18:45 INFO - TEST-START | kraken 19:18:45 INFO - operating with platform_type : mac_ 19:18:45 INFO - Initialising browser for kraken test... 19:18:45 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpjD2ah6/profile http://localhost:49235/getInfo.html) 19:18:48 INFO - PROCESS | 1647 | 2017-01-24 19:18:48.770 plugin-container[1648:10215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 19:18:48 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:18:48 INFO - PROCESS | 1647 | 2017-01-24 19:18:48.773 plugin-container[1648:10215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 19:18:48 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:18:48 INFO - PROCESS | 1647 | 2017-01-24 19:18:48.773 plugin-container[1648:10215] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:18:48 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 19:18:48 INFO - PROCESS | 1647 | colorDepth:24 19:18:48 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 19:18:48 INFO - PROCESS | 1647 | __metrics 19:18:48 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3253: TypeError: this.tabs is undefined 19:18:49 INFO - TEST-INFO | 1647: exit 0 19:18:49 INFO - Browser initialized. 19:18:49 INFO - Running cycle 1/1 for kraken test... 19:18:49 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpjD2ah6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:51 INFO - PROCESS | 1649 | 2017-01-24 19:18:51.934 plugin-container[1650:10338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 19:18:51 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:18:51 INFO - PROCESS | 1649 | 2017-01-24 19:18:51.935 plugin-container[1650:10338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 19:18:51 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:18:51 INFO - PROCESS | 1649 | 2017-01-24 19:18:51.935 plugin-container[1650:10338] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:19:01 INFO - PROCESS | 1649 | RSS: Main: 233857024 19:19:01 INFO - PROCESS | 1649 | 19:19:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:05 INFO - PROCESS | 1649 | RSS: Main: 246263808 19:19:05 INFO - PROCESS | 1649 | 19:19:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 19:19:08 INFO - PROCESS | 1649 | RSS: Main: 254382080 19:19:08 INFO - PROCESS | 1649 | 19:19:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 19:19:12 INFO - PROCESS | 1649 | RSS: Main: 257044480 19:19:12 INFO - PROCESS | 1649 | 19:19:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 19:19:15 INFO - PROCESS | 1649 | RSS: Main: 258199552 19:19:15 INFO - PROCESS | 1649 | 19:19:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:17 INFO - PROCESS | 1649 | RSS: Main: 258621440 19:19:17 INFO - PROCESS | 1649 | 19:19:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:21 INFO - PROCESS | 1649 | RSS: Main: 265236480 19:19:21 INFO - PROCESS | 1649 | 19:19:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:24 INFO - PROCESS | 1649 | RSS: Main: 265424896 19:19:24 INFO - PROCESS | 1649 | 19:19:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 19:19:28 INFO - PROCESS | 1649 | RSS: Main: 264548352 19:19:28 INFO - PROCESS | 1649 | 19:19:30 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:30 INFO - PROCESS | 1649 | RSS: Main: 263798784 19:19:30 INFO - PROCESS | 1649 | 19:19:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:33 INFO - PROCESS | 1649 | RSS: Main: 263815168 19:19:33 INFO - PROCESS | 1649 | 19:19:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:36 INFO - PROCESS | 1649 | RSS: Main: 264278016 19:19:36 INFO - PROCESS | 1649 | 19:19:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:39 INFO - PROCESS | 1649 | RSS: Main: 263786496 19:19:39 INFO - PROCESS | 1649 | 19:19:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:19:43 INFO - PROCESS | 1649 | RSS: Main: 264085504 19:19:43 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 19:19:45 INFO - PROCESS | 1649 | RSS: Main: 265994240 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | __start_tp_report 19:19:45 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 19:19:45 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 19:19:45 INFO - PROCESS | 1649 | |i|pagename|runs| 19:19:45 INFO - PROCESS | 1649 | |0;ai-astar;108;117;116;118;117;118;117;116;117;117 19:19:45 INFO - PROCESS | 1649 | |1;audio-beat-detection;140;111;112;146;113;111;111;124;167;145 19:19:45 INFO - PROCESS | 1649 | |2;audio-dft;224;257;204;231;194;198;194;199;275;238 19:19:45 INFO - PROCESS | 1649 | |3;audio-fft;78;59;59;81;63;72;81;82;70;60 19:19:45 INFO - PROCESS | 1649 | |4;audio-oscillator;87;72;83;73;69;71;80;69;73;68 19:19:45 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;91;89;101;88;92;87;91;88;90;87 19:19:45 INFO - PROCESS | 1649 | |6;imaging-darkroom;95;102;96;97;97;96;95;97;104;96 19:19:45 INFO - PROCESS | 1649 | |7;imaging-desaturate;151;149;92;92;90;96;95;90;75;152 19:19:45 INFO - PROCESS | 1649 | |8;json-parse-financial;60;66;94;96;97;94;67;62;63;64 19:19:45 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;70;83;93;82;76;86;70;71;69;71 19:19:45 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;86;92;88;86;88;94;88;90;89;87 19:19:45 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;139;140;140;141;140;147;155;160;178;140 19:19:45 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;232;247;191;233;230;179;179;198;154;147 19:19:45 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;64;90;94;96;92;72;68;66;68;65 19:19:45 INFO - PROCESS | 1649 | __end_tp_report 19:19:45 INFO - PROCESS | 1649 | __start_cc_report 19:19:45 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,914 19:19:45 INFO - PROCESS | 1649 | __end_cc_report 19:19:45 INFO - PROCESS | 1649 | __startTimestamp1485314385760__endTimestamp 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | ------- Summary: start ------- 19:19:45 INFO - PROCESS | 1649 | Number of tests: 14 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:116.10 Median:117.00 stddev:2.92 (2.5%) stddev-sans-first:0.71 19:19:45 INFO - PROCESS | 1649 | Values: 108.0 117.0 116.0 118.0 117.0 118.0 117.0 116.0 117.0 117.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:132.00 stddev:20.12 (15.2%) stddev-sans-first:20.86 19:19:45 INFO - PROCESS | 1649 | Values: 140.0 111.0 112.0 146.0 113.0 111.0 111.0 124.0 167.0 145.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:221.40 Median:227.50 stddev:28.61 (12.6%) stddev-sans-first:30.33 19:19:45 INFO - PROCESS | 1649 | Values: 224.0 257.0 204.0 231.0 194.0 198.0 194.0 199.0 275.0 238.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:70.50 Median:75.00 stddev:9.68 (12.9%) stddev-sans-first:9.87 19:19:45 INFO - PROCESS | 1649 | Values: 78.0 59.0 59.0 81.0 63.0 72.0 81.0 82.0 70.0 60.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:73.00 stddev:6.54 (9.0%) stddev-sans-first:5.13 19:19:45 INFO - PROCESS | 1649 | Values: 87.0 72.0 83.0 73.0 69.0 71.0 80.0 69.0 73.0 68.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:89.50 stddev:4.12 (4.6%) stddev-sans-first:4.36 19:19:45 INFO - PROCESS | 1649 | Values: 91.0 89.0 101.0 88.0 92.0 87.0 91.0 88.0 90.0 87.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:97.50 Median:96.00 stddev:3.03 (3.2%) stddev-sans-first:3.07 19:19:45 INFO - PROCESS | 1649 | Values: 95.0 102.0 96.0 97.0 97.0 96.0 95.0 97.0 104.0 96.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:108.20 Median:91.00 stddev:29.87 (32.8%) stddev-sans-first:27.37 19:19:45 INFO - PROCESS | 1649 | Values: 151.0 149.0 92.0 92.0 90.0 96.0 95.0 90.0 75.0 152.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:76.30 Median:80.50 stddev:16.45 (20.4%) stddev-sans-first:16.35 19:19:45 INFO - PROCESS | 1649 | Values: 60.0 66.0 94.0 96.0 97.0 94.0 67.0 62.0 63.0 64.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:77.10 Median:79.00 stddev:8.39 (10.6%) stddev-sans-first:8.49 19:19:45 INFO - PROCESS | 1649 | Values: 70.0 83.0 93.0 82.0 76.0 86.0 70.0 71.0 69.0 71.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:88.50 stddev:2.57 (2.9%) stddev-sans-first:2.52 19:19:45 INFO - PROCESS | 1649 | Values: 86.0 92.0 88.0 86.0 88.0 94.0 88.0 90.0 89.0 87.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:144.00 stddev:12.82 (8.9%) stddev-sans-first:13.18 19:19:45 INFO - PROCESS | 1649 | Values: 139.0 140.0 140.0 141.0 140.0 147.0 155.0 160.0 178.0 140.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.00 Median:214.00 stddev:35.13 (16.4%) stddev-sans-first:35.17 19:19:45 INFO - PROCESS | 1649 | Values: 232.0 247.0 191.0 233.0 230.0 179.0 179.0 198.0 154.0 147.0 19:19:45 INFO - PROCESS | 1649 | 19:19:45 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:81.00 stddev:13.59 (16.8%) stddev-sans-first:13.51 19:19:45 INFO - PROCESS | 1649 | Values: 64.0 90.0 94.0 96.0 92.0 72.0 68.0 66.0 68.0 65.0 19:19:45 INFO - PROCESS | 1649 | -------- Summary: end -------- 19:19:45 INFO - PROCESS | 1649 | 19:19:46 INFO - TEST-INFO | 1649: exit 0 19:19:46 INFO - TEST-OK | kraken | took 60831ms 19:19:46 INFO - SUITE-END | took 1176s 19:19:46 INFO - Completed test suite (00:19:36) 19:19:46 INFO - javascript benchmark 19:19:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7256.95063986412, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3331.2504686445554, 3340.131565792894, 3367.7137443317315, 3370.090075679567, 3393.0669066006844, 4558.977205113978, 4766.523347665236, 5479.506844384005, 5531.585131115167, 5632.577556683244, 4781.545753153454, 5530.253415788868, 5542.528885044776, 5597.832065038046, 5602.943970560294, 4221.978890105545, 5053.267276244942, 5068.0370729561355, 5110.463401342861, 5204.843854684365, 5159.406668233164, 5178.792848286064, 5186.377634683843, 5195.324607800981, 5196.974015129938, 5081.237814327862, 5186.7147306898105, 5197.064528384889, 5210.270562121306, 5213.2701421800975, 3810.0, 4640.744759038252, 5077.213031980012, 5094.6433749637545, 5124.769385377648, 4963.0, 5001.949980500185, 5040.294358789773, 5123.257127716461, 5152.716600587004, 5312.574994000471, 5595.63628364155, 5598.524125449342, 5661.660300381949, 5666.886662266773, 6079.20970273866, 6098.9695051524905, 6165.7533698652, 6173.629582225081, 6210.9068363974575, 6102.084687296897, 6231.937680623181, 6255.468285195764, 6258.937410625881, 6272.306477251117, 5635.380108188096, 5677.574181936371, 5721.485066344049, 5731.8567035824435, 5804.767809287666, 6231.906521402183, 6270.31026587075, 6281.403266689657, 6284.937150628435, 6285.96857015712, 6001.849953751103, 6027.065804800175, 6057.030875059969, 6068.726907289182, 6112.113743507167, 6053.878922421615, 6054.7275372607455, 6077.726502307407, 6079.574429789872, 6118.357572454828, 5249.737513124329, 6071.6660583667435, 6072.787452439232, 6161.106639537242, 6170.845728856814, 6150.415710507495, 6168.074788781719, 6174.197354343906, 6174.413430724074, 6197.690115494207, 4869.977304766039, 4875.536824001714, 4919.704817710949, 4946.9010619787405, 4977.32806071183, 4436.00189957257, 4441.089576636782, 4446.999425129385, 4453.643708503312, 4457.264551349056, 5815.476607105381, 5827.3007239131575, 5876.706164691748, 5890.705464726747, 5917.911231331534, 6081.726322315506, 6104.095385180791, 6105.459747278077, 6111.1967345965195, 6192.040233763774, 5835.328937172195, 5843.503302219359, 5855.59010869235, 5960.4635582797755, 5968.910466343008, 5428.375736790241, 5434.592405569598, 5440.075187218104, 5459.727013649302, 5463.399026107125, 6320.525960553069, 6327.082573026885, 6330.240371155491, 6331.493480521455, 6337.42963133311, 6016.488598469179, 6103.42017508336, 6107.511399088151, 6111.358307377662, 6144.2319710036245, 5350.357957045024, 6268.780592679234, 6322.715477803418, 6340.9365906340345, 6353.269374022047, 6103.23709536308, 6127.877442451037, 6139.754409823557, 6147.84630384244, 6163.476104531165, 6038.184845045863, 6100.633961962297, 6182.072689096672, 6194.752209911553, 6203.441690247719, 5978.013627751372, 5978.432048955342, 5986.880262394815, 5988.520918326436, 5991.0, 5334.919976200437, 5732.369439361751, 5830.125481177688, 5976.372480889444, 6007.189029480965, 5291.206319052019, 5764.798232061858, 5834.591578589628, 5923.555733320104, 5950.672713000653, 6003.519718422603, 6038.245219347582, 6042.969785151046, 6050.304215015153, 6056.9697151513965, 5569.526590239713, 5701.458361455655, 5855.121731740273, 5879.911801322898, 5881.441263080001], "value": 5597.096120554104, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.1812786687231, 480.15013426235566, 497.1548367774781, 504.42495555067217, 519.6803965561179, 38657.033574160625, 41589.3761593576, 41780.58219417805, 41930.0, 43782.12435751283, 42316.788416057956, 42365.7881710591, 42621.7868910655, 42625.0, 42932.71201863949, 8343.123971982945, 8533.445326053787, 9119.316051296162, 9318.394304370195, 9334.906650933506, 11007.834882476769, 11342.262752921033, 11349.432528373589, 11447.370394628291, 11480.138989575773, 11257.0, 11278.266912650652, 11286.66140015801, 11296.096312295038, 11298.604548840793, 11224.102071834233, 11297.0, 11299.548018079267, 11337.94331028348, 11344.716382090432, 11093.667189984313, 11194.272372295856, 11195.552177912874, 11200.775984480346, 11210.215284930058, 39791.0, 39945.201095978206, 39978.800635980966, 40125.398119028236, 40154.0, 4029.97985010076, 4061.208064427438, 4066.715329926906, 4084.836606535735, 4116.259073366793, 27517.0, 29144.854275728696, 29251.41497170066, 30334.696653033407, 30367.0, 3079.707427794356, 3243.594550681165, 3249.1389781707867, 3263.983680081584, 3287.6876696713775, 452787.0, 456373.71813141054, 458472.0, 458672.0, 458810.0, 52829.943401131764, 56929.14606280909, 58410.70794646085, 59444.0, 59536.0, 62031.689841550506, 62178.68910655508, 62508.0, 62645.74708505804, 62768.686156568925, 15506.5348039559, 15986.0, 16030.438934637232, 16067.919660401623, 16090.275937582837, 11233.943830280796, 11517.48171332292, 12321.876781232073, 12519.93740031294, 12579.496820127093, 15322.23388830554, 15513.612159696098, 15568.766468502981, 15655.68688626221, 15740.842591574166, 5587.888242235133, 5698.629589076697, 6495.967520162463, 6596.934030659728, 6620.702068406933, 770.2874840772263, 832.0680837461961, 867.9132086791396, 896.7713233125511, 905.4160066756905, 28454.146375608765, 29720.131691014074, 30061.0, 30062.797488100667, 30128.69871301303, 958.6644674363916, 974.332582181194, 1053.8577292065472, 1086.6305456144948, 1209.6673414810998, 15082.17048062367, 15545.766813497807, 15678.843211567966, 15679.995240975195, 16040.0, 496634.0, 581200.0, 583413.0, 585517.0, 585578.0, 59221.11168332479, 59854.10218846721, 59872.40127598668, 60006.0, 60085.39914600798, 1401.9299035048207, 1444.8627380398846, 1456.4756687592458, 1456.5120684570575, 1462.4881291547872, 29412.852935735184, 29681.85159074191, 29762.553561697026, 30341.393172136875, 30469.821332750467, 48670.26994595013, 48914.266286005026, 49084.0, 49169.0, 49282.50717492779, 467638.0, 504679.0, 507065.0, 508413.0, 510355.0, 32010.51984220192, 32873.50689739608, 33756.49365259474, 38453.0, 39783.0, 38794.6120538791, 45033.549664502934, 45862.0, 46474.0, 46795.0, 37392.25215495729, 38863.2227355457, 38931.805340973115, 39984.800076000596, 40061.79969100136, 37862.62137378591, 38017.809910950265, 38285.0, 39091.804540977115, 39580.80209598933, 36009.279814404086, 36049.098772530895, 36084.0, 36110.27779444344, 36258.0, 32936.01191964245, 33814.0, 34059.3188136231, 34181.487277691354, 34497.827510862284, 24638.630420543348, 25134.497310054063, 25311.275274858697, 25329.0, 25362.0], "value": 19968.07190286078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.75445960125916, 384.3024909788733, 386.29115572923683, 398.16981593377807, 411.0381706806073, 19455.805441945577, 19827.0, 20961.999999999964, 21467.785322146774, 21701.34895953122, 21122.943852807373, 21207.575848483022, 21544.676829847525, 21811.67282490764, 22092.337229883087, 5623.80316688917, 5793.826185214451, 6016.398360163992, 6112.327643959161, 6159.076138579204, 3837.0982819037645, 4035.778032208227, 5130.256112863633, 5823.155642431845, 6104.114903339013, 6049.213602231704, 6074.544409169308, 6156.045812899008, 6160.476359509425, 6175.876482470348, 6139.754409823602, 6266.216722909637, 6614.404703576653, 6697.129373181455, 6731.697073631698, 5111.7699703513435, 5942.078977758454, 5957.523398128139, 5966.612170208922, 5988.640681559077, 13554.118982266122, 13757.931210343884, 19510.51223719404, 25516.74483255181, 26337.604935925978, 2400.1599440195964, 2443.5235129149823, 2640.762331390165, 2677.9866100669374, 2685.0, 9773.35774935862, 10322.58709651613, 10333.379997200193, 10483.266171368008, 10555.788884222273, 1824.5165031266724, 1830.2221555838848, 1851.5000949743628, 1865.654853852028, 1887.1319193171157, 106553.46723266334, 109720.0, 116970.0, 123435.0, 132074.0, 11726.70683232926, 12189.451474683661, 12210.938945305394, 12213.69465763363, 12229.0, 15363.308651110727, 15436.768448473058, 15446.0732356059, 15461.072335659896, 15461.304241309168, 7203.927960720326, 7922.603869806487, 8644.524551149621, 8708.17272359125, 8788.209061184396, 8408.2432581068, 8413.3269338454, 8421.15788421153, 8576.828463430697, 8602.397832151815, 4017.3371393720295, 4717.481077081518, 4788.353572267699, 4794.137055330004, 4882.9755851221225, 1724.2671864457554, 1835.5476764336836, 1925.2010415677337, 1967.7245185674017, 2032.888191149501, 882.3823323673454, 997.6209040564539, 1005.7636455432968, 1006.5571148694551, 1053.052252972331, 21522.246721364678, 21865.674998875555, 22006.779932200792, 22028.669569956463, 22160.77839221587, 1012.5038731021747, 1015.5227043289642, 1024.7438140464883, 1043.446973104256, 1063.6543123484744, 11290.47578576898, 11524.711882202844, 11525.769484610428, 11535.596254131233, 11587.88412115885, 666295.0055749167, 691785.0, 712172.0, 722901.0, 738897.0, 112675.0, 130486.69513304745, 136676.31661841628, 144806.0, 147202.0, 966.2077096780713, 1016.6543375252302, 1047.0053449223117, 1051.7265510967204, 1053.0575135253905, 20035.899820500803, 20118.899405502878, 20388.776673399643, 20550.84216157342, 20565.38303850887, 58603.70698146482, 59473.810523788416, 59771.70114149575, 60410.0, 60485.0, 86584.0, 90675.0, 91728.54135729278, 92613.61079583946, 92704.60943085724, 8176.386770992318, 8319.833603328021, 8476.745697629081, 8591.484510929364, 8602.311815054905, 9120.45277283365, 11067.944660276647, 11503.48234329474, 13376.996725245452, 13579.52471663487, 10927.398993055458, 11295.152863535104, 11412.48643811014, 11438.771224575295, 11555.942220289182, 9559.522023898639, 11421.200515963803, 11469.770604587695, 11525.250858694159, 11837.82243266369, 11690.824637630272, 11740.119491038377, 11794.351310677652, 11798.41007949582, 12068.698282543006, 8273.214044665747, 8393.286570641563, 8641.783955401166, 8764.824703506021, 8767.21095101444, 11030.613928512785, 11142.777144456903, 11164.441777911234, 11426.885731142915, 11477.426128693698], "value": 9867.631409759122, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.356922600217, 1456.5630310906724, 1482.3477669825277, 1486.078631248626, 1496.1771025935739, 6136.723847426865, 7412.888806667905, 7965.76102716918, 8382.958085209573, 8396.202360775724, 7843.6862525499055, 8127.4310798244, 8129.91870081299, 8217.958910205456, 8259.710910118147, 2291.4615065459643, 2321.6865723127416, 2327.2669109230624, 2328.0, 2337.614293641547, 2105.8841763703067, 2175.1734340950416, 2336.9298921032396, 2339.0, 2349.964750528735, 2297.7357603875516, 2301.493671392291, 2326.2439707095264, 2326.720793504782, 2329.2080692564523, 2292.3008482412856, 2299.367673889677, 2311.167979527377, 2315.560043591712, 2320.8027317678016, 2267.1724820440586, 2325.6395258734756, 2326.1858349577683, 2333.6499525071204, 2338.3686404670643, 8046.436749427542, 8116.5941702914615, 8123.350131989427, 8132.227438393344, 8203.794905127419, 4943.579795717368, 5105.82129625465, 5113.923291150636, 5114.718690472023, 5123.026624941249, 3249.4151052810485, 3355.261842394669, 3475.3396854597545, 3528.4001719707453, 3564.536610240678, 1196.8743281955444, 1216.4769149265812, 1230.7046308885804, 1236.1285293867802, 1238.3127364312802, 10486.951304869528, 10492.370457772558, 10557.102646275076, 10560.735981600521, 10568.577256909715, 4344.826206951687, 4555.088982203506, 4640.466346370211, 4641.767911604406, 4659.974805542775, 9280.628774849065, 9289.953550232342, 9323.25413966881, 9334.393264437926, 9345.906540934504, 5013.924791128136, 5095.31213286209, 5177.456367081402, 5179.637425380187, 5200.843974680765, 3760.0, 4231.978840105779, 4318.537884815936, 4633.0733853229485, 4672.813087476463, 3798.867039653599, 3815.73289869712, 3901.1027463683513, 3933.665638420709, 3954.525456945185, 1283.4673610451557, 1283.6598301450124, 1284.2487145020082, 1294.8187253784479, 1304.7455746129604, 906.664534122379, 932.3706498113881, 933.5192375926404, 936.4942930817418, 958.8897276813116, 5304.787808487695, 5342.2787923630585, 5481.424450432727, 5593.412691667398, 5668.8866222675315, 513.1609817947682, 569.1008207032878, 581.6451964301773, 584.1617279204355, 593.3354642800092, 3593.1915319053005, 3669.486271921933, 3767.3407153747985, 3777.697784177259, 3779.829907654162, 8026.638801253957, 9439.622415103318, 9774.218062554979, 9795.461249631197, 9817.116459518678, 8170.428070035159, 9319.0, 9507.0, 9604.807903841884, 9718.951405242928, 7618.961905190438, 7694.07671079474, 7708.113566939649, 7709.306162445407, 7745.961270193613, 5207.947920520746, 5263.947360526499, 5286.233496142961, 5327.413984461784, 5365.256291705289, 8898.288136949159, 8915.37592368528, 8959.372843901125, 9060.95798983099, 9080.182783549511, 8792.868106978529, 8988.325875559229, 9027.32295077885, 9106.954465227896, 9263.444193348421, 5787.508061814793, 6210.596311239755, 6408.9745640697265, 6862.107925969592, 7101.680424380812, 7706.884396734165, 7858.174891636296, 7887.802804929923, 7889.763307100796, 7896.605169741605, 6991.021257023919, 7131.536450130725, 7160.319769621878, 7173.282671732785, 7235.059442272471, 6798.898016529855, 6994.61529615876, 7015.894761578683, 7031.789046328414, 7043.471739619651, 6165.784197553064, 6279.937200627935, 6358.300586935526, 6413.807585772434, 6416.294207637249, 4967.7083958170415, 5005.099082165245, 5010.549050585465, 5052.72210028452, 5079.568236699774, 4897.41231052276, 5004.549590536723, 5040.117979353672, 5153.098207813543, 5163.715995620277], "value": 4301.7112822677445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.81195876494706, 349.3083694285315, 358.17262124492424, 370.32231017238456, 376.3432809746992, 5031.365194334867, 5090.701871022884, 5127.589792816575, 5350.705711185893, 5430.402655707874, 4929.186684197103, 5086.830029093311, 5376.327959005124, 5380.461953804627, 5410.458954104588, 3720.2931443025873, 4205.747655140686, 4234.343676730112, 4240.3851441540955, 4254.212970600433, 3490.668386503291, 3851.2105018471148, 3853.2678791029616, 3966.980165099185, 3984.442178095069, 3521.418965870628, 3583.552055993001, 3983.5418926823495, 4172.33242681171, 4263.786810659471, 3801.4107813288983, 4214.115035842477, 4222.239996800575, 4241.875902885707, 4263.936040959388, 2803.3600343798903, 3272.083816531375, 3583.8924832255075, 3701.2042410881522, 3724.7279159712552, 4812.350332705075, 4927.827526036572, 5230.267762513251, 5237.580993520509, 5296.602754793367, 4272.786360681985, 4830.512286172624, 4865.781039853215, 4866.153300319317, 4866.3673722416215, 5651.9152212716845, 5716.28546431696, 5717.9714101429645, 5734.139879018139, 5781.682007489587, 3825.480557886751, 3829.483019792348, 4065.7560546367313, 4084.6936479764136, 4092.202020605983, 4912.484189160123, 4934.851954441337, 5561.249231353796, 5721.227634269362, 5886.323072846634, 3782.413725872494, 4177.394277829698, 4187.099773548702, 4187.309093999456, 4192.664586833046, 3940.2907476653904, 4228.556001619847, 4241.985057097915, 4244.8514301999285, 4246.490421149482, 4480.574345437179, 4653.139169253699, 4827.42070951481, 4892.8532144035735, 4900.26496025599, 5774.68239246837, 5797.507211886952, 5800.303963524404, 5800.50695690871, 5822.505087067647, 1340.2829486224823, 1348.2517202952456, 1383.7716776731727, 1388.576484172317, 1391.8190635217356, 908.3323757038703, 970.9804705059801, 973.5473005052685, 981.283662926068, 987.59015008772, 5259.737013149327, 5272.314599102092, 5272.868178295496, 5297.576193904555, 5344.087472327591, 5485.341758988867, 5541.418151094158, 5649.774009039593, 5752.539796816328, 5782.906145212291, 4463.754493502824, 4830.951690483121, 4959.056176419402, 5050.444451110375, 5287.4976877196605, 2592.4426248356317, 2924.195846142328, 2926.2976885547314, 2932.1558088653974, 2943.528235882059, 5004.947971331737, 5931.406859314034, 5958.314793798682, 5971.8056388722425, 6005.579609427298, 5121.8463446096675, 5198.818041368534, 5284.630075894651, 5439.374471935778, 5810.983077961339, 5519.503244707916, 5783.508401785811, 5789.305283366023, 5869.4717475427415, 5923.7926672566255, 5032.0, 5318.962802253678, 5630.971845140748, 5715.828525144252, 5747.626404283876, 4568.634509239187, 5092.9745351273, 5333.813316533902, 5487.75305111279, 5535.833924982096, 5197.376314842092, 5827.5337972961215, 5901.849139417773, 5983.9401605983385, 6229.50163986889, 3447.396705576464, 3717.2937141942944, 4175.912043978011, 4192.329227323614, 4213.810378532912, 4950.851474455772, 5721.342045664635, 5796.594238403271, 5836.970815145897, 5900.409959004237, 4645.442546894395, 4889.804407823647, 5676.545876329967, 5713.114467257582, 5730.398308177581, 4973.68723543554, 5108.386993560796, 5138.640295179302, 5747.0, 5793.333766616893, 4740.3837501124635, 5474.72626368672, 5529.654558991752, 5552.50027497511, 5628.382801997091, 4495.730256184639, 5443.836684899459, 5717.942820571741, 5725.6850873202375, 5747.195392645117, 5268.6575372600655, 5295.629305948547, 5559.916601251065, 5596.972015139898, 5597.496225339739], "value": 4163.574962609546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3016059342139, 734.5739471106755, 779.723198264616, 835.7158566087531, 840.1052878684203, 13102.410391532369, 14698.853011469882, 15618.531444056696, 15653.295601697922, 15724.0, 11454.656360309184, 13513.324333783321, 13519.797203041937, 13529.120607160528, 13552.39014244359, 720.7585458871284, 847.2078606502939, 848.6223630484437, 856.4261944497171, 867.1978419961542, 874.3704532736451, 874.9475031498099, 875.8248350329959, 876.4784952953015, 878.275422776209, 894.4588523943019, 918.3158546882581, 918.3663272342062, 919.839028170071, 920.7329874336434, 774.9612519374065, 906.2115959115579, 906.8639704044446, 908.9318301127441, 913.018505107006, 682.1405029662611, 683.723092147681, 683.9110915580992, 685.1196212866442, 687.1547995964941, 15097.867659925549, 15410.3835846566, 15464.768028479582, 15648.608784780357, 15959.760603590956, 13985.0, 14137.010409271355, 14208.502702405367, 14241.928790356085, 14290.428382864673, 8524.957375213145, 11759.235649682743, 11779.411029448493, 11787.94106029473, 12067.094967877356, 3654.543182102237, 3680.1167719747336, 3703.6851867591286, 3705.573859006222, 3817.6373244541724, 70866.29133708648, 74130.14674633123, 93318.06681933162, 96367.51816240944, 98163.99999999929, 10420.791584168426, 10707.411092389837, 10760.740244548733, 10771.676849694522, 10883.074938630305, 21053.894730526557, 21089.894550527457, 21211.363659090253, 21274.468138296666, 21280.255191068547, 7623.504472209289, 7633.274838890296, 7660.46376753633, 7687.577183254863, 7785.532868027936, 4262.190183865056, 4312.159128969884, 4371.388005679208, 4378.846740364072, 4461.821527138943, 3513.4554144107706, 3564.803935783505, 3581.1047238190454, 3592.0121966459433, 3605.8197090145386, 641.7208514296296, 647.9838004049842, 653.9182602174728, 661.9338066193438, 663.9900401493982, 648.2933602373436, 673.3838537738013, 674.2381109346408, 697.9147425753002, 708.0794966543473, 9831.410115393099, 9838.0, 10033.44816035125, 10129.746756331151, 10524.894751052545, 673.3737624009718, 683.3951952521954, 703.2053779229439, 715.9391451726661, 717.4834119434104, 4774.689645173053, 5055.266986286968, 5055.646104772631, 5057.949420505748, 5070.7464626768515, 105930.0, 107696.46151769347, 112236.43881780702, 112671.4366428179, 112752.43623781829, 53999.0, 56991.715041424526, 62308.0, 72662.63668681623, 91985.54007230054, 69718.0, 70314.64842675754, 71861.6406917962, 72713.54572908512, 73139.26860731431, 8553.61508732096, 9968.750781230237, 10654.467276635982, 10746.0, 10986.780264394827, 46436.0, 47412.52587474219, 48451.0, 49483.75258123686, 50450.0, 64314.0, 65249.673751632836, 66124.33875661182, 67304.0, 67554.0, 12514.749705005666, 12677.619671409873, 12844.486220551447, 12939.223646581235, 12967.870321296667, 14368.353424095732, 14618.634534136732, 14733.778993314894, 15229.390824366901, 15308.545688159607, 13359.599212023655, 13592.45630174782, 13659.0, 13692.246926419142, 14026.579202623938, 13253.602391928258, 13459.461621535029, 13601.659958501117, 13956.930215348859, 14078.225697586322, 12715.300658463504, 13216.0, 13222.933885330896, 13698.863011370157, 13840.930795346361, 10823.891761082288, 11034.66066086913, 11053.613123540637, 11244.212905096565, 11518.136139789716, 7854.882176767239, 9485.434903240888, 10724.195685323475, 10842.295250808673, 10994.780104398027], "value": 7393.622575326898, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 112.0, 146.0, 113.0, 111.0, 111.0, 124.0, 167.0, 145.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 257.0, 204.0, 231.0, 194.0, 198.0, 194.0, 199.0, 275.0, 238.0], "value": 221.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 59.0, 81.0, 63.0, 72.0, 81.0, 82.0, 70.0, 60.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 83.0, 73.0, 69.0, 71.0, 80.0, 69.0, 73.0, 68.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 101.0, 88.0, 92.0, 87.0, 91.0, 88.0, 90.0, 87.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 96.0, 97.0, 97.0, 96.0, 95.0, 97.0, 104.0, 96.0], "value": 97.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 92.0, 92.0, 90.0, 96.0, 95.0, 90.0, 75.0, 152.0], "value": 108.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 66.0, 94.0, 96.0, 97.0, 94.0, 67.0, 62.0, 63.0, 64.0], "value": 76.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 93.0, 82.0, 76.0, 86.0, 70.0, 71.0, 69.0, 71.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 88.0, 86.0, 88.0, 94.0, 88.0, 90.0, 89.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 140.0, 141.0, 140.0, 147.0, 155.0, 160.0, 178.0, 140.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [232.0, 247.0, 191.0, 233.0, 230.0, 179.0, 179.0, 198.0, 154.0, 147.0], "value": 199.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 90.0, 94.0, 96.0, 92.0, 72.0, 68.0, 66.0, 68.0, 65.0], "value": 77.5, "unit": "score"}]}]} 19:19:47 INFO - Return code: 0 19:19:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:19:47 ERROR - # TBPL SUCCESS # 19:19:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:47 INFO - 2017-01-24 19:19:47.079 screenresolution[1654:10721] starting screenresolution argv=screenresolution get 19:19:47 INFO - 2017-01-24 19:19:47.084 screenresolution[1654:10721] Display 0: 1600x1200x32@60 19:19:47 INFO - 2017-01-24 19:19:47.090 screenresolution[1655:10724] starting screenresolution argv=screenresolution list 19:19:47 INFO - Available Modes on Display 0 19:19:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:47 INFO - Intel Iris: 19:19:47 INFO - Chipset Model: Intel Iris 19:19:47 INFO - Type: GPU 19:19:47 INFO - Bus: Built-In 19:19:47 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:47 INFO - Vendor: Intel (0x8086) 19:19:47 INFO - Device ID: 0x0a2e 19:19:47 INFO - Revision ID: 0x0009 19:19:47 INFO - Displays: 19:19:47 INFO - Display: 19:19:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:47 INFO - Display Serial Number: 1600x1200 60 19:19:47 INFO - Main Display: Yes 19:19:47 INFO - Mirror: Off 19:19:47 INFO - Online: Yes 19:19:47 INFO - Rotation: Supported 19:19:47 INFO - Return code: 0 19:19:47 INFO - Running post-action listener: _resource_record_post_action 19:19:47 INFO - [mozharness: 2017-01-25 03:19:47.331631Z] Finished run-tests step (success) 19:19:47 INFO - Running post-run listener: _resource_record_post_run 19:19:47 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 39156224; Write bytes: 554318336; Read time: 384; Write time: 2002 19:19:47 INFO - TinderboxPrint: CPU usage
54.6% 19:19:47 INFO - TinderboxPrint: I/O read bytes / time
39,156,224 / 384 19:19:47 INFO - TinderboxPrint: I/O write bytes / time
554,318,336 / 2,002 19:19:47 INFO - TinderboxPrint: CPU idle
2,180.3 (45.4%) 19:19:47 INFO - TinderboxPrint: CPU system
963.8 (20.1%) 19:19:47 INFO - TinderboxPrint: CPU user
1,653.6 (34.5%) 19:19:47 INFO - TinderboxPrint: Swap in / out
290,914,304 / 0 19:19:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245725696; Write bytes: 238002176; Read time: 17596; Write time: 438 19:19:47 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 37050880; Write bytes: 300571136; Read time: 357; Write time: 1526 19:19:47 INFO - Running post-run listener: _upload_blobber_files 19:19:47 INFO - Blob upload gear active. 19:19:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:19: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 19:19: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:19: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:19:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:48 INFO - (blobuploader) - INFO - Done attempting. 19:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:49 INFO - (blobuploader) - INFO - Done attempting. 19:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:50 INFO - (blobuploader) - INFO - Done attempting. 19:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:53 INFO - (blobuploader) - INFO - Done attempting. 19:19:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:19:53 INFO - Return code: 0 19:19:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:19:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:19:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefb0aaf048f5d89e06c15d0e0c169f7a535522a96721f837ed9360bf4011077a3ffa0b0d3151b9273c2188724a75aed182c3bb5836225d32cfe1c8fc25cb4f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71330cf7553074688abf0b3c9e073b29bd1d76c81861ba3b20ba6ced7b4d6aa7c735cb21c2726307618e3e255113cda7a6a51ec892cd5cde87d55197412c42c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44313fa119484c3a04b74250db0aa7948685e884aa779cce8b2076e6823a1ff1216406acb0fdaf7bfcf8501e8b3097d80b597851cf1eb59877b98ccf88ce476", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e04aaa73ac64f15cbba3622421899dc38c8dc04e8d354ad5fc1ed6237d12282bab186ea27ff4ff59f20027bf03470d085679167fbb69d794be5314ed2dac3d2"} 19:19:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:19:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:19:53 INFO - Contents: 19:19:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefb0aaf048f5d89e06c15d0e0c169f7a535522a96721f837ed9360bf4011077a3ffa0b0d3151b9273c2188724a75aed182c3bb5836225d32cfe1c8fc25cb4f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71330cf7553074688abf0b3c9e073b29bd1d76c81861ba3b20ba6ced7b4d6aa7c735cb21c2726307618e3e255113cda7a6a51ec892cd5cde87d55197412c42c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44313fa119484c3a04b74250db0aa7948685e884aa779cce8b2076e6823a1ff1216406acb0fdaf7bfcf8501e8b3097d80b597851cf1eb59877b98ccf88ce476", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e04aaa73ac64f15cbba3622421899dc38c8dc04e8d354ad5fc1ed6237d12282bab186ea27ff4ff59f20027bf03470d085679167fbb69d794be5314ed2dac3d2"} 19:19:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:19:53 INFO - Copying logs to upload dir... 19:19:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:19:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.336352 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 19:19:53.098155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:53.102194) ========= 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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefb0aaf048f5d89e06c15d0e0c169f7a535522a96721f837ed9360bf4011077a3ffa0b0d3151b9273c2188724a75aed182c3bb5836225d32cfe1c8fc25cb4f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71330cf7553074688abf0b3c9e073b29bd1d76c81861ba3b20ba6ced7b4d6aa7c735cb21c2726307618e3e255113cda7a6a51ec892cd5cde87d55197412c42c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44313fa119484c3a04b74250db0aa7948685e884aa779cce8b2076e6823a1ff1216406acb0fdaf7bfcf8501e8b3097d80b597851cf1eb59877b98ccf88ce476", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e04aaa73ac64f15cbba3622421899dc38c8dc04e8d354ad5fc1ed6237d12282bab186ea27ff4ff59f20027bf03470d085679167fbb69d794be5314ed2dac3d2"} build_url:https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011089 build_url: 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fefb0aaf048f5d89e06c15d0e0c169f7a535522a96721f837ed9360bf4011077a3ffa0b0d3151b9273c2188724a75aed182c3bb5836225d32cfe1c8fc25cb4f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71330cf7553074688abf0b3c9e073b29bd1d76c81861ba3b20ba6ced7b4d6aa7c735cb21c2726307618e3e255113cda7a6a51ec892cd5cde87d55197412c42c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44313fa119484c3a04b74250db0aa7948685e884aa779cce8b2076e6823a1ff1216406acb0fdaf7bfcf8501e8b3097d80b597851cf1eb59877b98ccf88ce476", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e04aaa73ac64f15cbba3622421899dc38c8dc04e8d354ad5fc1ed6237d12282bab186ea27ff4ff59f20027bf03470d085679167fbb69d794be5314ed2dac3d2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:53.141739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:53.142358) ========= 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.Mr48Xlskmc/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.R0BYiI8xwy/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005143 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:53.194024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:53.194763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:53.195529) ========= ========= Total master_lag: 0.79 =========