builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0214 starttime: 1493382761.98 results: success (0) buildid: 20170428040924 builduid: ee014cb5555e4354b63599a97ea8fca8 revision: d19b88fdf81d7dff1ac2ffcec4084eee7d666d11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:41.984008) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:41.984496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:41.984773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:42.012308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:42.012700) ========= 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.zUT56RqnoC/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.ifNe4OzgvV/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-28 05:32:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-04-28 05:32:42 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.231152 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:42.269018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:42.269354) ========= 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.zUT56RqnoC/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.ifNe4OzgvV/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027354 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:42.318901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 05:32:42.319296) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d19b88fdf81d7dff1ac2ffcec4084eee7d666d11 --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 d19b88fdf81d7dff1ac2ffcec4084eee7d666d11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zUT56RqnoC/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.ifNe4OzgvV/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-28 05:32:42,426 truncating revision to first 12 chars 2017-04-28 05:32:42,426 Setting DEBUG logging. 2017-04-28 05:32:42,427 attempt 1/10 2017-04-28 05:32:42,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d19b88fdf81d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 05:32:43,559 unpacking tar archive at: mozilla-central-d19b88fdf81d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.398552 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 05:32:43.743219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:43.743728) ========= script_repo_revision: d19b88fdf81d7dff1ac2ffcec4084eee7d666d11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:43.744329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:43.744740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 05:32:43.767347) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-28 05:32:43.767880) ========= /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.zUT56RqnoC/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.ifNe4OzgvV/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:32:43 INFO - MultiFileLogger online at 20170428 05:32:43 in /builds/slave/test 05:32:43 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 05:32:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:43 INFO - {'append_to_log': False, 05:32:43 INFO - 'base_work_dir': '/builds/slave/test', 05:32:43 INFO - 'blob_upload_branch': 'Firefox', 05:32:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:43 INFO - 'branch': 'Firefox', 05:32:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:43 INFO - 'config_files': ('talos/mac_config.py',), 05:32:43 INFO - 'default_actions': ('clobber', 05:32:43 INFO - 'read-buildbot-config', 05:32:43 INFO - 'download-and-extract', 05:32:43 INFO - 'populate-webroot', 05:32:43 INFO - 'create-virtualenv', 05:32:43 INFO - 'install', 05:32:43 INFO - 'run-tests'), 05:32:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:43 INFO - 'download_minidump_stackwalk': True, 05:32:43 INFO - 'download_symbols': 'ondemand', 05:32:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:43 INFO - 'gecko_profile': False, 05:32:43 INFO - 'gecko_profile_interval': 0, 05:32:43 INFO - 'installer_path': 'installer.exe', 05:32:43 INFO - 'log_level': 'info', 05:32:43 INFO - 'log_name': 'talos', 05:32:43 INFO - 'log_to_console': True, 05:32:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:32:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:32:43 INFO - 'opt_config_files': (), 05:32:43 INFO - 'pip_index': False, 05:32:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:43 INFO - 'cmd': ('bash', 05:32:43 INFO - '-c', 05:32:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:43 INFO - 'enabled': True, 05:32:43 INFO - 'halt_on_failure': False, 05:32:43 INFO - 'name': 'check_screen_resolution'},), 05:32:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:43 INFO - 'cmd': ('bash', 05:32:43 INFO - '-c', 05:32:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:43 INFO - 'enabled': True, 05:32:43 INFO - 'halt_on_failure': False, 05:32:43 INFO - 'name': 'check_screen_resolution'},), 05:32:43 INFO - 'run_cmd_checks_enabled': True, 05:32:43 INFO - 'suite': 'dromaeojs-e10s', 05:32:43 INFO - 'system_bits': '32', 05:32:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:43 INFO - 'title': 't-yosemite-r7-0214', 05:32:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:43 INFO - 'use_talos_json': True, 05:32:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:43 INFO - 'work_dir': 'build'} 05:32:43 INFO - [mozharness: 2017-04-28 12:32:43.984723Z] Running clobber step. 05:32:43 INFO - Running pre-action listener: _resource_record_pre_action 05:32:43 INFO - Running main action method: clobber 05:32:43 INFO - rmtree: /builds/slave/test/build 05:32:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:46 INFO - Running post-action listener: _resource_record_post_action 05:32:46 INFO - [mozharness: 2017-04-28 12:32:46.451961Z] Finished clobber step (success) 05:32:46 INFO - [mozharness: 2017-04-28 12:32:46.452223Z] Running read-buildbot-config step. 05:32:46 INFO - Running pre-action listener: _resource_record_pre_action 05:32:46 INFO - Running main action method: read_buildbot_config 05:32:46 INFO - Using buildbot properties: 05:32:46 INFO - { 05:32:46 INFO - "project": "", 05:32:46 INFO - "product": "firefox", 05:32:46 INFO - "script_repo_revision": "production", 05:32:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:32:46 INFO - "repository": "", 05:32:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:32:46 INFO - "buildid": "20170428040924", 05:32:46 INFO - "pgo_build": "False", 05:32:46 INFO - "basedir": "/builds/slave/test", 05:32:46 INFO - "buildnumber": 129, 05:32:46 INFO - "slavename": "t-yosemite-r7-0214", 05:32:46 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:32:46 INFO - "platform": "yosemite_r7", 05:32:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:32:46 INFO - "branch": "mozilla-central", 05:32:46 INFO - "repo_path": "mozilla-central", 05:32:46 INFO - "revision": "d19b88fdf81d7dff1ac2ffcec4084eee7d666d11", 05:32:46 INFO - "stage_platform": "macosx64", 05:32:46 INFO - "builduid": "ee014cb5555e4354b63599a97ea8fca8", 05:32:46 INFO - "slavebuilddir": "test" 05:32:46 INFO - } 05:32:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:32:46 INFO - Running post-action listener: _resource_record_post_action 05:32:46 INFO - [mozharness: 2017-04-28 12:32:46.457888Z] Finished read-buildbot-config step (success) 05:32:46 INFO - [mozharness: 2017-04-28 12:32:46.458108Z] Running download-and-extract step. 05:32:46 INFO - Running pre-action listener: _resource_record_pre_action 05:32:46 INFO - Running main action method: download_and_extract 05:32:46 INFO - mkdir: /builds/slave/test/build/tests 05:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:46 INFO - trying https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:32:47 INFO - Downloaded 1325 bytes. 05:32:47 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:32:47 INFO - Using the following test package requirements: 05:32:47 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:32:47 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:32:47 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:32:47 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:32:47 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'jsshell-mac.zip'], 05:32:47 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:32:47 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:32:47 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:32:47 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:32:47 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:32:47 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:32:47 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:32:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:32:49 INFO - Content-Length response header: 52695500 05:32:49 INFO - Bytes received: 52695500 05:33:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:33:07 INFO - Content-Length response header: 52695500 05:33:07 INFO - Bytes received: 52695500 05:33:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:33:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:33:22 INFO - Fetch https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:33:23 INFO - Content-Length response header: 14408809 05:33:23 INFO - Bytes received: 14408809 05:33: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')]} 05:33:23 INFO - trying https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:33:23 INFO - Downloading https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:33:25 INFO - Downloaded 71219873 bytes. 05:33:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:33:25 INFO - mkdir: /builds/slave/test/properties 05:33:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:25 INFO - Contents: 05:33:25 INFO - build_url:https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:33:26 INFO - Running post-action listener: _resource_record_post_action 05:33:26 INFO - Running post-action listener: set_extra_try_arguments 05:33:26 INFO - [mozharness: 2017-04-28 12:33:26.688285Z] Finished download-and-extract step (success) 05:33:26 INFO - [mozharness: 2017-04-28 12:33:26.688431Z] Running populate-webroot step. 05:33:26 INFO - Running pre-action listener: _resource_record_pre_action 05:33:26 INFO - Running main action method: populate_webroot 05:33:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:26 INFO - '--tppagecycles', 05:33:26 INFO - '7'], 05:33:26 INFO - 'tests': ['tsvgm']}}, 05:33:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:33:26 INFO - 'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:33:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:33:26 INFO - 'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['damp', 'tps']}, 05:33:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:33:26 INFO - 'tests': ['damp', 'tps']}, 05:33:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['dromaeo_dom']}, 05:33:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:33:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:33:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['a11yr', 05:33:26 INFO - 'ts_paint', 05:33:26 INFO - 'tpaint', 05:33:26 INFO - 'sessionrestore', 05:33:26 INFO - 'sessionrestore_no_auto_restore', 05:33:26 INFO - 'tabpaint']}, 05:33:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:26 INFO - 'ts_paint', 05:33:26 INFO - 'tpaint', 05:33:26 INFO - 'sessionrestore', 05:33:26 INFO - 'sessionrestore_no_auto_restore', 05:33:26 INFO - 'tabpaint']}, 05:33:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:33:26 INFO - 'ts_paint', 05:33:26 INFO - 'tpaint', 05:33:26 INFO - 'sessionrestore', 05:33:26 INFO - 'sessionrestore_no_auto_restore', 05:33:26 INFO - 'tabpaint']}, 05:33:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:33:26 INFO - 'ts_paint', 05:33:26 INFO - 'tpaint', 05:33:26 INFO - 'sessionrestore', 05:33:26 INFO - 'sessionrestore_no_auto_restore', 05:33:26 INFO - 'tabpaint']}, 05:33:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['a11yr', 05:33:26 INFO - 'ts_paint', 05:33:26 INFO - 'tpaint', 05:33:26 INFO - 'sessionrestore', 05:33:26 INFO - 'sessionrestore_no_auto_restore', 05:33:26 INFO - 'tabpaint']}, 05:33:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['a11yr', 05:33:26 INFO - 'ts_paint', 05:33:26 INFO - 'tpaint', 05:33:26 INFO - 'sessionrestore', 05:33:26 INFO - 'sessionrestore_no_auto_restore', 05:33:26 INFO - 'tabpaint']}, 05:33:26 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:33:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:33:26 INFO - 'bloom_basic_ref']}, 05:33:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['tsvgx', 05:33:26 INFO - 'tsvgr_opacity', 05:33:26 INFO - 'tart', 05:33:26 INFO - 'tscrollx', 05:33:26 INFO - 'cart', 05:33:26 INFO - 'tsvg_static']}, 05:33:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:26 INFO - 'tsvgr_opacity', 05:33:26 INFO - 'tart', 05:33:26 INFO - 'tscrollx', 05:33:26 INFO - 'cart', 05:33:26 INFO - 'tsvg_static']}, 05:33:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:33:26 INFO - 'talos_options': ['--disable-e10s'], 05:33:26 INFO - 'tests': ['tp5o']}, 05:33:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:33:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:33:26 INFO - 'talos_options': ['--disable-e10s', 05:33:26 INFO - '--xperf_path', 05:33:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:26 INFO - 'tests': ['tp5n']}, 05:33:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:33:26 INFO - 'talos_options': ['--xperf_path', 05:33:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:26 INFO - 'tests': ['tp5n']}}, 05:33:26 INFO - 'talos.zip': {'path': '', 05:33:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:26 INFO - Running post-action listener: _resource_record_post_action 05:33:26 INFO - [mozharness: 2017-04-28 12:33:26.707541Z] Finished populate-webroot step (success) 05:33:26 INFO - [mozharness: 2017-04-28 12:33:26.707673Z] Running create-virtualenv step. 05:33:26 INFO - Running pre-action listener: _resource_record_pre_action 05:33:26 INFO - Running main action method: create_virtualenv 05:33:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:26 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 05:33:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:26 INFO - Using real prefix '/tools/python27' 05:33:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:30 INFO - Installing pip.................done. 05:33:30 INFO - Return code: 0 05:33:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:33:30 INFO - Reading from file tmpfile_stdout 05:33:30 INFO - Output received: 05:33:30 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) 05:33:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33: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', 'pip>=1.5'] in /builds/slave/test/build 05:33: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 pip>=1.5 05:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:30 INFO - 'HOME': '/Users/cltbld', 05:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:30 INFO - 'LOGNAME': 'cltbld', 05:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:30 INFO - 'MOZ_NO_REMOTE': '1', 05:33:30 INFO - 'NO_EM_RESTART': '1', 05:33:30 INFO - 'PAGER': '/bin/cat', 05:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:30 INFO - 'PWD': '/builds/slave/test', 05:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:30 INFO - 'SHELL': '/bin/bash', 05:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:30 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:30 INFO - 'USER': 'cltbld', 05:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:30 INFO - 'XPC_FLAGS': '0x0', 05:33:30 INFO - 'XPC_SERVICE_NAME': '0', 05:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:30 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 05:33:30 INFO - Cleaning up... 05:33:30 INFO - Return code: 0 05:33:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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', '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 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:33: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 psutil>=3.1.1 05:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:30 INFO - 'HOME': '/Users/cltbld', 05:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:30 INFO - 'LOGNAME': 'cltbld', 05:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:30 INFO - 'MOZ_NO_REMOTE': '1', 05:33:30 INFO - 'NO_EM_RESTART': '1', 05:33:30 INFO - 'PAGER': '/bin/cat', 05:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:30 INFO - 'PWD': '/builds/slave/test', 05:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:30 INFO - 'SHELL': '/bin/bash', 05:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:30 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:30 INFO - 'USER': 'cltbld', 05:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:30 INFO - 'XPC_FLAGS': '0x0', 05:33:30 INFO - 'XPC_SERVICE_NAME': '0', 05:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:31 INFO - Downloading/unpacking psutil>=3.1.1 05:33:31 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 05:33:31 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 05:33:31 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 05:33:31 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 05:33:31 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 05:33:31 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 05:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:34 INFO - Installing collected packages: psutil 05:33:34 INFO - Running setup.py install for psutil 05:33:34 INFO - building 'psutil._psutil_osx' extension 05:33:34 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 05:33:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:33:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:33:35 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 05:33:35 INFO - building 'psutil._psutil_posix' extension 05:33:35 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 05:33:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:33:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:33:35 INFO - ^ 05:33:35 INFO - 1 warning generated. 05:33:35 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 05:33:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:35 INFO - Successfully installed psutil 05:33:35 INFO - Cleaning up... 05:33:35 INFO - Return code: 0 05:33:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:35 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 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:35 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 05:33:35 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 05:33:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:35 INFO - 'HOME': '/Users/cltbld', 05:33:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:35 INFO - 'LOGNAME': 'cltbld', 05:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:35 INFO - 'MOZ_NO_REMOTE': '1', 05:33:35 INFO - 'NO_EM_RESTART': '1', 05:33:35 INFO - 'PAGER': '/bin/cat', 05:33:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:35 INFO - 'PWD': '/builds/slave/test', 05:33:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:35 INFO - 'SHELL': '/bin/bash', 05:33:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:35 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:35 INFO - 'USER': 'cltbld', 05:33:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:35 INFO - 'XPC_FLAGS': '0x0', 05:33:35 INFO - 'XPC_SERVICE_NAME': '0', 05:33:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:38 INFO - Installing collected packages: mozsystemmonitor 05:33:38 INFO - Running setup.py install for mozsystemmonitor 05:33:39 INFO - Successfully installed mozsystemmonitor 05:33:39 INFO - Cleaning up... 05:33:39 INFO - Return code: 0 05:33:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:39 INFO - 'HOME': '/Users/cltbld', 05:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:39 INFO - 'LOGNAME': 'cltbld', 05:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:39 INFO - 'MOZ_NO_REMOTE': '1', 05:33:39 INFO - 'NO_EM_RESTART': '1', 05:33:39 INFO - 'PAGER': '/bin/cat', 05:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:39 INFO - 'PWD': '/builds/slave/test', 05:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:39 INFO - 'SHELL': '/bin/bash', 05:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:39 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:39 INFO - 'USER': 'cltbld', 05:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:39 INFO - 'XPC_FLAGS': '0x0', 05:33:39 INFO - 'XPC_SERVICE_NAME': '0', 05:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:43 INFO - warning: no files found matching '*.txt' 05:33:43 INFO - no previously-included directories found matching 'build' 05:33:43 INFO - no previously-included directories found matching 'dist' 05:33:43 INFO - no previously-included directories found matching '.git*' 05:33:43 INFO - Installing collected packages: jsonschema, functools32 05:33:43 INFO - Running setup.py install for functools32 05:33:43 INFO - warning: no files found matching '*.txt' 05:33:43 INFO - no previously-included directories found matching 'build' 05:33:43 INFO - no previously-included directories found matching 'dist' 05:33:43 INFO - no previously-included directories found matching '.git*' 05:33:43 INFO - Successfully installed jsonschema functools32 05:33:43 INFO - Cleaning up... 05:33:43 INFO - Return code: 0 05:33:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:43 INFO - 'HOME': '/Users/cltbld', 05:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:43 INFO - 'LOGNAME': 'cltbld', 05:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:43 INFO - 'MOZ_NO_REMOTE': '1', 05:33:43 INFO - 'NO_EM_RESTART': '1', 05:33:43 INFO - 'PAGER': '/bin/cat', 05:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:43 INFO - 'PWD': '/builds/slave/test', 05:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:43 INFO - 'SHELL': '/bin/bash', 05:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:43 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:43 INFO - 'USER': 'cltbld', 05:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:43 INFO - 'XPC_FLAGS': '0x0', 05:33:43 INFO - 'XPC_SERVICE_NAME': '0', 05:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:44 INFO - Cleaning up... 05:33:44 INFO - Return code: 0 05:33:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:44 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 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:44 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 05:33:44 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 05:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:44 INFO - 'HOME': '/Users/cltbld', 05:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:44 INFO - 'LOGNAME': 'cltbld', 05:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:44 INFO - 'MOZ_NO_REMOTE': '1', 05:33:44 INFO - 'NO_EM_RESTART': '1', 05:33:44 INFO - 'PAGER': '/bin/cat', 05:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:44 INFO - 'PWD': '/builds/slave/test', 05:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:44 INFO - 'SHELL': '/bin/bash', 05:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:44 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:44 INFO - 'USER': 'cltbld', 05:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:44 INFO - 'XPC_FLAGS': '0x0', 05:33:44 INFO - 'XPC_SERVICE_NAME': '0', 05:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:48 INFO - Downloading docopt-0.6.1.tar.gz 05:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:48 INFO - Running setup.py install for blobuploader 05:33:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:48 INFO - Running setup.py install for requests 05:33:49 INFO - Running setup.py install for docopt 05:33:49 INFO - Successfully installed blobuploader requests docopt 05:33:49 INFO - Cleaning up... 05:33:49 INFO - Return code: 0 05:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:49 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')]} 05:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:49 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')]} 05:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:49 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 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:49 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 05:33:49 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 05:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:49 INFO - 'HOME': '/Users/cltbld', 05:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:49 INFO - 'LOGNAME': 'cltbld', 05:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:49 INFO - 'MOZ_NO_REMOTE': '1', 05:33:49 INFO - 'NO_EM_RESTART': '1', 05:33:49 INFO - 'PAGER': '/bin/cat', 05:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:49 INFO - 'PWD': '/builds/slave/test', 05:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:49 INFO - 'SHELL': '/bin/bash', 05:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:49 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:49 INFO - 'USER': 'cltbld', 05:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:49 INFO - 'XPC_FLAGS': '0x0', 05:33:49 INFO - 'XPC_SERVICE_NAME': '0', 05:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-4VeWbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-UwE8Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-OA3tGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uBNs3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:49 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-cIiXGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-5wDNbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-onbcWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-lkbDb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ckowBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-m8YtB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-bE5J4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-09ijqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-K8I7oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JbGa59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:50 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-cqE5eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:51 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ESZxi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:51 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-78wMxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:51 INFO - Running setup.py install for manifestparser 05:33:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:51 INFO - Running setup.py install for mozcrash 05:33:51 INFO - Running setup.py install for mozdebug 05:33:51 INFO - Running setup.py install for mozdevice 05:33:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:51 INFO - Running setup.py install for mozfile 05:33:51 INFO - Running setup.py install for mozhttpd 05:33:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Running setup.py install for mozinfo 05:33:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Running setup.py install for mozInstall 05:33:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Running setup.py install for mozleak 05:33:52 INFO - Running setup.py install for mozlog 05:33:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Running setup.py install for moznetwork 05:33:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:52 INFO - Running setup.py install for mozprocess 05:33:53 INFO - Running setup.py install for mozprofile 05:33:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:53 INFO - Running setup.py install for mozrunner 05:33:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:53 INFO - Running setup.py install for mozscreenshot 05:33:53 INFO - Running setup.py install for moztest 05:33:53 INFO - Running setup.py install for mozversion 05:33:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:53 INFO - Cleaning up... 05:33:53 INFO - Return code: 0 05:33:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:53 INFO - 'HOME': '/Users/cltbld', 05:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:53 INFO - 'LOGNAME': 'cltbld', 05:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:53 INFO - 'MOZ_NO_REMOTE': '1', 05:33:53 INFO - 'NO_EM_RESTART': '1', 05:33:53 INFO - 'PAGER': '/bin/cat', 05:33:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:53 INFO - 'PWD': '/builds/slave/test', 05:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:53 INFO - 'SHELL': '/bin/bash', 05:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:53 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:53 INFO - 'USER': 'cltbld', 05:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:53 INFO - 'XPC_FLAGS': '0x0', 05:33:53 INFO - 'XPC_SERVICE_NAME': '0', 05:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Q44FoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:54 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)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-GvsTk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:54 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)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-fU8is_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uolveE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uGef1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ZlvLzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-GzwxSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-O0rXUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:54 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-m3KuGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:55 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)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-EIy0Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:55 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)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Y0NxKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:55 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)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-kgIsPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-K4R_9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JET4Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Ii5jzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-cQfKL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:55 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-OXGrqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:58 INFO - Downloading blessings-1.6.tar.gz 05:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:58 INFO - Installing collected packages: blessings 05:33:58 INFO - Running setup.py install for blessings 05:33:58 INFO - Successfully installed blessings 05:33:58 INFO - Cleaning up... 05:33:58 INFO - Return code: 0 05:33:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:59 INFO - Reading from file tmpfile_stdout 05:33:59 INFO - Current package versions: 05:33:59 INFO - blessings == 1.6 05:33:59 INFO - blobuploader == 1.2.4 05:33:59 INFO - docopt == 0.6.1 05:33:59 INFO - functools32 == 3.2.3-2 05:33:59 INFO - jsonschema == 2.5.1 05:33:59 INFO - manifestparser == 1.1 05:33:59 INFO - mozInstall == 1.12 05:33:59 INFO - mozcrash == 1.0 05:33:59 INFO - mozdebug == 0.1 05:33:59 INFO - mozdevice == 0.50 05:33:59 INFO - mozfile == 1.2 05:33:59 INFO - mozhttpd == 0.7 05:33:59 INFO - mozinfo == 0.9 05:33:59 INFO - mozleak == 0.1 05:33:59 INFO - mozlog == 3.4 05:33:59 INFO - moznetwork == 0.27 05:33:59 INFO - mozprocess == 0.25 05:33:59 INFO - mozprofile == 0.28 05:33:59 INFO - mozrunner == 6.13 05:33:59 INFO - mozscreenshot == 0.1 05:33:59 INFO - mozsystemmonitor == 0.3 05:33:59 INFO - moztest == 0.8 05:33:59 INFO - mozversion == 1.4 05:33:59 INFO - psutil == 3.1.1 05:33:59 INFO - requests == 1.2.3 05:33:59 INFO - wsgiref == 0.1.2 05:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:59 INFO - 'HOME': '/Users/cltbld', 05:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:59 INFO - 'LOGNAME': 'cltbld', 05:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:59 INFO - 'MOZ_NO_REMOTE': '1', 05:33:59 INFO - 'NO_EM_RESTART': '1', 05:33:59 INFO - 'PAGER': '/bin/cat', 05:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:59 INFO - 'PWD': '/builds/slave/test', 05:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:59 INFO - 'SHELL': '/bin/bash', 05:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:59 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:59 INFO - 'USER': 'cltbld', 05:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:59 INFO - 'XPC_FLAGS': '0x0', 05:33:59 INFO - 'XPC_SERVICE_NAME': '0', 05:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:59 INFO - Cleaning up... 05:33:59 INFO - Return code: 0 05:33:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:59 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 0x106aefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106af2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd932465d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, '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.zUT56RqnoC/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.ifNe4OzgvV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:33:59 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 05:33:59 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 05:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:59 INFO - 'HOME': '/Users/cltbld', 05:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:59 INFO - 'LOGNAME': 'cltbld', 05:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:59 INFO - 'MOZ_NO_REMOTE': '1', 05:33:59 INFO - 'NO_EM_RESTART': '1', 05:33:59 INFO - 'PAGER': '/bin/cat', 05:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:59 INFO - 'PWD': '/builds/slave/test', 05:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:59 INFO - 'SHELL': '/bin/bash', 05:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:33:59 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:59 INFO - 'USER': 'cltbld', 05:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:59 INFO - 'XPC_FLAGS': '0x0', 05:33:59 INFO - 'XPC_SERVICE_NAME': '0', 05:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:59 INFO - Cleaning up... 05:33:59 INFO - Return code: 0 05:33:59 INFO - Running post-action listener: _resource_record_post_action 05:33:59 INFO - Running post-action listener: _start_resource_monitoring 05:33:59 INFO - Starting resource monitoring. 05:33:59 INFO - [mozharness: 2017-04-28 12:33:59.666847Z] Finished create-virtualenv step (success) 05:33:59 INFO - [mozharness: 2017-04-28 12:33:59.667839Z] Running install step. 05:33:59 INFO - Running pre-action listener: _resource_record_pre_action 05:33:59 INFO - Running main action method: install 05:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:59 INFO - Reading from file tmpfile_stdout 05:33:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:34:00 INFO - Reading from file tmpfile_stdout 05:34:00 INFO - Output received: 05:34:00 INFO - Usage: mozinstall [options] installer 05:34:00 INFO - Options: 05:34:00 INFO - -h, --help show this help message and exit 05:34:00 INFO - -d DEST, --destination=DEST 05:34:00 INFO - Directory to install application into. [default: 05:34:00 INFO - "/builds/slave/test"] 05:34:00 INFO - --app=APP Application being installed. [default: firefox] 05:34:00 INFO - mkdir: /builds/slave/test/build/application 05:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:34:20 INFO - Reading from file tmpfile_stdout 05:34:20 INFO - Output received: 05:34:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:34:20 INFO - Running post-action listener: _resource_record_post_action 05:34:20 INFO - [mozharness: 2017-04-28 12:34:20.015096Z] Finished install step (success) 05:34:20 INFO - [mozharness: 2017-04-28 12:34:20.015317Z] Running run-tests step. 05:34:20 INFO - Running pre-action listener: _resource_record_pre_action 05:34:20 INFO - Running main action method: run_tests 05:34:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:20 INFO - 2017-04-28 05:34:20.030 screenresolution[1621:7427] starting screenresolution argv=screenresolution get 05:34:20 INFO - 2017-04-28 05:34:20.032 screenresolution[1621:7427] Display 0: 1600x1200x32@60 05:34:20 INFO - 2017-04-28 05:34:20.038 screenresolution[1622:7429] starting screenresolution argv=screenresolution list 05:34:20 INFO - Available Modes on Display 0 05:34:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:20 INFO - Intel Iris: 05:34:20 INFO - Chipset Model: Intel Iris 05:34:20 INFO - Type: GPU 05:34:20 INFO - Bus: Built-In 05:34:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:34:20 INFO - Vendor: Intel (0x8086) 05:34:20 INFO - Device ID: 0x0a2e 05:34:20 INFO - Revision ID: 0x0009 05:34:20 INFO - Displays: 05:34:20 INFO - Display: 05:34:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:20 INFO - Display Serial Number: 1600x1200 60 05:34:20 INFO - Main Display: Yes 05:34:20 INFO - Mirror: Off 05:34:20 INFO - Online: Yes 05:34:20 INFO - Rotation: Supported 05:34:20 INFO - Return code: 0 05:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:34:20 INFO - Python 2.7.3 05:34:20 INFO - Return code: 0 05:34:20 INFO - grabbing minidump binary from tooltool 05:34:20 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')]} 05:34:20 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 0x1068cdd30>, '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 0x1067f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:34:20 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 05:34:20 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 05:34:20 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 05:34:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:20 INFO - Return code: 0 05:34:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:34:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:34:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:34:20 INFO - ENV: RUST_BACKTRACE is now 1 05:34:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:34:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:34:20 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/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:34:20 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/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUT56RqnoC/Render', 05:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:20 INFO - 'HOME': '/Users/cltbld', 05:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:20 INFO - 'LOGNAME': 'cltbld', 05:34:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:34:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:20 INFO - 'MOZ_NO_REMOTE': '1', 05:34:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:34:20 INFO - 'NO_EM_RESTART': '1', 05:34:20 INFO - 'PAGER': '/bin/cat', 05:34:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:20 INFO - 'PWD': '/builds/slave/test', 05:34:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:20 INFO - 'RUST_BACKTRACE': '1', 05:34:20 INFO - 'SHELL': '/bin/bash', 05:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ifNe4OzgvV/Listeners', 05:34:20 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 05:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:20 INFO - 'USER': 'cltbld', 05:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:20 INFO - 'XPC_FLAGS': '0x0', 05:34:20 INFO - 'XPC_SERVICE_NAME': '0', 05:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:20 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/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:34:20 INFO - mozversion application_buildid: 20170428040924 05:34:20 INFO - mozversion application_changeset: d19b88fdf81d7dff1ac2ffcec4084eee7d666d11 05:34:20 INFO - mozversion application_display_name: Nightly 05:34:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:20 INFO - mozversion application_name: Firefox 05:34:20 INFO - mozversion application_remotingname: firefox 05:34:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:34:20 INFO - mozversion application_vendor: Mozilla 05:34:20 INFO - mozversion application_version: 55.0a1 05:34:20 INFO - mozversion platform_buildid: 20170428040924 05:34:20 INFO - mozversion platform_changeset: d19b88fdf81d7dff1ac2ffcec4084eee7d666d11 05:34:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:34:20 INFO - mozversion platform_version: 55.0a1 05:34:20 INFO - using testdate: 1493382860 05:34:20 INFO - actual date: 1493382860 05:34:20 INFO - starting webserver on 'localhost:49234' 05:34:20 INFO - SUITE-START | Running 2 tests 05:34:20 INFO - TEST-START | dromaeo_css 05:34:20 INFO - operating with platform_type : mac_ 05:34:20 INFO - Initialising browser for dromaeo_css test... 05:34:20 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpzqG3U7/profile http://localhost:49234/getInfo.html) 05:34:23 INFO - PID 1632 | 2017-04-28 05:34:23.185 plugin-container[1634:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 05:34:23 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:34:23 INFO - PID 1632 | 2017-04-28 05:34:23.187 plugin-container[1634:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 05:34:23 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:34:23 INFO - PID 1632 | 2017-04-28 05:34:23.187 plugin-container[1634:7612] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:34:23 INFO - PID 1632 | __metrics Screen width/height:1600/1200 05:34:23 INFO - PID 1632 | colorDepth:24 05:34:23 INFO - PID 1632 | Browser inner width/height: 1024/689 05:34:23 INFO - PID 1632 | __metrics 05:34:23 ERROR - PID 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 05:34:24 INFO - TEST-INFO | 1632: exit 0 05:34:24 INFO - Browser initialized. 05:34:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:24 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpzqG3U7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:26 INFO - PID 1635 | 2017-04-28 05:34:26.765 plugin-container[1636:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 05:34:26 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:34:26 INFO - PID 1635 | 2017-04-28 05:34:26.766 plugin-container[1636:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 05:34:26 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:34:26 INFO - PID 1635 | 2017-04-28 05:34:26.766 plugin-container[1636:7753] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:34:36 INFO - PID 1635 | RSS: Main: 251056128 05:34:36 INFO - PID 1635 | 05:37:41 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 05:37:43 INFO - PID 1635 | RSS: Main: 252981248 05:37:43 INFO - PID 1635 | 05:39:25 INFO - PID 1635 | ************************* 05:39:25 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:39:25 INFO - PID 1635 | 05:39:25 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:39:25 INFO - PID 1635 | Full stack: 05:39:25 INFO - PID 1635 | ************************* 05:39:25 INFO - PID 1635 | ************************* 05:39:25 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:39:25 INFO - PID 1635 | 05:39:25 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:39:25 INFO - PID 1635 | Full stack: 05:39:25 INFO - PID 1635 | ************************* 05:39:25 INFO - PID 1635 | ************************* 05:39:25 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:39:25 INFO - PID 1635 | 05:39:25 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:39:25 INFO - PID 1635 | Full stack: 05:39:25 INFO - PID 1635 | ************************* 05:39:25 INFO - PID 1635 | ************************* 05:39:25 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:39:25 INFO - PID 1635 | 05:39:25 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:39:25 INFO - PID 1635 | Full stack: 05:39:25 INFO - PID 1635 | ************************* 05:40:45 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 05:40:46 INFO - PID 1635 | RSS: Main: 258244608 05:40:46 INFO - PID 1635 | 05:43:47 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 05:43:48 INFO - PID 1635 | RSS: Main: 267132928 05:43:48 INFO - PID 1635 | 05:46:50 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 05:46:50 INFO - PID 1635 | RSS: Main: 259719168 05:46:50 INFO - PID 1635 | 05:49:53 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 05:49:54 INFO - PID 1635 | RSS: Main: 268693504 05:49:54 INFO - PID 1635 | 05:52:55 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 05:52:56 INFO - PID 1635 | RSS: Main: 263450624 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | __start_tp_report 05:52:56 INFO - PID 1635 | _x_x_mozilla_page_load 05:52:56 INFO - PID 1635 | _x_x_mozilla_page_load_details 05:52:56 INFO - PID 1635 | |i|pagename|runs| 05:52:56 INFO - PID 1635 | |0;dojo.html;3564.7682900611444;3577.856885724571;3581.480685300633;3617.819109044547;3624.6556577125166;4254.978725106378;6224.782132625353;6272.686365681715;6279.968600156999;6372.394622510866;6105.06553558391;6157.291911430187;6242.687865606724;6244.812655620327;6258.342873998233;3942.2903877302074;5405.00007498612;5437.429069947658;5453.972730136364;5466.671999680012;5489.58828087893;5569.944300557004;5571.275734154575;5599;5610.523105536014;5339.5194432500875;5477.589180811455;5491.615586908918;5539.196816461611;5560.555155587564;5371.462853714636;5384.5692344612335;5392.379876314235;5394.541463975567;5410.891782164374;5380.757865896005;5429.511343979021;5439.646422982533;5451.236826844245;5485.424030476783;6114.724837382284;6245.87508249837;6262.968685156545;6308.684565771693;6309.684515774239;6625.503087268474;6672.599644021374;6692.966535167293;6706.161729783777;6729.091572637729;6446;6545.410913017804;6589.7034633441135;6678.732850685967;6775.3902148806355;6276.717547710364;6338;6345.270293916259;6346.143270658495;6352.301246862841;5708.514776243983;6690.962900750392;6948.44412447003;6952.791416257521;6976.7558135465015;6357.650329231937;6389.6805159741825;6460.450861676716;6518.478521718346;6566.901496477557;6666.866662666816;6727.327267273331;6769.153855768029;6772.8984065239065;6790.456763458911;6551.737930482823;6609.801705948829;6630.933690663128;6633.2703402625675;6637.369449902251;6333.68331583419;6426.74293028283;6463;6637.103990961158;6650.70071846768;5269.55208807248;5322.9088036952335;5326.92009619856;5337.306150200449;5369.785208591613;4036.8990775230855;4673.948361618676;4738.502457242009;4740.099381117577;4766.761661916959;5141.9742901286;5938.228030356113;6181.907271390933;6349.206349206349;6378.362163783678;6635.568688035262;6695.363940425652;6745.898811517831;6765.763198288135;6824.351686589766;6315.905261421082;6360.650164241011;6361.681915904186;6362.236531616236;6390.169277993924;5940.287165540077;5958.314793798682;5971.0744834550715;5975.223220981332;5979.073243647242;6645.700943457653;6846.144231971004;6935.583864968118;6971.058907047483;7008.579485230903;6741.966290168518;6798.52410331272;6817.795466136024;6819.318068193141;6847.07564478789;6962.512624116263;6970.059042029261;7026.754063607749;7030.121234845645;7044.225135235222;6387.425131738166;6505.674716264262;6578.934210657832;6676.532642714963;6691.5650482718465;6775.051492791112;6798.592084474947;6802.761903333359;6808.897866531907;6812.965935170292;6336;6423.779481898424;6590.340965903371;6599.835004124935;6614.867702645824;5142.51146141116;6563.638999855054;6572.277049524644;6577.210734711865;6579.17760279965;6188.690565471618;6206.472449841814;6270.7805226816845;6349.714262858275;6377.7767778127545;6499.902501462388;6517.283098859217;6573.276939536551;6602.306757790555;6608.339166083353;6348.936510634834;6384.361563843579;6384.840378990562;6389;6401.711922963571 05:52:56 INFO - PID 1635 | |1;ext.html;739.9381886992167;781.519365590162;826.4793180296414;1197.2816310213873;1252.2736812648666;35776.28447431053;37138.81430592846;37157.07107322318;37169.442458363075;37191.814040929756;37434.812825935835;37522.62477375226;37829.621703782956;37874.8106259469;37900.43149352762;7811.531308121516;7950.1254861965135;8245.628946697412;8474.661013559451;8499.957500212491;8470.98348198217;8518.23335899769;8562.743117706448;8598.355123365742;8610.56947152643;8540.74377768668;8561.828763424728;8621.482711037357;8623;8625.309975202;7015.684294206773;8565.828683426327;8597.398182127254;8598.828023439497;8607.999999999969;8350.540720260384;8400.907881975305;8420.326373890073;8431.83136337276;8437.282830959375;36554.451683224775;36728.71449499255;36731.63268367336;36741.26517469662;36823.631763682555;3638.872639457633;3641.745077844552;3686.5760437549757;3687.0966613179944;3689.206820533598;27397.45205095907;27727.92040596943;30388.392232155235;30532;30538.389232215453;3074.9077527674203;3153.8107713537033;3155.7159855612877;3167.224030112637;3180.745540356766;291527.5423622868;295211;299437;307020.9297907015;309958;38346.616533834866;47879.5212047882;48006.75996620065;48100.759496203;48149.75925120422;48168.518314817105;49934.25098623524;50217.99564008699;51118.74440627773;51159.7442012795;14106.435742570182;14215.928920355538;14226.715465690628;14244.07413518118;14264.643383915485;11449.828252576219;11457.770844583061;11459.025982791556;11461.140414468948;11481.598144064918;13179.538716144889;13285.867141328463;13290.73418531624;13302.002349823802;13390.464381424634;6000.939990600038;6036.094585812163;6051.7579296827635;6063;6074;993.8062077894741;1009.4448053570507;1017.3336464615688;1043.1446214104512;1044.1646682653848;19334.90950350635;22429.551408972056;24302.87848560746;24309.878450607986;24380.268591941916;1118.1222740148944;1118.1725523112839;1151.8560179977503;1152.7924973504682;1154.9653510394533;11253.94373028146;12410.255384676948;13324.933375333061;16077.678446431006;16112.274947627386;283331;330377;331222;336286;337452;55898.44101558932;56045.43954560484;56230.71884640551;56336.154957675666;56422.717886410304;1467.2150399536197;1496.513633069257;1540.7149677309733;1544.7682847572953;1555.0902721907585;25622;27777;28049.298767530974;30040.399192016474;30135.547966780076;34838.65161348354;36248.55005799738;38715.80642096772;38811;39111;304793;304909.9509004882;305060;305078;306088;32476;33914.830425847715;33936.490952635235;34009.65990340065;34096;41567.01195856516;43901.78049109734;44009;44042.559574405124;44045.77977110094;28106.43787124287;28608.57087143736;29966.550501742928;30662.693373065984;30795.538066928566;29837.254068648457;30412.69587304187;30651;30693.079207623807;30726.539101913935;36640;36664;36692.81653591715;36808.44787328246;36831.89504314875;28588.857055714587;28744.856275718488;29588.816447342728;29837.10488685343;31018.0694579163;22538;24281;24290;24354.269371918872;24543.50912981766 05:52:56 INFO - PID 1635 | |2;jquery.html;396.54793535369663;423.4030017675077;425.7892343290072;449.438202247191;456.85152325494215;19828.60342793145;21301.57396852062;22030.779692203094;22051.66922496164;22266.88866555665;21905.890470547663;22465;23115.768842311572;23306.970093887812;23558.29325120245;6064.848378790522;6210.534209934273;6277.278113017016;6282.308946015934;6284.71718772654;5872.530197584204;6123.11214873843;6142.416470435302;6181.536384771138;6213.533984951124;5885.5585831062845;6069.969650151766;6160.476359509447;6161.414665606782;6166.136740856284;6077.604955677889;6104.328523862371;6116.357782432825;6151.5386346024225;6162.568620196588;5139.203423469368;5285.762140703678;5345.3585569731495;5452.154915988028;5459.989901868167;26766.33084172892;27095.864520677467;27542;27657.44685106307;27692.30769230765;2173.4566358410398;2222.14447437736;2240.7311122665224;2246.831487638434;2248.5840119577765;17634.91182544079;17802.109894505353;17806;18391.172397242157;18659.906700466545;2138.754043285011;2152.720146380976;2190.4742861713075;2191.6931629571873;2191.747948985871;163024;166989;168110;168975.46536801834;169649.3035069658;12621.74756504883;12696.047796415121;12864.976730468332;12938.90019348366;13066.869331306565;16300.429484968206;16446;16446.83553164477;16504.25730842115;16547.669046619;7229.819254518574;7406.814829629302;8209.753707388787;8908.5991130398;9211.40125891815;8554.35842311829;8572.228499435081;8574.528400937883;8666.133386661284;8722.738317850475;6432.453241474527;6601.768938087144;7520.398368130536;7878.803029924183;7978.162292959156;2185.278857976896;2196.176433837311;2205.735311762599;2206.9448263793533;2344.874460259085;828.8093738440192;969.8254314223508;990.5667414232927;1002.2633364477103;1012.7063151685928;21040.263590774248;21421.357359279245;21571.57782654552;25671;27679.723202768117;1026.1021606094666;1027.686555600549;1032.6385764982197;1051.4217180550665;1062.0919114157439;10925.890741092488;12083.918600756751;13195.868041319463;13827.446902124004;14270.001099923113;490118;568508;572032;579722;581537;130346;136285;139081.30459347638;139118.04409779672;142598;1209.564556759566;1231.8275441438207;1248.5630029489787;1258.2010423381219;1260.24385368778;19023;21166.78833211648;22498.987545560816;22707.88646056759;23172.3048308551;57057.714711426175;59740.70129649324;59903.70048149906;61308.386916130265;61993.45016374627;84738.57630711807;85685;88047.79880503038;88244.5587772057;88999;7997.7600671979935;8965.865512017195;9149.862752058858;9182.95408522953;9249;14031.649208769863;14602.488912887999;14685.339159737623;15008.47470338533;15129.773053404428;11619;12152.635420937386;12226.633201003984;12411.379431028594;12468.5012599495;11686.474108664961;11951.191470004369;12048.698782530508;12186.756264874475;12193.69515762113;12363.69090772738;12381.595061358199;12506.062045346818;12650.557230496888;12661.683457913627;8846.513441760508;9161.221296189631;9195.724128276162;9264.629414823601;9308.208802251884;11539.596114135966;11883.702907427383;12102.75794484123;12123.393830308272;12167.330796805907 05:52:56 INFO - PID 1635 | |3;mootools.html;1447.3342262559222;1489.2181604657553;1494.5665756930491;1509.064380084348;1522.1399909051386;11159.939805718453;11454.48454819533;11658.825117623242;11677.941610291948;11794.882051179486;11482.425878706073;11660.708482287948;11676.124290678212;11679.474423650934;11680;2482.9627555586635;2521.621756736486;2522.2811498722867;2531.3671582104475;2538.7588179122954;2468.419921318489;2506.385935445818;2530.1903390914913;2532.3669082729316;2538.1877799104295;2485.652008718781;2515.735847735989;2515.937101572466;2541.872906354684;2543.300592337104;2449.2774631483667;2481.019997101153;2494.3514686181543;2496.987515062431;2502.637117617944;2458.5820410530073;2493.9750602494105;2495.401103735109;2495.4135778092314;2507.5862482690336;11490.310581365145;11576.826347604792;11696.766064678659;11709;11719.355435451047;5987.652778124931;6395.904061439082;6540.93459065408;6741.730330786762;6763.425108865752;3978.5026871641044;4287.849925252633;4367.825286988516;4373.934390984138;4377.868663940055;1103.6578660615235;1235.5552001279623;1249.868763779799;1304.269609018943;1311.3050083455785;15607.609809754733;16147.83852161475;16152.353905843753;16391.754123688155;16469.58826029359;5859.94140058594;6015.187949626745;6164.4143806338325;6222.81331560054;6236.469900058455;13431.19412835233;13530.864691353157;13542.59372218835;13560.728785424237;13585.796213056812;6747.595144291358;6790.287019862942;6793.830154246183;6804;6816.182058153054;5074.568661663726;6146.661933593606;6152.876942461216;6255.405736455121;6308.116863639094;4606.861794146181;4728.243481043017;4761.309610106585;4782.832600858953;4814.446338671098;1461.291273732239;1498.9400423983136;1504.6689728259764;1514.780356848273;1519.5897107780838;795.0975642645524;805.1827395193883;823.7858156879255;827.7889138269703;867.2541614211773;6041.24484439445;6044.879102417927;6169.475594574512;6298.1812364392335;6332.525060620472;584.2988413903333;592.4453280318091;606.263389981175;613.15078616117;618.8421952402109;3693.4275187346007;4209.284421648327;4238.682098842537;4292.7424354538825;4408.889777755582;14397.136171829723;14774.187419691805;14843.03520271179;14861.702765944621;14876.256187190596;14192;14389.568312950629;14501.274936253356;14590.999999999787;14788.334524946404;7031.507794454339;7400.5189662671755;8331.291840193651;8499.405041647025;8578.056413794478;6072.544559157993;6494.415502604788;6621.271660117287;6785.389314961677;6801.897971530332;9844.753881153028;10193.592256309665;12127.575534856238;12147.149699520949;12440.253584784941;12407.007439405006;12474.75050499003;12476.251424914533;12701.301428421157;12787.552435665079;9123.315751318545;9326.487043212688;9404.811903761749;9427.24582033422;9434.716958491255;8621.698240561802;10352.068313851789;10583.88869168757;10610.946945265225;10618.1505479563;8909.777255568662;8939.106089391009;8963.641454342014;8995.685151019683;9033.864492032493;8244.876326855221;8261.586920653823;8328.83342333162;8335.291500222307;8365.790855228424;8014;8025.95662563863;8094.676212951416;8101.87847182281;8108.837823243384;4663.650226232979;4960.77676504551;6001.7299221536005;6050.546209034252;6153.600015998945;5998.49012833914;6084.452399283909;6097.969510152421;6250.781222657185;6253.905566525931 05:52:56 INFO - PID 1635 | |4;prototype.html;394.37688452245453;397.83291017772535;400.0897957147489;401.0195073046401;407.9694022948278;6388.712507937143;6404.711787969541;6429.16420865288;6471.38521840425;6479.935200647986;5160.638755287131;5622.212890195376;6223.471004964572;6279.331284204218;6280.497560195185;4754.239321708527;4759.952400476003;4774.68964517307;4775.904481910377;4781.043791241748;3769.396896496561;4475.351074094255;4793.664443488957;4803.543663351993;4857.878553036167;4229.746215227081;4460.66545009124;4480.6639502037315;4482.170798402306;4487.483939346984;3666.4317030859993;4091.3862920562156;4232.238197124517;4472.575105365001;4489.887752806173;3398.5072164536004;3519.5952465466544;3649.981750091259;3681.9079523012138;3879.9612003879884;5996.19051428056;6088.269407671108;6094.177286066413;6110.29731580865;6175.475084617768;5327.893442131136;5357.491038351351;5369.704666243355;5392.514673679349;5409.972950135224;5776.306843178845;6542.149520562344;6580.5393622446445;6620.966895165493;6642.667866606698;4324.718893271959;4342.283523218665;4343.1965086458795;4362.978185109086;4364.650827933758;6412.658754944797;6558.770443034471;6777.085093512362;7030.683619237147;7126.037984872028;3491.703205227584;4114.156597897424;4202.85290014848;4395.846145384896;4429.623482004065;4080.9183816323507;4454.933176002362;4458.7324760514475;4479.290029532086;4540.79566419512;5316.963192177565;5321.8935621287355;5327.440618734977;5332.413434522199;5334.626576139711;5689.260396148474;6017.502736364359;6646.83382915431;6687.933120668828;6708.228553716385;1490.4410845932775;1526.8625823675923;1531.1349087765377;1531.8468153184815;1590.473145780064;879.7228872905142;914.3051281026468;943.9292053095908;990.5592011554933;1009.6869970309227;6426;6446.452051575575;6465.450436712838;6466.288708242089;6473.838154046187;5506.752196151103;6341.587796793194;6585.275619681831;6985.26654701249;6997.230304666483;6264.812055638338;6346.650934198663;6362.1093046973465;6399.488040956712;6413.583117097373;3169.984150079235;3652.502473985653;3657.085728567858;3659.2681463707363;3669.4495825625836;6969.63032568929;7269.20038795732;7311.780646580611;7333.1566869809585;7341.229170936975;6467.805965821033;7116.217216106224;7240.565566066053;7263.382612477999;7265.963670181615;5991.370906054889;6090.964536028797;6966.825829354205;7259.709611615476;7341;6419.454346380423;6508.674566271762;6877.344605610724;7007.544509606859;7038.3665470107935;6024.638521688713;6826;6898.103246577913;6926.9307306926285;7008.789736307919;6353.332900045429;6768.424683901727;6850.177978642595;7295.744648937261;7308.9568197943245;3766.2844059628583;4009.4587230723478;4360.106178233391;4372.868813935587;4410;6711.966440167768;7031.437485001085;7034.683439245144;7040.859182816417;7068.858622827617;5457.61796674229;5884.676342801015;6594.439472644879;6785.592864427953;6801.591904485746;6762.154730658668;6762.695678694372;6773.525853190229;6802.387785099365;6832.897506537505;5846.859862326805;5905.5570832186895;6347.682615869096;6605.438537724155;6606.405423511907;5253.684778913277;5870.618409803349;6145.385461453998;6823.905656605996;6899.827504312432;6028.457438830526;6378.330275321025;6514.185726784152;6543.738250469928;6616.155053327116 05:52:56 INFO - PID 1635 | |5;yui.html;776.2780614028951;783.0837919634024;859.4928991894782;881.5636260051275;889.3818795936822;16815.663686726257;17277.65444691107;17326.480205593838;18551.814481855177;19172.233110675592;17692.292308307686;18180.090995450242;18310.633787324277;18321.083945802722;18487;977.7213494154186;997.825380558403;1000.9049140331693;1001.2690735762898;1001.5092604623754;1003.2876657573132;1014.7310962594918;1017.1557607186055;1017.811704834608;1020.6478764826123;1065.3075500924422;1075.6127793994194;1076.43487169236;1078.4392116099623;1082.9133669306436;1059.6926891201542;1062.4581463453694;1072.801531716631;1073.7745073534568;1074.6023971130653;757.5114051436848;770.8496843115595;775.6160700453312;775.8719811231197;779.033997842671;17120;17398.913005435017;17480.737788933176;17729.822701772948;17759.556011099827;16770.83229167705;17192.398266060754;17306.56733581658;17810.465686029438;17834.573234141237;14034.298285085704;14070.859291407058;14084.366203520865;14212.00515963883;14267.714645707132;3572.392693242129;3619.7647152935238;3619.8009109498967;3624.52881125452;3626.89119326418;107201.31996700144;133360.3331983334;134161;136760;136902;13536.864631353757;13715.039947203799;13779.311034448237;13851.30743462843;13951.232682202577;22899.08403663868;22946.196883109344;23249.605023698634;23891;24953.126640567494;7893.013373328334;7940.16628254025;8007;8130.146334634896;8161.387895907831;3992.8802135935966;4040.5353384360587;4042.7776472293717;4066.2274167908595;4070.3690927906223;4341.500727416387;4366.323219900921;4450.265706158448;4482.238019536687;4487.237169681162;830.5349004557468;956.1681337236648;963.7927845513249;967.02330646048;968.9660861869801;642.1202951955851;644.320242144542;674.3122015544118;676.807109973665;676.8409423785406;10761.085307748772;11845;11985.64043078709;12074.335911524775;12096.455659495345;650.3139188156446;650.5868773328971;658.6904155047121;667.3793372163934;681.2200030964518;5492.423295553989;5606.299212598426;5621.915671264935;5708.200851880657;5716.314042314865;107041.46479267554;109545;109851.90148098576;110486;114468;94430.52784736032;97249.5137524322;97999.06002819927;98293.50853245688;100152.49923750335;76738.99999999888;77610.6119469399;84774.57612711897;85536;86529;8807;10511.211659125749;12034.699132521757;12054.939725301318;12145.574904878287;39430.408543871294;39580.40629390619;40391.39412908867;40785.1842963145;40941;51685.44943651697;52582.685432862956;70921.29078709146;72252;74174;14923.776143357642;15383.461653834527;16254.187290635657;16510.83489165141;16559.586010349838;17594.03232822207;18132.546686332946;18435.53911152232;18454.89270643766;18570;14227.50203742864;15894.205289735699;16405.507834764976;16784.496465106065;16856.831431686016;16065.75901361504;16079.75880361819;16371.181440928143;16538.751918720987;16621.584460388105;15743.13412762309;16116.435924742578;16281.755773663168;16321.26554305083;16324.18379081065;10730.195235357223;10932.234743567873;11047.944760276147;11405.942970285427;11876.703082423008;11964.820527691918;13126.015548834066;13147.802782958071;13160.276184809545;13345.266010369134 05:52:56 INFO - PID 1635 | __end_tp_report 05:52:56 INFO - PID 1635 | __start_cc_report 05:52:56 INFO - PID 1635 | _x_x_mozilla_cycle_collect,413 05:52:56 INFO - PID 1635 | __end_cc_report 05:52:56 INFO - PID 1635 | __startTimestamp1493383976069__endTimestamp 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | ------- Summary: start ------- 05:52:56 INFO - PID 1635 | Number of tests: 6 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:6139.20 Median:6372.39 stddev:767.05 (12.0%) stddev-sans-first:742.33 05:52:56 INFO - PID 1635 | Values: 3564.8 3577.9 3581.5 3617.8 3624.7 4255.0 6224.8 6272.7 6280.0 6372.4 6105.1 6157.3 6242.7 6244.8 6258.3 3942.3 5405.0 5437.4 5454.0 5466.7 5489.6 5569.9 5571.3 5599.0 5610.5 5339.5 5477.6 5491.6 5539.2 5560.6 5371.5 5384.6 5392.4 5394.5 5410.9 5380.8 5429.5 5439.6 5451.2 5485.4 6114.7 6245.9 6263.0 6308.7 6309.7 6625.5 6672.6 6693.0 6706.2 6729.1 6446.0 6545.4 6589.7 6678.7 6775.4 6276.7 6338.0 6345.3 6346.1 6352.3 5708.5 6691.0 6948.4 6952.8 6976.8 6357.7 6389.7 6460.5 6518.5 6566.9 6666.9 6727.3 6769.2 6772.9 6790.5 6551.7 6609.8 6630.9 6633.3 6637.4 6333.7 6426.7 6463.0 6637.1 6650.7 5269.6 5322.9 5326.9 5337.3 5369.8 4036.9 4673.9 4738.5 4740.1 4766.8 5142.0 5938.2 6181.9 6349.2 6378.4 6635.6 6695.4 6745.9 6765.8 6824.4 6315.9 6360.7 6361.7 6362.2 6390.2 5940.3 5958.3 5971.1 5975.2 5979.1 6645.7 6846.1 6935.6 6971.1 7008.6 6742.0 6798.5 6817.8 6819.3 6847.1 6962.5 6970.1 7026.8 7030.1 7044.2 6387.4 6505.7 6578.9 6676.5 6691.6 6775.1 6798.6 6802.8 6808.9 6813.0 6336.0 6423.8 6590.3 6599.8 6614.9 5142.5 6563.6 6572.3 6577.2 6579.2 6188.7 6206.5 6270.8 6349.7 6377.8 6499.9 6517.3 6573.3 6602.3 6608.3 6348.9 6384.4 6384.8 6389.0 6401.7 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:45869.77 Median:336869.00 stddev:81424.44 (24.2%) stddev-sans-first:81582.35 05:52:56 INFO - PID 1635 | Values: 739.9 781.5 826.5 1197.3 1252.3 35776.3 37138.8 37157.1 37169.4 37191.8 37434.8 37522.6 37829.6 37874.8 37900.4 7811.5 7950.1 8245.6 8474.7 8500.0 8471.0 8518.2 8562.7 8598.4 8610.6 8540.7 8561.8 8621.5 8623.0 8625.3 7015.7 8565.8 8597.4 8598.8 8608.0 8350.5 8400.9 8420.3 8431.8 8437.3 36554.5 36728.7 36731.6 36741.3 36823.6 3638.9 3641.7 3686.6 3687.1 3689.2 27397.5 27727.9 30388.4 30532.0 30538.4 3074.9 3153.8 3155.7 3167.2 3180.7 291527.5 295211.0 299437.0 307020.9 309958.0 38346.6 47879.5 48006.8 48100.8 48149.8 48168.5 49934.3 50218.0 51118.7 51159.7 14106.4 14215.9 14226.7 14244.1 14264.6 11449.8 11457.8 11459.0 11461.1 11481.6 13179.5 13285.9 13290.7 13302.0 13390.5 6000.9 6036.1 6051.8 6063.0 6074.0 993.8 1009.4 1017.3 1043.1 1044.2 19334.9 22429.6 24302.9 24309.9 24380.3 1118.1 1118.2 1151.9 1152.8 1155.0 11253.9 12410.3 13324.9 16077.7 16112.3 283331.0 330377.0 331222.0 336286.0 337452.0 55898.4 56045.4 56230.7 56336.2 56422.7 1467.2 1496.5 1540.7 1544.8 1555.1 25622.0 27777.0 28049.3 30040.4 30135.5 34838.7 36248.6 38715.8 38811.0 39111.0 304793.0 304910.0 305060.0 305078.0 306088.0 32476.0 33914.8 33936.5 34009.7 34096.0 41567.0 43901.8 44009.0 44042.6 44045.8 28106.4 28608.6 29966.6 30662.7 30795.5 29837.3 30412.7 30651.0 30693.1 30726.5 36640.0 36664.0 36692.8 36808.4 36831.9 28588.9 28744.9 29588.8 29837.1 31018.1 22538.0 24281.0 24290.0 24354.3 24543.5 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:37032.48 Median:12355.92 stddev:95543.07 (773.3%) stddev-sans-first:95771.50 05:52:56 INFO - PID 1635 | Values: 396.5 423.4 425.8 449.4 456.9 19828.6 21301.6 22030.8 22051.7 22266.9 21905.9 22465.0 23115.8 23307.0 23558.3 6064.8 6210.5 6277.3 6282.3 6284.7 5872.5 6123.1 6142.4 6181.5 6213.5 5885.6 6070.0 6160.5 6161.4 6166.1 6077.6 6104.3 6116.4 6151.5 6162.6 5139.2 5285.8 5345.4 5452.2 5460.0 26766.3 27095.9 27542.0 27657.4 27692.3 2173.5 2222.1 2240.7 2246.8 2248.6 17634.9 17802.1 17806.0 18391.2 18659.9 2138.8 2152.7 2190.5 2191.7 2191.7 163024.0 166989.0 168110.0 168975.5 169649.3 12621.7 12696.0 12865.0 12938.9 13066.9 16300.4 16446.0 16446.8 16504.3 16547.7 7229.8 7406.8 8209.8 8908.6 9211.4 8554.4 8572.2 8574.5 8666.1 8722.7 6432.5 6601.8 7520.4 7878.8 7978.2 2185.3 2196.2 2205.7 2206.9 2344.9 828.8 969.8 990.6 1002.3 1012.7 21040.3 21421.4 21571.6 25671.0 27679.7 1026.1 1027.7 1032.6 1051.4 1062.1 10925.9 12083.9 13195.9 13827.4 14270.0 490118.0 568508.0 572032.0 579722.0 581537.0 130346.0 136285.0 139081.3 139118.0 142598.0 1209.6 1231.8 1248.6 1258.2 1260.2 19023.0 21166.8 22499.0 22707.9 23172.3 57057.7 59740.7 59903.7 61308.4 61993.5 84738.6 85685.0 88047.8 88244.6 88999.0 7997.8 8965.9 9149.9 9183.0 9249.0 14031.6 14602.5 14685.3 15008.5 15129.8 11619.0 12152.6 12226.6 12411.4 12468.5 11686.5 11951.2 12048.7 12186.8 12193.7 12363.7 12381.6 12506.1 12650.6 12661.7 8846.5 9161.2 9195.7 9264.6 9308.2 11539.6 11883.7 12102.8 12123.4 12167.3 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:6990.49 Median:4223.98 stddev:4367.68 (103.4%) stddev-sans-first:4360.08 05:52:56 INFO - PID 1635 | Values: 1447.3 1489.2 1494.6 1509.1 1522.1 11159.9 11454.5 11658.8 11677.9 11794.9 11482.4 11660.7 11676.1 11679.5 11680.0 2483.0 2521.6 2522.3 2531.4 2538.8 2468.4 2506.4 2530.2 2532.4 2538.2 2485.7 2515.7 2515.9 2541.9 2543.3 2449.3 2481.0 2494.4 2497.0 2502.6 2458.6 2494.0 2495.4 2495.4 2507.6 11490.3 11576.8 11696.8 11709.0 11719.4 5987.7 6395.9 6540.9 6741.7 6763.4 3978.5 4287.8 4367.8 4373.9 4377.9 1103.7 1235.6 1249.9 1304.3 1311.3 15607.6 16147.8 16152.4 16391.8 16469.6 5859.9 6015.2 6164.4 6222.8 6236.5 13431.2 13530.9 13542.6 13560.7 13585.8 6747.6 6790.3 6793.8 6804.0 6816.2 5074.6 6146.7 6152.9 6255.4 6308.1 4606.9 4728.2 4761.3 4782.8 4814.4 1461.3 1498.9 1504.7 1514.8 1519.6 795.1 805.2 823.8 827.8 867.3 6041.2 6044.9 6169.5 6298.2 6332.5 584.3 592.4 606.3 613.2 618.8 3693.4 4209.3 4238.7 4292.7 4408.9 14397.1 14774.2 14843.0 14861.7 14876.3 14192.0 14389.6 14501.3 14591.0 14788.3 7031.5 7400.5 8331.3 8499.4 8578.1 6072.5 6494.4 6621.3 6785.4 6801.9 9844.8 10193.6 12127.6 12147.1 12440.3 12407.0 12474.8 12476.3 12701.3 12787.6 9123.3 9326.5 9404.8 9427.2 9434.7 8621.7 10352.1 10583.9 10610.9 10618.2 8909.8 8939.1 8963.6 8995.7 9033.9 8244.9 8261.6 8328.8 8335.3 8365.8 8014.0 8026.0 8094.7 8101.9 8108.8 4663.7 4960.8 6001.7 6050.5 6153.6 5998.5 6084.5 6098.0 6250.8 6253.9 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5374.22 Median:6127.84 stddev:1740.96 (28.4%) stddev-sans-first:1705.25 05:52:56 INFO - PID 1635 | Values: 394.4 397.8 400.1 401.0 408.0 6388.7 6404.7 6429.2 6471.4 6479.9 5160.6 5622.2 6223.5 6279.3 6280.5 4754.2 4760.0 4774.7 4775.9 4781.0 3769.4 4475.4 4793.7 4803.5 4857.9 4229.7 4460.7 4480.7 4482.2 4487.5 3666.4 4091.4 4232.2 4472.6 4489.9 3398.5 3519.6 3650.0 3681.9 3880.0 5996.2 6088.3 6094.2 6110.3 6175.5 5327.9 5357.5 5369.7 5392.5 5410.0 5776.3 6542.1 6580.5 6621.0 6642.7 4324.7 4342.3 4343.2 4363.0 4364.7 6412.7 6558.8 6777.1 7030.7 7126.0 3491.7 4114.2 4202.9 4395.8 4429.6 4080.9 4454.9 4458.7 4479.3 4540.8 5317.0 5321.9 5327.4 5332.4 5334.6 5689.3 6017.5 6646.8 6687.9 6708.2 1490.4 1526.9 1531.1 1531.8 1590.5 879.7 914.3 943.9 990.6 1009.7 6426.0 6446.5 6465.5 6466.3 6473.8 5506.8 6341.6 6585.3 6985.3 6997.2 6264.8 6346.7 6362.1 6399.5 6413.6 3170.0 3652.5 3657.1 3659.3 3669.4 6969.6 7269.2 7311.8 7333.2 7341.2 6467.8 7116.2 7240.6 7263.4 7266.0 5991.4 6091.0 6966.8 7259.7 7341.0 6419.5 6508.7 6877.3 7007.5 7038.4 6024.6 6826.0 6898.1 6926.9 7008.8 6353.3 6768.4 6850.2 7295.7 7309.0 3766.3 4009.5 4360.1 4372.9 4410.0 6712.0 7031.4 7034.7 7040.9 7068.9 5457.6 5884.7 6594.4 6785.6 6801.6 6762.2 6762.7 6773.5 6802.4 6832.9 5846.9 5905.6 6347.7 6605.4 6606.4 5253.7 5870.6 6145.4 6823.9 6899.8 6028.5 6378.3 6514.2 6543.7 6616.2 05:52:56 INFO - PID 1635 | 05:52:56 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:22506.30 Median:17785.01 stddev:32293.22 (181.6%) stddev-sans-first:32342.59 05:52:56 INFO - PID 1635 | Values: 776.3 783.1 859.5 881.6 889.4 16815.7 17277.7 17326.5 18551.8 19172.2 17692.3 18180.1 18310.6 18321.1 18487.0 977.7 997.8 1000.9 1001.3 1001.5 1003.3 1014.7 1017.2 1017.8 1020.6 1065.3 1075.6 1076.4 1078.4 1082.9 1059.7 1062.5 1072.8 1073.8 1074.6 757.5 770.8 775.6 775.9 779.0 17120.0 17398.9 17480.7 17729.8 17759.6 16770.8 17192.4 17306.6 17810.5 17834.6 14034.3 14070.9 14084.4 14212.0 14267.7 3572.4 3619.8 3619.8 3624.5 3626.9 107201.3 133360.3 134161.0 136760.0 136902.0 13536.9 13715.0 13779.3 13851.3 13951.2 22899.1 22946.2 23249.6 23891.0 24953.1 7893.0 7940.2 8007.0 8130.1 8161.4 3992.9 4040.5 4042.8 4066.2 4070.4 4341.5 4366.3 4450.3 4482.2 4487.2 830.5 956.2 963.8 967.0 969.0 642.1 644.3 674.3 676.8 676.8 10761.1 11845.0 11985.6 12074.3 12096.5 650.3 650.6 658.7 667.4 681.2 5492.4 5606.3 5621.9 5708.2 5716.3 107041.5 109545.0 109851.9 110486.0 114468.0 94430.5 97249.5 97999.1 98293.5 100152.5 76739.0 77610.6 84774.6 85536.0 86529.0 8807.0 10511.2 12034.7 12054.9 12145.6 39430.4 39580.4 40391.4 40785.2 40941.0 51685.4 52582.7 70921.3 72252.0 74174.0 14923.8 15383.5 16254.2 16510.8 16559.6 17594.0 18132.5 18435.5 18454.9 18570.0 14227.5 15894.2 16405.5 16784.5 16856.8 16065.8 16079.8 16371.2 16538.8 16621.6 15743.1 16116.4 16281.8 16321.3 16324.2 10730.2 10932.2 11047.9 11405.9 11876.7 11964.8 13126.0 13147.8 13160.3 13345.3 05:52:56 INFO - PID 1635 | -------- Summary: end -------- 05:52:56 INFO - PID 1635 | 05:52:56 INFO - TEST-INFO | 1635: exit 0 05:52:56 INFO - TEST-OK | dromaeo_css | took 1116177ms 05:52:56 INFO - TEST-START | kraken 05:52:56 INFO - operating with platform_type : mac_ 05:52:56 INFO - Initialising browser for kraken test... 05:52:56 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpedezy7/profile http://localhost:49234/getInfo.html) 05:52:59 INFO - PID 1646 | 2017-04-28 05:52:59.103 plugin-container[1647:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 05:52:59 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:59 INFO - PID 1646 | 2017-04-28 05:52:59.106 plugin-container[1647:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 05:52:59 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:59 INFO - PID 1646 | 2017-04-28 05:52:59.106 plugin-container[1647:10151] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:52:59 INFO - PID 1646 | __metrics Screen width/height:1600/1200 05:52:59 INFO - PID 1646 | colorDepth:24 05:52:59 INFO - PID 1646 | Browser inner width/height: 1024/689 05:52:59 INFO - PID 1646 | __metrics 05:52:59 ERROR - PID 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 05:53:00 INFO - TEST-INFO | 1646: exit 0 05:53:00 INFO - Browser initialized. 05:53:00 INFO - Running cycle 1/1 for kraken test... 05:53:00 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpedezy7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:02 INFO - PID 1648 | 2017-04-28 05:53:02.585 plugin-container[1649:10271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464f, name = 'com.apple.tsm.portname' 05:53:02 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:53:02 INFO - PID 1648 | 2017-04-28 05:53:02.585 plugin-container[1649:10271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b0b, name = 'com.apple.CFPasteboardClient' 05:53:02 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:53:02 INFO - PID 1648 | 2017-04-28 05:53:02.585 plugin-container[1649:10271] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:53:12 INFO - PID 1648 | RSS: Main: 250859520 05:53:12 INFO - PID 1648 | 05:53:15 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:16 INFO - PID 1648 | RSS: Main: 259162112 05:53:16 INFO - PID 1648 | 05:53:18 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft) 05:53:19 INFO - PID 1648 | RSS: Main: 265428992 05:53:19 INFO - PID 1648 | 05:53:22 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft) 05:53:23 INFO - PID 1648 | RSS: Main: 262500352 05:53:23 INFO - PID 1648 | 05:53:25 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator) 05:53:26 INFO - PID 1648 | RSS: Main: 264552448 05:53:26 INFO - PID 1648 | 05:53:27 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:28 INFO - PID 1648 | RSS: Main: 265080832 05:53:28 INFO - PID 1648 | 05:53:31 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:32 INFO - PID 1648 | RSS: Main: 270483456 05:53:32 INFO - PID 1648 | 05:53:35 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:35 INFO - PID 1648 | RSS: Main: 272670720 05:53:35 INFO - PID 1648 | 05:53:38 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial) 05:53:39 INFO - PID 1648 | RSS: Main: 272068608 05:53:39 INFO - PID 1648 | 05:53:40 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:41 INFO - PID 1648 | RSS: Main: 271474688 05:53:41 INFO - PID 1648 | 05:53:43 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:44 INFO - PID 1648 | RSS: Main: 271536128 05:53:44 INFO - PID 1648 | 05:53:46 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:46 INFO - PID 1648 | RSS: Main: 271175680 05:53:46 INFO - PID 1648 | 05:53:49 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:50 INFO - PID 1648 | RSS: Main: 271417344 05:53:50 INFO - PID 1648 | 05:53:54 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:54 INFO - PID 1648 | RSS: Main: 268709888 05:53:54 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar) 05:53:56 INFO - PID 1648 | RSS: Main: 270544896 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | __start_tp_report 05:53:56 INFO - PID 1648 | _x_x_mozilla_page_load 05:53:56 INFO - PID 1648 | _x_x_mozilla_page_load_details 05:53:56 INFO - PID 1648 | |i|pagename|runs| 05:53:56 INFO - PID 1648 | |0;ai-astar;103;117;110;113;109;108;115;114;111;114 05:53:56 INFO - PID 1648 | |1;audio-beat-detection;130;111;111;167;143;111;108;115;135;112 05:53:56 INFO - PID 1648 | |2;audio-dft;199;203;200;213;209;228;197;203;197;198 05:53:56 INFO - PID 1648 | |3;audio-fft;81;60;61;86;72;91;59;56;73;61 05:53:56 INFO - PID 1648 | |4;audio-oscillator;93;70;82;75;70;70;89;72;70;90 05:53:56 INFO - PID 1648 | |5;imaging-gaussian-blur;97;91;92;90;91;91;92;91;118;137 05:53:56 INFO - PID 1648 | |6;imaging-darkroom;99;97;98;102;98;97;99;98;98;121 05:53:56 INFO - PID 1648 | |7;imaging-desaturate;92;91;117;142;91;93;94;90;93;94 05:53:56 INFO - PID 1648 | |8;json-parse-financial;51;48;50;51;50;50;52;52;51;52 05:53:56 INFO - PID 1648 | |9;json-stringify-tinderbox;56;58;79;82;62;61;57;58;59;86 05:53:56 INFO - PID 1648 | |10;stanford-crypto-aes;82;84;86;84;84;84;83;84;83;85 05:53:56 INFO - PID 1648 | |11;stanford-crypto-ccm;136;174;152;149;151;159;151;133;201;151 05:53:56 INFO - PID 1648 | |12;stanford-crypto-pbkdf2;195;220;254;215;262;255;194;193;194;185 05:53:56 INFO - PID 1648 | |13;stanford-crypto-sha256-iterative;99;71;63;74;99;103;102;72;73;73 05:53:56 INFO - PID 1648 | __end_tp_report 05:53:56 INFO - PID 1648 | __start_cc_report 05:53:56 INFO - PID 1648 | _x_x_mozilla_cycle_collect,1003 05:53:56 INFO - PID 1648 | __end_cc_report 05:53:56 INFO - PID 1648 | __startTimestamp1493384036771__endTimestamp 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | ------- Summary: start ------- 05:53:56 INFO - PID 1648 | Number of tests: 14 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:4.09 (3.6%) stddev-sans-first:3.00 05:53:56 INFO - PID 1648 | Values: 103.0 117.0 110.0 113.0 109.0 108.0 115.0 114.0 111.0 114.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:122.50 stddev:19.30 (15.8%) stddev-sans-first:20.37 05:53:56 INFO - PID 1648 | Values: 130.0 111.0 111.0 167.0 143.0 111.0 108.0 115.0 135.0 112.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#2] audio-dft Cycles:10 Average:204.70 Median:203.00 stddev:9.74 (4.8%) stddev-sans-first:10.11 05:53:56 INFO - PID 1648 | Values: 199.0 203.0 200.0 213.0 209.0 228.0 197.0 203.0 197.0 198.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#3] audio-fft Cycles:10 Average:70.00 Median:72.50 stddev:12.52 (17.3%) stddev-sans-first:12.63 05:53:56 INFO - PID 1648 | Values: 81.0 60.0 61.0 86.0 72.0 91.0 59.0 56.0 73.0 61.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.50 stddev:9.47 (12.1%) stddev-sans-first:8.37 05:53:56 INFO - PID 1648 | Values: 93.0 70.0 82.0 75.0 70.0 70.0 89.0 72.0 70.0 90.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:91.00 stddev:15.79 (17.4%) stddev-sans-first:16.73 05:53:56 INFO - PID 1648 | Values: 97.0 91.0 92.0 90.0 91.0 91.0 92.0 91.0 118.0 137.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:98.00 stddev:7.27 (7.4%) stddev-sans-first:7.69 05:53:56 INFO - PID 1648 | Values: 99.0 97.0 98.0 102.0 98.0 97.0 99.0 98.0 98.0 121.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#7] imaging-desaturate Cycles:10 Average:99.70 Median:92.50 stddev:16.83 (18.2%) stddev-sans-first:17.61 05:53:56 INFO - PID 1648 | Values: 92.0 91.0 117.0 142.0 91.0 93.0 94.0 90.0 93.0 94.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:1.25 (2.5%) stddev-sans-first:1.32 05:53:56 INFO - PID 1648 | Values: 51.0 48.0 50.0 51.0 50.0 50.0 52.0 52.0 51.0 52.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:61.50 stddev:11.66 (19.0%) stddev-sans-first:11.82 05:53:56 INFO - PID 1648 | Values: 56.0 58.0 79.0 82.0 62.0 61.0 57.0 58.0 59.0 86.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 05:53:56 INFO - PID 1648 | Values: 82.0 84.0 86.0 84.0 84.0 84.0 83.0 84.0 83.0 85.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:151.50 stddev:19.51 (12.9%) stddev-sans-first:19.35 05:53:56 INFO - PID 1648 | Values: 136.0 174.0 152.0 149.0 151.0 159.0 151.0 133.0 201.0 151.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:216.70 Median:217.50 stddev:29.80 (13.7%) stddev-sans-first:30.56 05:53:56 INFO - PID 1648 | Values: 195.0 220.0 254.0 215.0 262.0 255.0 194.0 193.0 194.0 185.0 05:53:56 INFO - PID 1648 | 05:53:56 INFO - PID 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.90 Median:73.00 stddev:15.70 (21.5%) stddev-sans-first:15.54 05:53:56 INFO - PID 1648 | Values: 99.0 71.0 63.0 74.0 99.0 103.0 102.0 72.0 73.0 73.0 05:53:56 INFO - PID 1648 | -------- Summary: end -------- 05:53:56 INFO - PID 1648 | 05:53:57 INFO - TEST-INFO | 1648: exit 0 05:53:57 INFO - TEST-OK | kraken | took 61163ms 05:53:57 INFO - SUITE-END | took 1177s 05:53:58 INFO - Completed test suite (00:19:37) 05:53:58 INFO - javascript benchmark 05:53:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7940.5606537191225, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3564.7682900611444, 3577.856885724571, 3581.480685300633, 3617.819109044547, 3624.6556577125166, 4254.978725106378, 6224.782132625353, 6272.686365681715, 6279.968600156999, 6372.394622510866, 6105.06553558391, 6157.291911430187, 6242.687865606724, 6244.812655620327, 6258.342873998233, 3942.2903877302074, 5405.00007498612, 5437.429069947658, 5453.972730136364, 5466.671999680012, 5489.58828087893, 5569.944300557004, 5571.275734154575, 5599.0, 5610.523105536014, 5339.5194432500875, 5477.589180811455, 5491.615586908918, 5539.196816461611, 5560.555155587564, 5371.462853714636, 5384.5692344612335, 5392.379876314235, 5394.541463975567, 5410.891782164374, 5380.757865896005, 5429.511343979021, 5439.646422982533, 5451.236826844245, 5485.424030476783, 6114.724837382284, 6245.87508249837, 6262.968685156545, 6308.684565771693, 6309.684515774239, 6625.503087268474, 6672.599644021374, 6692.966535167293, 6706.161729783777, 6729.091572637729, 6446.0, 6545.410913017804, 6589.7034633441135, 6678.732850685967, 6775.3902148806355, 6276.717547710364, 6338.0, 6345.270293916259, 6346.143270658495, 6352.301246862841, 5708.514776243983, 6690.962900750392, 6948.44412447003, 6952.791416257521, 6976.7558135465015, 6357.650329231937, 6389.6805159741825, 6460.450861676716, 6518.478521718346, 6566.901496477557, 6666.866662666816, 6727.327267273331, 6769.153855768029, 6772.8984065239065, 6790.456763458911, 6551.737930482823, 6609.801705948829, 6630.933690663128, 6633.2703402625675, 6637.369449902251, 6333.68331583419, 6426.74293028283, 6463.0, 6637.103990961158, 6650.70071846768, 5269.55208807248, 5322.9088036952335, 5326.92009619856, 5337.306150200449, 5369.785208591613, 4036.8990775230855, 4673.948361618676, 4738.502457242009, 4740.099381117577, 4766.761661916959, 5141.9742901286, 5938.228030356113, 6181.907271390933, 6349.206349206349, 6378.362163783678, 6635.568688035262, 6695.363940425652, 6745.898811517831, 6765.763198288135, 6824.351686589766, 6315.905261421082, 6360.650164241011, 6361.681915904186, 6362.236531616236, 6390.169277993924, 5940.287165540077, 5958.314793798682, 5971.0744834550715, 5975.223220981332, 5979.073243647242, 6645.700943457653, 6846.144231971004, 6935.583864968118, 6971.058907047483, 7008.579485230903, 6741.966290168518, 6798.52410331272, 6817.795466136024, 6819.318068193141, 6847.07564478789, 6962.512624116263, 6970.059042029261, 7026.754063607749, 7030.121234845645, 7044.225135235222, 6387.425131738166, 6505.674716264262, 6578.934210657832, 6676.532642714963, 6691.5650482718465, 6775.051492791112, 6798.592084474947, 6802.761903333359, 6808.897866531907, 6812.965935170292, 6336.0, 6423.779481898424, 6590.340965903371, 6599.835004124935, 6614.867702645824, 5142.51146141116, 6563.638999855054, 6572.277049524644, 6577.210734711865, 6579.17760279965, 6188.690565471618, 6206.472449841814, 6270.7805226816845, 6349.714262858275, 6377.7767778127545, 6499.902501462388, 6517.283098859217, 6573.276939536551, 6602.306757790555, 6608.339166083353, 6348.936510634834, 6384.361563843579, 6384.840378990562, 6389.0, 6401.711922963571], "value": 6088.8562274429605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.9381886992167, 781.519365590162, 826.4793180296414, 1197.2816310213873, 1252.2736812648666, 35776.28447431053, 37138.81430592846, 37157.07107322318, 37169.442458363075, 37191.814040929756, 37434.812825935835, 37522.62477375226, 37829.621703782956, 37874.8106259469, 37900.43149352762, 7811.531308121516, 7950.1254861965135, 8245.628946697412, 8474.661013559451, 8499.957500212491, 8470.98348198217, 8518.23335899769, 8562.743117706448, 8598.355123365742, 8610.56947152643, 8540.74377768668, 8561.828763424728, 8621.482711037357, 8623.0, 8625.309975202, 7015.684294206773, 8565.828683426327, 8597.398182127254, 8598.828023439497, 8607.999999999969, 8350.540720260384, 8400.907881975305, 8420.326373890073, 8431.83136337276, 8437.282830959375, 36554.451683224775, 36728.71449499255, 36731.63268367336, 36741.26517469662, 36823.631763682555, 3638.872639457633, 3641.745077844552, 3686.5760437549757, 3687.0966613179944, 3689.206820533598, 27397.45205095907, 27727.92040596943, 30388.392232155235, 30532.0, 30538.389232215453, 3074.9077527674203, 3153.8107713537033, 3155.7159855612877, 3167.224030112637, 3180.745540356766, 291527.5423622868, 295211.0, 299437.0, 307020.9297907015, 309958.0, 38346.616533834866, 47879.5212047882, 48006.75996620065, 48100.759496203, 48149.75925120422, 48168.518314817105, 49934.25098623524, 50217.99564008699, 51118.74440627773, 51159.7442012795, 14106.435742570182, 14215.928920355538, 14226.715465690628, 14244.07413518118, 14264.643383915485, 11449.828252576219, 11457.770844583061, 11459.025982791556, 11461.140414468948, 11481.598144064918, 13179.538716144889, 13285.867141328463, 13290.73418531624, 13302.002349823802, 13390.464381424634, 6000.939990600038, 6036.094585812163, 6051.7579296827635, 6063.0, 6074.0, 993.8062077894741, 1009.4448053570507, 1017.3336464615688, 1043.1446214104512, 1044.1646682653848, 19334.90950350635, 22429.551408972056, 24302.87848560746, 24309.878450607986, 24380.268591941916, 1118.1222740148944, 1118.1725523112839, 1151.8560179977503, 1152.7924973504682, 1154.9653510394533, 11253.94373028146, 12410.255384676948, 13324.933375333061, 16077.678446431006, 16112.274947627386, 283331.0, 330377.0, 331222.0, 336286.0, 337452.0, 55898.44101558932, 56045.43954560484, 56230.71884640551, 56336.154957675666, 56422.717886410304, 1467.2150399536197, 1496.513633069257, 1540.7149677309733, 1544.7682847572953, 1555.0902721907585, 25622.0, 27777.0, 28049.298767530974, 30040.399192016474, 30135.547966780076, 34838.65161348354, 36248.55005799738, 38715.80642096772, 38811.0, 39111.0, 304793.0, 304909.9509004882, 305060.0, 305078.0, 306088.0, 32476.0, 33914.830425847715, 33936.490952635235, 34009.65990340065, 34096.0, 41567.01195856516, 43901.78049109734, 44009.0, 44042.559574405124, 44045.77977110094, 28106.43787124287, 28608.57087143736, 29966.550501742928, 30662.693373065984, 30795.538066928566, 29837.254068648457, 30412.69587304187, 30651.0, 30693.079207623807, 30726.539101913935, 36640.0, 36664.0, 36692.81653591715, 36808.44787328246, 36831.89504314875, 28588.857055714587, 28744.856275718488, 29588.816447342728, 29837.10488685343, 31018.0694579163, 22538.0, 24281.0, 24290.0, 24354.269371918872, 24543.50912981766], "value": 17625.001280518536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.54793535369663, 423.4030017675077, 425.7892343290072, 449.438202247191, 456.85152325494215, 19828.60342793145, 21301.57396852062, 22030.779692203094, 22051.66922496164, 22266.88866555665, 21905.890470547663, 22465.0, 23115.768842311572, 23306.970093887812, 23558.29325120245, 6064.848378790522, 6210.534209934273, 6277.278113017016, 6282.308946015934, 6284.71718772654, 5872.530197584204, 6123.11214873843, 6142.416470435302, 6181.536384771138, 6213.533984951124, 5885.5585831062845, 6069.969650151766, 6160.476359509447, 6161.414665606782, 6166.136740856284, 6077.604955677889, 6104.328523862371, 6116.357782432825, 6151.5386346024225, 6162.568620196588, 5139.203423469368, 5285.762140703678, 5345.3585569731495, 5452.154915988028, 5459.989901868167, 26766.33084172892, 27095.864520677467, 27542.0, 27657.44685106307, 27692.30769230765, 2173.4566358410398, 2222.14447437736, 2240.7311122665224, 2246.831487638434, 2248.5840119577765, 17634.91182544079, 17802.109894505353, 17806.0, 18391.172397242157, 18659.906700466545, 2138.754043285011, 2152.720146380976, 2190.4742861713075, 2191.6931629571873, 2191.747948985871, 163024.0, 166989.0, 168110.0, 168975.46536801834, 169649.3035069658, 12621.74756504883, 12696.047796415121, 12864.976730468332, 12938.90019348366, 13066.869331306565, 16300.429484968206, 16446.0, 16446.83553164477, 16504.25730842115, 16547.669046619, 7229.819254518574, 7406.814829629302, 8209.753707388787, 8908.5991130398, 9211.40125891815, 8554.35842311829, 8572.228499435081, 8574.528400937883, 8666.133386661284, 8722.738317850475, 6432.453241474527, 6601.768938087144, 7520.398368130536, 7878.803029924183, 7978.162292959156, 2185.278857976896, 2196.176433837311, 2205.735311762599, 2206.9448263793533, 2344.874460259085, 828.8093738440192, 969.8254314223508, 990.5667414232927, 1002.2633364477103, 1012.7063151685928, 21040.263590774248, 21421.357359279245, 21571.57782654552, 25671.0, 27679.723202768117, 1026.1021606094666, 1027.686555600549, 1032.6385764982197, 1051.4217180550665, 1062.0919114157439, 10925.890741092488, 12083.918600756751, 13195.868041319463, 13827.446902124004, 14270.001099923113, 490118.0, 568508.0, 572032.0, 579722.0, 581537.0, 130346.0, 136285.0, 139081.30459347638, 139118.04409779672, 142598.0, 1209.564556759566, 1231.8275441438207, 1248.5630029489787, 1258.2010423381219, 1260.24385368778, 19023.0, 21166.78833211648, 22498.987545560816, 22707.88646056759, 23172.3048308551, 57057.714711426175, 59740.70129649324, 59903.70048149906, 61308.386916130265, 61993.45016374627, 84738.57630711807, 85685.0, 88047.79880503038, 88244.5587772057, 88999.0, 7997.7600671979935, 8965.865512017195, 9149.862752058858, 9182.95408522953, 9249.0, 14031.649208769863, 14602.488912887999, 14685.339159737623, 15008.47470338533, 15129.773053404428, 11619.0, 12152.635420937386, 12226.633201003984, 12411.379431028594, 12468.5012599495, 11686.474108664961, 11951.191470004369, 12048.698782530508, 12186.756264874475, 12193.69515762113, 12363.69090772738, 12381.595061358199, 12506.062045346818, 12650.557230496888, 12661.683457913627, 8846.513441760508, 9161.221296189631, 9195.724128276162, 9264.629414823601, 9308.208802251884, 11539.596114135966, 11883.702907427383, 12102.75794484123, 12123.393830308272, 12167.330796805907], "value": 10746.006672449023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.3342262559222, 1489.2181604657553, 1494.5665756930491, 1509.064380084348, 1522.1399909051386, 11159.939805718453, 11454.48454819533, 11658.825117623242, 11677.941610291948, 11794.882051179486, 11482.425878706073, 11660.708482287948, 11676.124290678212, 11679.474423650934, 11680.0, 2482.9627555586635, 2521.621756736486, 2522.2811498722867, 2531.3671582104475, 2538.7588179122954, 2468.419921318489, 2506.385935445818, 2530.1903390914913, 2532.3669082729316, 2538.1877799104295, 2485.652008718781, 2515.735847735989, 2515.937101572466, 2541.872906354684, 2543.300592337104, 2449.2774631483667, 2481.019997101153, 2494.3514686181543, 2496.987515062431, 2502.637117617944, 2458.5820410530073, 2493.9750602494105, 2495.401103735109, 2495.4135778092314, 2507.5862482690336, 11490.310581365145, 11576.826347604792, 11696.766064678659, 11709.0, 11719.355435451047, 5987.652778124931, 6395.904061439082, 6540.93459065408, 6741.730330786762, 6763.425108865752, 3978.5026871641044, 4287.849925252633, 4367.825286988516, 4373.934390984138, 4377.868663940055, 1103.6578660615235, 1235.5552001279623, 1249.868763779799, 1304.269609018943, 1311.3050083455785, 15607.609809754733, 16147.83852161475, 16152.353905843753, 16391.754123688155, 16469.58826029359, 5859.94140058594, 6015.187949626745, 6164.4143806338325, 6222.81331560054, 6236.469900058455, 13431.19412835233, 13530.864691353157, 13542.59372218835, 13560.728785424237, 13585.796213056812, 6747.595144291358, 6790.287019862942, 6793.830154246183, 6804.0, 6816.182058153054, 5074.568661663726, 6146.661933593606, 6152.876942461216, 6255.405736455121, 6308.116863639094, 4606.861794146181, 4728.243481043017, 4761.309610106585, 4782.832600858953, 4814.446338671098, 1461.291273732239, 1498.9400423983136, 1504.6689728259764, 1514.780356848273, 1519.5897107780838, 795.0975642645524, 805.1827395193883, 823.7858156879255, 827.7889138269703, 867.2541614211773, 6041.24484439445, 6044.879102417927, 6169.475594574512, 6298.1812364392335, 6332.525060620472, 584.2988413903333, 592.4453280318091, 606.263389981175, 613.15078616117, 618.8421952402109, 3693.4275187346007, 4209.284421648327, 4238.682098842537, 4292.7424354538825, 4408.889777755582, 14397.136171829723, 14774.187419691805, 14843.03520271179, 14861.702765944621, 14876.256187190596, 14192.0, 14389.568312950629, 14501.274936253356, 14590.999999999787, 14788.334524946404, 7031.507794454339, 7400.5189662671755, 8331.291840193651, 8499.405041647025, 8578.056413794478, 6072.544559157993, 6494.415502604788, 6621.271660117287, 6785.389314961677, 6801.897971530332, 9844.753881153028, 10193.592256309665, 12127.575534856238, 12147.149699520949, 12440.253584784941, 12407.007439405006, 12474.75050499003, 12476.251424914533, 12701.301428421157, 12787.552435665079, 9123.315751318545, 9326.487043212688, 9404.811903761749, 9427.24582033422, 9434.716958491255, 8621.698240561802, 10352.068313851789, 10583.88869168757, 10610.946945265225, 10618.1505479563, 8909.777255568662, 8939.106089391009, 8963.641454342014, 8995.685151019683, 9033.864492032493, 8244.876326855221, 8261.586920653823, 8328.83342333162, 8335.291500222307, 8365.790855228424, 8014.0, 8025.95662563863, 8094.676212951416, 8101.87847182281, 8108.837823243384, 4663.650226232979, 4960.77676504551, 6001.7299221536005, 6050.546209034252, 6153.600015998945, 5998.49012833914, 6084.452399283909, 6097.969510152421, 6250.781222657185, 6253.905566525931], "value": 5304.1435691083525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.37688452245453, 397.83291017772535, 400.0897957147489, 401.0195073046401, 407.9694022948278, 6388.712507937143, 6404.711787969541, 6429.16420865288, 6471.38521840425, 6479.935200647986, 5160.638755287131, 5622.212890195376, 6223.471004964572, 6279.331284204218, 6280.497560195185, 4754.239321708527, 4759.952400476003, 4774.68964517307, 4775.904481910377, 4781.043791241748, 3769.396896496561, 4475.351074094255, 4793.664443488957, 4803.543663351993, 4857.878553036167, 4229.746215227081, 4460.66545009124, 4480.6639502037315, 4482.170798402306, 4487.483939346984, 3666.4317030859993, 4091.3862920562156, 4232.238197124517, 4472.575105365001, 4489.887752806173, 3398.5072164536004, 3519.5952465466544, 3649.981750091259, 3681.9079523012138, 3879.9612003879884, 5996.19051428056, 6088.269407671108, 6094.177286066413, 6110.29731580865, 6175.475084617768, 5327.893442131136, 5357.491038351351, 5369.704666243355, 5392.514673679349, 5409.972950135224, 5776.306843178845, 6542.149520562344, 6580.5393622446445, 6620.966895165493, 6642.667866606698, 4324.718893271959, 4342.283523218665, 4343.1965086458795, 4362.978185109086, 4364.650827933758, 6412.658754944797, 6558.770443034471, 6777.085093512362, 7030.683619237147, 7126.037984872028, 3491.703205227584, 4114.156597897424, 4202.85290014848, 4395.846145384896, 4429.623482004065, 4080.9183816323507, 4454.933176002362, 4458.7324760514475, 4479.290029532086, 4540.79566419512, 5316.963192177565, 5321.8935621287355, 5327.440618734977, 5332.413434522199, 5334.626576139711, 5689.260396148474, 6017.502736364359, 6646.83382915431, 6687.933120668828, 6708.228553716385, 1490.4410845932775, 1526.8625823675923, 1531.1349087765377, 1531.8468153184815, 1590.473145780064, 879.7228872905142, 914.3051281026468, 943.9292053095908, 990.5592011554933, 1009.6869970309227, 6426.0, 6446.452051575575, 6465.450436712838, 6466.288708242089, 6473.838154046187, 5506.752196151103, 6341.587796793194, 6585.275619681831, 6985.26654701249, 6997.230304666483, 6264.812055638338, 6346.650934198663, 6362.1093046973465, 6399.488040956712, 6413.583117097373, 3169.984150079235, 3652.502473985653, 3657.085728567858, 3659.2681463707363, 3669.4495825625836, 6969.63032568929, 7269.20038795732, 7311.780646580611, 7333.1566869809585, 7341.229170936975, 6467.805965821033, 7116.217216106224, 7240.565566066053, 7263.382612477999, 7265.963670181615, 5991.370906054889, 6090.964536028797, 6966.825829354205, 7259.709611615476, 7341.0, 6419.454346380423, 6508.674566271762, 6877.344605610724, 7007.544509606859, 7038.3665470107935, 6024.638521688713, 6826.0, 6898.103246577913, 6926.9307306926285, 7008.789736307919, 6353.332900045429, 6768.424683901727, 6850.177978642595, 7295.744648937261, 7308.9568197943245, 3766.2844059628583, 4009.4587230723478, 4360.106178233391, 4372.868813935587, 4410.0, 6711.966440167768, 7031.437485001085, 7034.683439245144, 7040.859182816417, 7068.858622827617, 5457.61796674229, 5884.676342801015, 6594.439472644879, 6785.592864427953, 6801.591904485746, 6762.154730658668, 6762.695678694372, 6773.525853190229, 6802.387785099365, 6832.897506537505, 5846.859862326805, 5905.5570832186895, 6347.682615869096, 6605.438537724155, 6606.405423511907, 5253.684778913277, 5870.618409803349, 6145.385461453998, 6823.905656605996, 6899.827504312432, 6028.457438830526, 6378.330275321025, 6514.185726784152, 6543.738250469928, 6616.155053327116], "value": 4822.313299432366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.2780614028951, 783.0837919634024, 859.4928991894782, 881.5636260051275, 889.3818795936822, 16815.663686726257, 17277.65444691107, 17326.480205593838, 18551.814481855177, 19172.233110675592, 17692.292308307686, 18180.090995450242, 18310.633787324277, 18321.083945802722, 18487.0, 977.7213494154186, 997.825380558403, 1000.9049140331693, 1001.2690735762898, 1001.5092604623754, 1003.2876657573132, 1014.7310962594918, 1017.1557607186055, 1017.811704834608, 1020.6478764826123, 1065.3075500924422, 1075.6127793994194, 1076.43487169236, 1078.4392116099623, 1082.9133669306436, 1059.6926891201542, 1062.4581463453694, 1072.801531716631, 1073.7745073534568, 1074.6023971130653, 757.5114051436848, 770.8496843115595, 775.6160700453312, 775.8719811231197, 779.033997842671, 17120.0, 17398.913005435017, 17480.737788933176, 17729.822701772948, 17759.556011099827, 16770.83229167705, 17192.398266060754, 17306.56733581658, 17810.465686029438, 17834.573234141237, 14034.298285085704, 14070.859291407058, 14084.366203520865, 14212.00515963883, 14267.714645707132, 3572.392693242129, 3619.7647152935238, 3619.8009109498967, 3624.52881125452, 3626.89119326418, 107201.31996700144, 133360.3331983334, 134161.0, 136760.0, 136902.0, 13536.864631353757, 13715.039947203799, 13779.311034448237, 13851.30743462843, 13951.232682202577, 22899.08403663868, 22946.196883109344, 23249.605023698634, 23891.0, 24953.126640567494, 7893.013373328334, 7940.16628254025, 8007.0, 8130.146334634896, 8161.387895907831, 3992.8802135935966, 4040.5353384360587, 4042.7776472293717, 4066.2274167908595, 4070.3690927906223, 4341.500727416387, 4366.323219900921, 4450.265706158448, 4482.238019536687, 4487.237169681162, 830.5349004557468, 956.1681337236648, 963.7927845513249, 967.02330646048, 968.9660861869801, 642.1202951955851, 644.320242144542, 674.3122015544118, 676.807109973665, 676.8409423785406, 10761.085307748772, 11845.0, 11985.64043078709, 12074.335911524775, 12096.455659495345, 650.3139188156446, 650.5868773328971, 658.6904155047121, 667.3793372163934, 681.2200030964518, 5492.423295553989, 5606.299212598426, 5621.915671264935, 5708.200851880657, 5716.314042314865, 107041.46479267554, 109545.0, 109851.90148098576, 110486.0, 114468.0, 94430.52784736032, 97249.5137524322, 97999.06002819927, 98293.50853245688, 100152.49923750335, 76738.99999999888, 77610.6119469399, 84774.57612711897, 85536.0, 86529.0, 8807.0, 10511.211659125749, 12034.699132521757, 12054.939725301318, 12145.574904878287, 39430.408543871294, 39580.40629390619, 40391.39412908867, 40785.1842963145, 40941.0, 51685.44943651697, 52582.685432862956, 70921.29078709146, 72252.0, 74174.0, 14923.776143357642, 15383.461653834527, 16254.187290635657, 16510.83489165141, 16559.586010349838, 17594.03232822207, 18132.546686332946, 18435.53911152232, 18454.89270643766, 18570.0, 14227.50203742864, 15894.205289735699, 16405.507834764976, 16784.496465106065, 16856.831431686016, 16065.75901361504, 16079.75880361819, 16371.181440928143, 16538.751918720987, 16621.584460388105, 15743.13412762309, 16116.435924742578, 16281.755773663168, 16321.26554305083, 16324.18379081065, 10730.195235357223, 10932.234743567873, 11047.944760276147, 11405.942970285427, 11876.703082423008, 11964.820527691918, 13126.015548834066, 13147.802782958071, 13160.276184809545, 13345.266010369134], "value": 8497.537079088379, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 110.0, 113.0, 109.0, 108.0, 115.0, 114.0, 111.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 111.0, 111.0, 167.0, 143.0, 111.0, 108.0, 115.0, 135.0, 112.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 203.0, 200.0, 213.0, 209.0, 228.0, 197.0, 203.0, 197.0, 198.0], "value": 204.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 61.0, 86.0, 72.0, 91.0, 59.0, 56.0, 73.0, 61.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 82.0, 75.0, 70.0, 70.0, 89.0, 72.0, 70.0, 90.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 91.0, 92.0, 90.0, 91.0, 91.0, 92.0, 91.0, 118.0, 137.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 98.0, 102.0, 98.0, 97.0, 99.0, 98.0, 98.0, 121.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 117.0, 142.0, 91.0, 93.0, 94.0, 90.0, 93.0, 94.0], "value": 99.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 50.0, 51.0, 50.0, 50.0, 52.0, 52.0, 51.0, 52.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 79.0, 82.0, 62.0, 61.0, 57.0, 58.0, 59.0, 86.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 86.0, 84.0, 84.0, 84.0, 83.0, 84.0, 83.0, 85.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 174.0, 152.0, 149.0, 151.0, 159.0, 151.0, 133.0, 201.0, 151.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 220.0, 254.0, 215.0, 262.0, 255.0, 194.0, 193.0, 194.0, 185.0], "value": 216.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 71.0, 63.0, 74.0, 99.0, 103.0, 102.0, 72.0, 73.0, 73.0], "value": 82.9, "unit": "score"}]}]} 05:53:58 INFO - Return code: 0 05:53:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:58 ERROR - # TBPL SUCCESS # 05:53:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:58 INFO - 2017-04-28 05:53:58.599 screenresolution[1653:10660] starting screenresolution argv=screenresolution get 05:53:58 INFO - 2017-04-28 05:53:58.602 screenresolution[1653:10660] Display 0: 1600x1200x32@60 05:53:58 INFO - 2017-04-28 05:53:58.608 screenresolution[1654:10663] starting screenresolution argv=screenresolution list 05:53:58 INFO - Available Modes on Display 0 05:53:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:58 INFO - Intel Iris: 05:53:58 INFO - Chipset Model: Intel Iris 05:53:58 INFO - Type: GPU 05:53:58 INFO - Bus: Built-In 05:53:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:58 INFO - Vendor: Intel (0x8086) 05:53:58 INFO - Device ID: 0x0a2e 05:53:58 INFO - Revision ID: 0x0009 05:53:58 INFO - Displays: 05:53:58 INFO - Display: 05:53:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:58 INFO - Display Serial Number: 1600x1200 60 05:53:58 INFO - Main Display: Yes 05:53:58 INFO - Mirror: Off 05:53:58 INFO - Online: Yes 05:53:58 INFO - Rotation: Supported 05:53:58 INFO - Return code: 0 05:53:58 INFO - Running post-action listener: _resource_record_post_action 05:53:58 INFO - [mozharness: 2017-04-28 12:53:58.844174Z] Finished run-tests step (success) 05:53:58 INFO - Running post-run listener: _resource_record_post_run 05:53:58 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40077824; Write bytes: 514618368; Read time: 270; Write time: 1642 05:53:58 INFO - TinderboxPrint: CPU usage
54.2% 05:53:58 INFO - TinderboxPrint: I/O read bytes / time
40,077,824 / 270 05:53:58 INFO - TinderboxPrint: I/O write bytes / time
514,618,368 / 1,642 05:53:58 INFO - TinderboxPrint: CPU idle
2,194.6 (45.8%) 05:53:58 INFO - TinderboxPrint: CPU system
967.5 (20.2%) 05:53:58 INFO - TinderboxPrint: CPU user
1,631.7 (34.0%) 05:53:58 INFO - TinderboxPrint: Swap in / out
247,701,504 / 0 05:53:58 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206381568; Write bytes: 206297088; Read time: 15993; Write time: 458 05:53:58 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37898752; Write bytes: 301251584; Read time: 248; Write time: 1155 05:53:59 INFO - Running post-run listener: _upload_blobber_files 05:53:59 INFO - Blob upload gear active. 05:53:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:59 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 05:53:59 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'] 05:53:59 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 05:53:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:00 INFO - (blobuploader) - INFO - Done attempting. 05:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:01 INFO - (blobuploader) - INFO - Done attempting. 05:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:03 INFO - (blobuploader) - INFO - Done attempting. 05:54:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:54:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:54:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:05 INFO - (blobuploader) - INFO - Done attempting. 05:54:05 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:05 INFO - Return code: 0 05:54:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:54:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83d51f86023508f41001a964f10ede6c7fb70a0172f77af0fdb24aab4a788a1561a5c315fe28286b511570635049abe8c49ab23d1e99a00622ead2baaa38e83b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9c8b92f89bca373de1db1fad3e3a48f289837c84730a19845872cbc00b322306a9eee6209ef4513a453167af9c3bac3d9d91cc3508e573b07f5eb6791bdc1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c284768cbe8bd9b913b195a613d85b14e617e0baa7faf27a17a9f9db9ae751168690cedc192178378cdd7f8250ce96d80e31bf20b7b435dcabb7ae7b283284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb9dcb4366e93d02b909a4e4030e99290684129779f51b8273a47d4dcaeead23c3fe248b30ea7ad80b9474189b33abe573ee204cc8a322bdec5d4be894603fb7"} 05:54:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:54:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:54:05 INFO - Contents: 05:54:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83d51f86023508f41001a964f10ede6c7fb70a0172f77af0fdb24aab4a788a1561a5c315fe28286b511570635049abe8c49ab23d1e99a00622ead2baaa38e83b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9c8b92f89bca373de1db1fad3e3a48f289837c84730a19845872cbc00b322306a9eee6209ef4513a453167af9c3bac3d9d91cc3508e573b07f5eb6791bdc1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c284768cbe8bd9b913b195a613d85b14e617e0baa7faf27a17a9f9db9ae751168690cedc192178378cdd7f8250ce96d80e31bf20b7b435dcabb7ae7b283284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb9dcb4366e93d02b909a4e4030e99290684129779f51b8273a47d4dcaeead23c3fe248b30ea7ad80b9474189b33abe573ee204cc8a322bdec5d4be894603fb7"} 05:54:05 INFO - Running post-run listener: copy_logs_to_upload_dir 05:54:05 INFO - Copying logs to upload dir... 05:54:05 INFO - mkdir: /builds/slave/test/build/upload/logs 05:54:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.667838 ========= master_lag: 1.85 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-28 05:54:07.290011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 05:54:07.293581) ========= 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.zUT56RqnoC/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.ifNe4OzgvV/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83d51f86023508f41001a964f10ede6c7fb70a0172f77af0fdb24aab4a788a1561a5c315fe28286b511570635049abe8c49ab23d1e99a00622ead2baaa38e83b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9c8b92f89bca373de1db1fad3e3a48f289837c84730a19845872cbc00b322306a9eee6209ef4513a453167af9c3bac3d9d91cc3508e573b07f5eb6791bdc1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c284768cbe8bd9b913b195a613d85b14e617e0baa7faf27a17a9f9db9ae751168690cedc192178378cdd7f8250ce96d80e31bf20b7b435dcabb7ae7b283284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb9dcb4366e93d02b909a4e4030e99290684129779f51b8273a47d4dcaeead23c3fe248b30ea7ad80b9474189b33abe573ee204cc8a322bdec5d4be894603fb7"} build_url:https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011529 build_url: 'https://queue.taskcluster.net/v1/task/FQ5NpCH8SqezZnpZ_nsqLA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83d51f86023508f41001a964f10ede6c7fb70a0172f77af0fdb24aab4a788a1561a5c315fe28286b511570635049abe8c49ab23d1e99a00622ead2baaa38e83b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9c8b92f89bca373de1db1fad3e3a48f289837c84730a19845872cbc00b322306a9eee6209ef4513a453167af9c3bac3d9d91cc3508e573b07f5eb6791bdc1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c284768cbe8bd9b913b195a613d85b14e617e0baa7faf27a17a9f9db9ae751168690cedc192178378cdd7f8250ce96d80e31bf20b7b435dcabb7ae7b283284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb9dcb4366e93d02b909a4e4030e99290684129779f51b8273a47d4dcaeead23c3fe248b30ea7ad80b9474189b33abe573ee204cc8a322bdec5d4be894603fb7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 05:54:07.335092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:54:07.335439) ========= 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.zUT56RqnoC/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.ifNe4OzgvV/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005140 ========= master_lag: 0.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 05:54:07.583137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 05:54:07.583442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 05:54:07.583760) ========= ========= Total master_lag: 2.20 =========