builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0284 starttime: 1492256086.63 results: success (0) buildid: 20170415030205 builduid: 585cfe114bf742d0b76e4fa43b77292c revision: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.626374) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.627205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.627485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.654572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.654916) ========= 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.munbnufUA4/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.KehKitXzbs/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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-15 04:34:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 54.3M=0s 2017-04-15 04:34:46 (54.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132770 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.813588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.813939) ========= 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.munbnufUA4/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.KehKitXzbs/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.025885 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:46.877051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-15 04:34:46.877680) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 --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 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.munbnufUA4/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.KehKitXzbs/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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-15 04:34:46,986 truncating revision to first 12 chars 2017-04-15 04:34:46,986 Setting DEBUG logging. 2017-04-15 04:34:46,986 attempt 1/10 2017-04-15 04:34:46,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9379831bb9c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-15 04:34:48,094 unpacking tar archive at: mozilla-central-9379831bb9c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392964 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-15 04:34:48.394538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:48.394849) ========= script_repo_revision: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:48.395282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:48.395559) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-15 04:34:48.422198) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-15 04:34:48.422495) ========= /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.munbnufUA4/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.KehKitXzbs/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:34:48 INFO - MultiFileLogger online at 20170415 04:34:48 in /builds/slave/test 04:34:48 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 04:34:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:34:48 INFO - {'append_to_log': False, 04:34:48 INFO - 'base_work_dir': '/builds/slave/test', 04:34:48 INFO - 'blob_upload_branch': 'Firefox', 04:34:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:34:48 INFO - 'branch': 'Firefox', 04:34:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:34:48 INFO - 'config_files': ('talos/mac_config.py',), 04:34:48 INFO - 'default_actions': ('clobber', 04:34:48 INFO - 'read-buildbot-config', 04:34:48 INFO - 'download-and-extract', 04:34:48 INFO - 'populate-webroot', 04:34:48 INFO - 'create-virtualenv', 04:34:48 INFO - 'install', 04:34:48 INFO - 'run-tests'), 04:34:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:34:48 INFO - 'download_minidump_stackwalk': True, 04:34:48 INFO - 'download_symbols': 'ondemand', 04:34:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:34:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:34:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:34:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:34:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:34:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:34:48 INFO - 'gecko_profile': False, 04:34:48 INFO - 'gecko_profile_interval': 0, 04:34:48 INFO - 'installer_path': 'installer.exe', 04:34:48 INFO - 'log_level': 'info', 04:34:48 INFO - 'log_name': 'talos', 04:34:48 INFO - 'log_to_console': True, 04:34:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:34:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:34:48 INFO - 'opt_config_files': (), 04:34:48 INFO - 'pip_index': False, 04:34:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:48 INFO - 'cmd': ('bash', 04:34:48 INFO - '-c', 04:34:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:48 INFO - 'enabled': True, 04:34:48 INFO - 'halt_on_failure': False, 04:34:48 INFO - 'name': 'check_screen_resolution'},), 04:34:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:48 INFO - 'cmd': ('bash', 04:34:48 INFO - '-c', 04:34:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:48 INFO - 'enabled': True, 04:34:48 INFO - 'halt_on_failure': False, 04:34:48 INFO - 'name': 'check_screen_resolution'},), 04:34:48 INFO - 'run_cmd_checks_enabled': True, 04:34:48 INFO - 'suite': 'dromaeojs-e10s', 04:34:48 INFO - 'system_bits': '32', 04:34:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:34:48 INFO - 'title': 't-yosemite-r7-0284', 04:34:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:34:48 INFO - 'use_talos_json': True, 04:34:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:34:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:34:48 INFO - 'work_dir': 'build'} 04:34:48 INFO - [mozharness: 2017-04-15 11:34:48.637462Z] Running clobber step. 04:34:48 INFO - Running pre-action listener: _resource_record_pre_action 04:34:48 INFO - Running main action method: clobber 04:34:48 INFO - rmtree: /builds/slave/test/build 04:34:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:51 INFO - Running post-action listener: _resource_record_post_action 04:34:51 INFO - [mozharness: 2017-04-15 11:34:51.056892Z] Finished clobber step (success) 04:34:51 INFO - [mozharness: 2017-04-15 11:34:51.057090Z] Running read-buildbot-config step. 04:34:51 INFO - Running pre-action listener: _resource_record_pre_action 04:34:51 INFO - Running main action method: read_buildbot_config 04:34:51 INFO - Using buildbot properties: 04:34:51 INFO - { 04:34:51 INFO - "project": "", 04:34:51 INFO - "product": "firefox", 04:34:51 INFO - "script_repo_revision": "production", 04:34:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:34:51 INFO - "repository": "", 04:34:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:34:51 INFO - "buildid": "20170415030205", 04:34:51 INFO - "stage_platform": "macosx64", 04:34:51 INFO - "basedir": "/builds/slave/test", 04:34:51 INFO - "nightly_build": "True", 04:34:51 INFO - "buildnumber": 23, 04:34:51 INFO - "slavename": "t-yosemite-r7-0284", 04:34:51 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:34:51 INFO - "platform": "yosemite_r7", 04:34:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:34:51 INFO - "branch": "mozilla-central", 04:34:51 INFO - "repo_path": "mozilla-central", 04:34:51 INFO - "revision": "9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4", 04:34:51 INFO - "pgo_build": "False", 04:34:51 INFO - "builduid": "585cfe114bf742d0b76e4fa43b77292c", 04:34:51 INFO - "slavebuilddir": "test" 04:34:51 INFO - } 04:34:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:34:51 INFO - Running post-action listener: _resource_record_post_action 04:34:51 INFO - [mozharness: 2017-04-15 11:34:51.060317Z] Finished read-buildbot-config step (success) 04:34:51 INFO - [mozharness: 2017-04-15 11:34:51.060453Z] Running download-and-extract step. 04:34:51 INFO - Running pre-action listener: _resource_record_pre_action 04:34:51 INFO - Running main action method: download_and_extract 04:34:51 INFO - mkdir: /builds/slave/test/build/tests 04:34:51 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')]} 04:34:51 INFO - trying https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:34:51 INFO - Downloading https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/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 04:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/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 04:34:52 INFO - Downloaded 1325 bytes. 04:34:52 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:34:52 INFO - Using the following test package requirements: 04:34:52 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:34:52 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:34:52 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:34:52 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:34:52 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'jsshell-mac.zip'], 04:34:52 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:34:52 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:34:52 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:34:52 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:34:52 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:34:52 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:34:52 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:34:52 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:34:54 INFO - Expected file size: 52596373 04:34:54 INFO - Obtained file size: 52596373 04:35:10 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 04:35:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:35:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:35:10 INFO - Fetch https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:35:12 INFO - Expected file size: 52596373 04:35:12 INFO - Obtained file size: 52596373 04:35:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:35:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:35:27 INFO - Fetch https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:35:28 INFO - Expected file size: 14408853 04:35:28 INFO - Obtained file size: 14408853 04:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:29 INFO - trying https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:35:29 INFO - Downloading https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:35:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/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 04:35:31 INFO - Downloaded 71185907 bytes. 04:35:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:35:31 INFO - mkdir: /builds/slave/test/properties 04:35:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:35:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:35:31 INFO - Contents: 04:35:31 INFO - build_url:https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:35:32 INFO - Running post-action listener: _resource_record_post_action 04:35:32 INFO - Running post-action listener: set_extra_try_arguments 04:35:32 INFO - [mozharness: 2017-04-15 11:35:32.381620Z] Finished download-and-extract step (success) 04:35:32 INFO - [mozharness: 2017-04-15 11:35:32.381761Z] Running populate-webroot step. 04:35:32 INFO - Running pre-action listener: _resource_record_pre_action 04:35:32 INFO - Running main action method: populate_webroot 04:35:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:35:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:35:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:35:32 INFO - '--tppagecycles', 04:35:32 INFO - '7'], 04:35:32 INFO - 'tests': ['tsvgm']}}, 04:35:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:35:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:35:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:35:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:35:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:35:32 INFO - 'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:35:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:35:32 INFO - 'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['damp', 'tps']}, 04:35:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:35:32 INFO - 'tests': ['damp', 'tps']}, 04:35:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['dromaeo_dom']}, 04:35:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:35:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:35:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:35:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['a11yr', 04:35:32 INFO - 'ts_paint', 04:35:32 INFO - 'tpaint', 04:35:32 INFO - 'sessionrestore', 04:35:32 INFO - 'sessionrestore_no_auto_restore', 04:35:32 INFO - 'tabpaint']}, 04:35:32 INFO - 'other-e10s': {'tests': ['a11yr', 04:35:32 INFO - 'ts_paint', 04:35:32 INFO - 'tpaint', 04:35:32 INFO - 'sessionrestore', 04:35:32 INFO - 'sessionrestore_no_auto_restore', 04:35:32 INFO - 'tabpaint']}, 04:35:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:35:32 INFO - 'ts_paint', 04:35:32 INFO - 'tpaint', 04:35:32 INFO - 'sessionrestore', 04:35:32 INFO - 'sessionrestore_no_auto_restore', 04:35:32 INFO - 'tabpaint']}, 04:35:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:35:32 INFO - 'ts_paint', 04:35:32 INFO - 'tpaint', 04:35:32 INFO - 'sessionrestore', 04:35:32 INFO - 'sessionrestore_no_auto_restore', 04:35:32 INFO - 'tabpaint']}, 04:35:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['a11yr', 04:35:32 INFO - 'ts_paint', 04:35:32 INFO - 'tpaint', 04:35:32 INFO - 'sessionrestore', 04:35:32 INFO - 'sessionrestore_no_auto_restore', 04:35:32 INFO - 'tabpaint']}, 04:35:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['a11yr', 04:35:32 INFO - 'ts_paint', 04:35:32 INFO - 'tpaint', 04:35:32 INFO - 'sessionrestore', 04:35:32 INFO - 'sessionrestore_no_auto_restore', 04:35:32 INFO - 'tabpaint']}, 04:35:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:35:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:35:32 INFO - 'bloom_basic_ref']}, 04:35:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['tsvgx', 04:35:32 INFO - 'tsvgr_opacity', 04:35:32 INFO - 'tart', 04:35:32 INFO - 'tscrollx', 04:35:32 INFO - 'cart', 04:35:32 INFO - 'tsvg_static']}, 04:35:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:35:32 INFO - 'tsvgr_opacity', 04:35:32 INFO - 'tart', 04:35:32 INFO - 'tscrollx', 04:35:32 INFO - 'cart', 04:35:32 INFO - 'tsvg_static']}, 04:35:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:35:32 INFO - 'talos_options': ['--disable-e10s'], 04:35:32 INFO - 'tests': ['tp5o']}, 04:35:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:35:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:35:32 INFO - 'talos_options': ['--disable-e10s', 04:35:32 INFO - '--xperf_path', 04:35:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:32 INFO - 'tests': ['tp5n']}, 04:35:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:35:32 INFO - 'talos_options': ['--xperf_path', 04:35:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:32 INFO - 'tests': ['tp5n']}}, 04:35:32 INFO - 'talos.zip': {'path': '', 04:35:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:35:32 INFO - Running post-action listener: _resource_record_post_action 04:35:32 INFO - [mozharness: 2017-04-15 11:35:32.400786Z] Finished populate-webroot step (success) 04:35:32 INFO - [mozharness: 2017-04-15 11:35:32.400897Z] Running create-virtualenv step. 04:35:32 INFO - Running pre-action listener: _resource_record_pre_action 04:35:32 INFO - Running main action method: create_virtualenv 04:35:32 INFO - Creating virtualenv /builds/slave/test/build/venv 04:35:32 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 04:35:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:35:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:35:32 INFO - Using real prefix '/tools/python27' 04:35:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:35:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:36 INFO - Installing pip.................done. 04:35:36 INFO - Return code: 0 04:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:35:36 INFO - Reading from file tmpfile_stdout 04:35:36 INFO - Output received: 04:35:36 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) 04:35:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:36 INFO - 'HOME': '/Users/cltbld', 04:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:36 INFO - 'LOGNAME': 'cltbld', 04:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:36 INFO - 'MOZ_NO_REMOTE': '1', 04:35:36 INFO - 'NO_EM_RESTART': '1', 04:35:36 INFO - 'PAGER': '/bin/cat', 04:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:36 INFO - 'PWD': '/builds/slave/test', 04:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:36 INFO - 'SHELL': '/bin/bash', 04:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:36 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:36 INFO - 'USER': 'cltbld', 04:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:36 INFO - 'XPC_FLAGS': '0x0', 04:35:36 INFO - 'XPC_SERVICE_NAME': '0', 04:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:36 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 04:35:36 INFO - Cleaning up... 04:35:36 INFO - Return code: 0 04:35:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:36 INFO - 'HOME': '/Users/cltbld', 04:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:36 INFO - 'LOGNAME': 'cltbld', 04:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:36 INFO - 'MOZ_NO_REMOTE': '1', 04:35:36 INFO - 'NO_EM_RESTART': '1', 04:35:36 INFO - 'PAGER': '/bin/cat', 04:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:36 INFO - 'PWD': '/builds/slave/test', 04:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:36 INFO - 'SHELL': '/bin/bash', 04:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:36 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:36 INFO - 'USER': 'cltbld', 04:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:36 INFO - 'XPC_FLAGS': '0x0', 04:35:36 INFO - 'XPC_SERVICE_NAME': '0', 04:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:36 INFO - Downloading/unpacking psutil>=3.1.1 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35: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 04:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:40 INFO - Installing collected packages: psutil 04:35:40 INFO - Running setup.py install for psutil 04:35:41 INFO - building 'psutil._psutil_osx' extension 04:35:41 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 04:35:41 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 04:35:41 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 04:35:41 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 04:35:41 INFO - building 'psutil._psutil_posix' extension 04:35:41 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 04:35:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:35:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:35:41 INFO - ^ 04:35:41 INFO - 1 warning generated. 04:35:41 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 04:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:42 INFO - Successfully installed psutil 04:35:42 INFO - Cleaning up... 04:35:42 INFO - Return code: 0 04:35:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:35:42 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')]} 04:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:42 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')]} 04:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:42 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:42 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 04:35:42 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 04:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:42 INFO - 'HOME': '/Users/cltbld', 04:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:42 INFO - 'LOGNAME': 'cltbld', 04:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:42 INFO - 'MOZ_NO_REMOTE': '1', 04:35:42 INFO - 'NO_EM_RESTART': '1', 04:35:42 INFO - 'PAGER': '/bin/cat', 04:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:42 INFO - 'PWD': '/builds/slave/test', 04:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:42 INFO - 'SHELL': '/bin/bash', 04:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:42 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:42 INFO - 'USER': 'cltbld', 04:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:42 INFO - 'XPC_FLAGS': '0x0', 04:35:42 INFO - 'XPC_SERVICE_NAME': '0', 04:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:35:45 INFO - Installing collected packages: mozsystemmonitor 04:35:45 INFO - Running setup.py install for mozsystemmonitor 04:35:45 INFO - Successfully installed mozsystemmonitor 04:35:45 INFO - Cleaning up... 04:35:45 INFO - Return code: 0 04:35:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:45 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:45 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 04:35:45 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 04:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:45 INFO - 'HOME': '/Users/cltbld', 04:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:45 INFO - 'LOGNAME': 'cltbld', 04:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:45 INFO - 'MOZ_NO_REMOTE': '1', 04:35:45 INFO - 'NO_EM_RESTART': '1', 04:35:45 INFO - 'PAGER': '/bin/cat', 04:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:45 INFO - 'PWD': '/builds/slave/test', 04:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:45 INFO - 'SHELL': '/bin/bash', 04:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:45 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:45 INFO - 'USER': 'cltbld', 04:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:45 INFO - 'XPC_FLAGS': '0x0', 04:35:45 INFO - 'XPC_SERVICE_NAME': '0', 04:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:35:45 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 04:35:45 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 04:35:45 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 04:35:45 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 04:35:45 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 04:35:45 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 04:35:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:48 INFO - warning: no files found matching '*.txt' 04:35:48 INFO - no previously-included directories found matching 'build' 04:35:48 INFO - no previously-included directories found matching 'dist' 04:35:48 INFO - no previously-included directories found matching '.git*' 04:35:48 INFO - Installing collected packages: jsonschema, functools32 04:35:48 INFO - Running setup.py install for functools32 04:35:49 INFO - warning: no files found matching '*.txt' 04:35:49 INFO - no previously-included directories found matching 'build' 04:35:49 INFO - no previously-included directories found matching 'dist' 04:35:49 INFO - no previously-included directories found matching '.git*' 04:35:49 INFO - Successfully installed jsonschema functools32 04:35:49 INFO - Cleaning up... 04:35:49 INFO - Return code: 0 04:35:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:49 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:49 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 04:35:49 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 04:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:49 INFO - 'HOME': '/Users/cltbld', 04:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:49 INFO - 'LOGNAME': 'cltbld', 04:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:49 INFO - 'MOZ_NO_REMOTE': '1', 04:35:49 INFO - 'NO_EM_RESTART': '1', 04:35:49 INFO - 'PAGER': '/bin/cat', 04:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:49 INFO - 'PWD': '/builds/slave/test', 04:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:49 INFO - 'SHELL': '/bin/bash', 04:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:49 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:49 INFO - 'USER': 'cltbld', 04:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:49 INFO - 'XPC_FLAGS': '0x0', 04:35:49 INFO - 'XPC_SERVICE_NAME': '0', 04:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:35:49 INFO - Cleaning up... 04:35:49 INFO - Return code: 0 04:35:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:49 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:49 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 04:35:49 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 04:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:49 INFO - 'HOME': '/Users/cltbld', 04:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:49 INFO - 'LOGNAME': 'cltbld', 04:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:49 INFO - 'MOZ_NO_REMOTE': '1', 04:35:49 INFO - 'NO_EM_RESTART': '1', 04:35:49 INFO - 'PAGER': '/bin/cat', 04:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:49 INFO - 'PWD': '/builds/slave/test', 04:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:49 INFO - 'SHELL': '/bin/bash', 04:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:49 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:49 INFO - 'USER': 'cltbld', 04:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:49 INFO - 'XPC_FLAGS': '0x0', 04:35:49 INFO - 'XPC_SERVICE_NAME': '0', 04:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:49 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 04:35:49 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 04:35:49 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 04:35:49 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 04:35:49 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 04:35:49 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 04:35:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:53 INFO - Downloading docopt-0.6.1.tar.gz 04:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:53 INFO - Running setup.py install for blobuploader 04:35:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:53 INFO - Running setup.py install for requests 04:35:54 INFO - Running setup.py install for docopt 04:35:54 INFO - Successfully installed blobuploader requests docopt 04:35:54 INFO - Cleaning up... 04:35:54 INFO - Return code: 0 04:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:54 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:54 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 04:35:54 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 04:35:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:54 INFO - 'HOME': '/Users/cltbld', 04:35:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:54 INFO - 'LOGNAME': 'cltbld', 04:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:54 INFO - 'MOZ_NO_REMOTE': '1', 04:35:54 INFO - 'NO_EM_RESTART': '1', 04:35:54 INFO - 'PAGER': '/bin/cat', 04:35:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:54 INFO - 'PWD': '/builds/slave/test', 04:35:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:54 INFO - 'SHELL': '/bin/bash', 04:35:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:54 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:54 INFO - 'USER': 'cltbld', 04:35:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:54 INFO - 'XPC_FLAGS': '0x0', 04:35:54 INFO - 'XPC_SERVICE_NAME': '0', 04:35:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:54 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-eRIlet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:54 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-LTeYXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:54 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ppwtz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-H9z9X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-7nJXYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Xf_8wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-spRY3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-pAzc7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ubiTIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-kmZwpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-u0OnPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-8MCjjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:55 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-eYO40d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:56 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-l_90EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:56 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-YvApg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:56 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-FybSYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:56 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-E4bZd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:56 INFO - Running setup.py install for manifestparser 04:35:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:56 INFO - Running setup.py install for mozcrash 04:35:56 INFO - Running setup.py install for mozdebug 04:35:56 INFO - Running setup.py install for mozdevice 04:35:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Running setup.py install for mozfile 04:35:57 INFO - Running setup.py install for mozhttpd 04:35:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Running setup.py install for mozinfo 04:35:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Running setup.py install for mozInstall 04:35:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Running setup.py install for mozleak 04:35:57 INFO - Running setup.py install for mozlog 04:35:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:57 INFO - Running setup.py install for moznetwork 04:35:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Running setup.py install for mozprocess 04:35:58 INFO - Running setup.py install for mozprofile 04:35:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Running setup.py install for mozrunner 04:35:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:58 INFO - Running setup.py install for mozscreenshot 04:35:58 INFO - Running setup.py install for moztest 04:35:58 INFO - Running setup.py install for mozversion 04:35:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:59 INFO - Cleaning up... 04:35:59 INFO - Return code: 0 04:35:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35: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')]} 04:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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')]} 04:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:59 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:35:59 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 04:35:59 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 04:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:59 INFO - 'HOME': '/Users/cltbld', 04:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:59 INFO - 'LOGNAME': 'cltbld', 04:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:59 INFO - 'MOZ_NO_REMOTE': '1', 04:35:59 INFO - 'NO_EM_RESTART': '1', 04:35:59 INFO - 'PAGER': '/bin/cat', 04:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:59 INFO - 'PWD': '/builds/slave/test', 04:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:59 INFO - 'SHELL': '/bin/bash', 04:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:35:59 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:59 INFO - 'USER': 'cltbld', 04:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:59 INFO - 'XPC_FLAGS': '0x0', 04:35:59 INFO - 'XPC_SERVICE_NAME': '0', 04:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:59 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-0kqjGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:59 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)) 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:59 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-PxcT4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:59 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)) 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:59 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-4ZmjXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:59 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)) 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:59 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-c3tPNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:59 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)) 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:59 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Ao_F35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:59 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)) 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:59 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-twfmSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:59 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)) 04:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:59 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-EQJTvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-yd0QCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-QAvgxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-JUayCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-uJuCfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-5PrS5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-mn0zMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-zy1Gkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-xQ3hej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:00 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)) 04:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:00 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-q4puvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:01 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)) 04:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-n810Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:01 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)) 04:36:01 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)) 04:36:01 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)) 04:36:01 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)) 04:36:01 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)) 04:36:01 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)) 04:36:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:03 INFO - Downloading blessings-1.6.tar.gz 04:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:03 INFO - Installing collected packages: blessings 04:36:03 INFO - Running setup.py install for blessings 04:36:03 INFO - Successfully installed blessings 04:36:03 INFO - Cleaning up... 04:36:04 INFO - Return code: 0 04:36:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:04 INFO - Reading from file tmpfile_stdout 04:36:04 INFO - Current package versions: 04:36:04 INFO - blessings == 1.6 04:36:04 INFO - blobuploader == 1.2.4 04:36:04 INFO - docopt == 0.6.1 04:36:04 INFO - functools32 == 3.2.3-2 04:36:04 INFO - jsonschema == 2.5.1 04:36:04 INFO - manifestparser == 1.1 04:36:04 INFO - mozInstall == 1.12 04:36:04 INFO - mozcrash == 1.0 04:36:04 INFO - mozdebug == 0.1 04:36:04 INFO - mozdevice == 0.50 04:36:04 INFO - mozfile == 1.2 04:36:04 INFO - mozhttpd == 0.7 04:36:04 INFO - mozinfo == 0.9 04:36:04 INFO - mozleak == 0.1 04:36:04 INFO - mozlog == 3.4 04:36:04 INFO - moznetwork == 0.27 04:36:04 INFO - mozprocess == 0.25 04:36:04 INFO - mozprofile == 0.28 04:36:04 INFO - mozrunner == 6.13 04:36:04 INFO - mozscreenshot == 0.1 04:36:04 INFO - mozsystemmonitor == 0.3 04:36:04 INFO - moztest == 0.8 04:36:04 INFO - mozversion == 1.4 04:36:04 INFO - psutil == 3.1.1 04:36:04 INFO - requests == 1.2.3 04:36:04 INFO - wsgiref == 0.1.2 04:36:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:04 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')]} 04:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:04 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')]} 04:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:04 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:36:04 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 04:36:04 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 04:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:04 INFO - 'HOME': '/Users/cltbld', 04:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:04 INFO - 'LOGNAME': 'cltbld', 04:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:04 INFO - 'MOZ_NO_REMOTE': '1', 04:36:04 INFO - 'NO_EM_RESTART': '1', 04:36:04 INFO - 'PAGER': '/bin/cat', 04:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:04 INFO - 'PWD': '/builds/slave/test', 04:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:04 INFO - 'SHELL': '/bin/bash', 04:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:36:04 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:04 INFO - 'USER': 'cltbld', 04:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:04 INFO - 'XPC_FLAGS': '0x0', 04:36:04 INFO - 'XPC_SERVICE_NAME': '0', 04:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 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)) 04:36:04 INFO - Cleaning up... 04:36:04 INFO - Return code: 0 04:36:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36:04 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')]} 04:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:04 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')]} 04:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:04 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 0x101af6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a5888f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, '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.munbnufUA4/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.KehKitXzbs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 04:36:04 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 04:36:04 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 04:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:04 INFO - 'HOME': '/Users/cltbld', 04:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:04 INFO - 'LOGNAME': 'cltbld', 04:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:04 INFO - 'MOZ_NO_REMOTE': '1', 04:36:04 INFO - 'NO_EM_RESTART': '1', 04:36:04 INFO - 'PAGER': '/bin/cat', 04:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:04 INFO - 'PWD': '/builds/slave/test', 04:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:04 INFO - 'SHELL': '/bin/bash', 04:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:36:04 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:04 INFO - 'USER': 'cltbld', 04:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:04 INFO - 'XPC_FLAGS': '0x0', 04:36:04 INFO - 'XPC_SERVICE_NAME': '0', 04:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:04 INFO - Cleaning up... 04:36:04 INFO - Return code: 0 04:36:04 INFO - Running post-action listener: _resource_record_post_action 04:36:04 INFO - Running post-action listener: _start_resource_monitoring 04:36:04 INFO - Starting resource monitoring. 04:36:04 INFO - [mozharness: 2017-04-15 11:36:04.931165Z] Finished create-virtualenv step (success) 04:36:04 INFO - [mozharness: 2017-04-15 11:36:04.932106Z] Running install step. 04:36:04 INFO - Running pre-action listener: _resource_record_pre_action 04:36:04 INFO - Running main action method: install 04:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:05 INFO - Reading from file tmpfile_stdout 04:36:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:05 INFO - Reading from file tmpfile_stdout 04:36:05 INFO - Output received: 04:36:05 INFO - Usage: mozinstall [options] installer 04:36:05 INFO - Options: 04:36:05 INFO - -h, --help show this help message and exit 04:36:05 INFO - -d DEST, --destination=DEST 04:36:05 INFO - Directory to install application into. [default: 04:36:05 INFO - "/builds/slave/test"] 04:36:05 INFO - --app=APP Application being installed. [default: firefox] 04:36:05 INFO - mkdir: /builds/slave/test/build/application 04:36:05 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'] 04:36:05 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 04:36:25 INFO - Reading from file tmpfile_stdout 04:36:25 INFO - Output received: 04:36:25 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:36:25 INFO - Running post-action listener: _resource_record_post_action 04:36:25 INFO - [mozharness: 2017-04-15 11:36:25.169025Z] Finished install step (success) 04:36:25 INFO - [mozharness: 2017-04-15 11:36:25.169185Z] Running run-tests step. 04:36:25 INFO - Running pre-action listener: _resource_record_pre_action 04:36:25 INFO - Running main action method: run_tests 04:36:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:36:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:36:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:36:25 INFO - 2017-04-15 04:36:25.184 screenresolution[1664:10307] starting screenresolution argv=screenresolution get 04:36:25 INFO - 2017-04-15 04:36:25.186 screenresolution[1664:10307] Display 0: 1600x1200x32@60 04:36:25 INFO - 2017-04-15 04:36:25.192 screenresolution[1665:10310] starting screenresolution argv=screenresolution list 04:36:25 INFO - Available Modes on Display 0 04:36:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:36:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:36:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:36:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:36:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:36:25 INFO - Intel Iris: 04:36:25 INFO - Chipset Model: Intel Iris 04:36:25 INFO - Type: GPU 04:36:25 INFO - Bus: Built-In 04:36:25 INFO - VRAM (Dynamic, Max): 1536 MB 04:36:25 INFO - Vendor: Intel (0x8086) 04:36:25 INFO - Device ID: 0x0a2e 04:36:25 INFO - Revision ID: 0x0009 04:36:25 INFO - Displays: 04:36:25 INFO - Display: 04:36:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:36:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:36:25 INFO - Display Serial Number: 1600x1200 60 04:36:25 INFO - Main Display: Yes 04:36:25 INFO - Mirror: Off 04:36:25 INFO - Online: Yes 04:36:25 INFO - Rotation: Supported 04:36:25 INFO - Return code: 0 04:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:25 INFO - Python 2.7.3 04:36:25 INFO - Return code: 0 04:36:25 INFO - grabbing minidump binary from tooltool 04:36:25 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')]} 04:36:25 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 0x1018d4d30>, '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 0x1017fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:25 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 04:36:25 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 04:36:25 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 04:36:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:25 INFO - Return code: 0 04:36:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:36:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:25 INFO - ENV: RUST_BACKTRACE is now 1 04:36:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:36:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:25 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 04:36:25 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0284 --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 04:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.munbnufUA4/Render', 04:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:25 INFO - 'HOME': '/Users/cltbld', 04:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:25 INFO - 'LOGNAME': 'cltbld', 04:36:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:25 INFO - 'MOZ_NO_REMOTE': '1', 04:36:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:25 INFO - 'NO_EM_RESTART': '1', 04:36:25 INFO - 'PAGER': '/bin/cat', 04:36:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:25 INFO - 'PWD': '/builds/slave/test', 04:36:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:25 INFO - 'RUST_BACKTRACE': '1', 04:36:25 INFO - 'SHELL': '/bin/bash', 04:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KehKitXzbs/Listeners', 04:36:25 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 04:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:25 INFO - 'USER': 'cltbld', 04:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:25 INFO - 'XPC_FLAGS': '0x0', 04:36:25 INFO - 'XPC_SERVICE_NAME': '0', 04:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:25 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 04:36:25 INFO - mozversion application_buildid: 20170415030205 04:36:25 INFO - mozversion application_changeset: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 04:36:25 INFO - mozversion application_display_name: Nightly 04:36:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:25 INFO - mozversion application_name: Firefox 04:36:25 INFO - mozversion application_remotingname: firefox 04:36:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:36:25 INFO - mozversion application_vendor: Mozilla 04:36:25 INFO - mozversion application_version: 55.0a1 04:36:25 INFO - mozversion platform_buildid: 20170415030205 04:36:25 INFO - mozversion platform_changeset: 9379831bb9c3d9abfea7dbf8dd06dbdab1d81dc4 04:36:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:36:25 INFO - mozversion platform_version: 55.0a1 04:36:25 INFO - using testdate: 1492256185 04:36:25 INFO - actual date: 1492256185 04:36:25 INFO - starting webserver on 'localhost:49236' 04:36:25 INFO - SUITE-START | Running 2 tests 04:36:25 INFO - TEST-START | dromaeo_css 04:36:25 INFO - operating with platform_type : mac_ 04:36:25 INFO - Initialising browser for dromaeo_css test... 04:36:25 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpjUKjGD/profile http://localhost:49236/getInfo.html) 04:36:29 INFO - PID 1675 | 2017-04-15 04:36:29.106 plugin-container[1679:10516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x914b, name = 'com.apple.tsm.portname' 04:36:29 INFO - PID 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:29 INFO - PID 1675 | 2017-04-15 04:36:29.106 plugin-container[1679:10516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c17, name = 'com.apple.CFPasteboardClient' 04:36:29 INFO - PID 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:29 INFO - PID 1675 | 2017-04-15 04:36:29.106 plugin-container[1679:10516] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:29 INFO - PID 1675 | __metrics Screen width/height:1600/1200 04:36:29 INFO - PID 1675 | colorDepth:24 04:36:29 INFO - PID 1675 | Browser inner width/height: 1024/689 04:36:29 INFO - PID 1675 | __metrics 04:36:29 ERROR - PID 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 04:36:30 INFO - TEST-INFO | 1675: exit 0 04:36:30 INFO - Browser initialized. 04:36:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:30 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpjUKjGD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:33 INFO - PID 1680 | 2017-04-15 04:36:33.019 plugin-container[1681:10643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 04:36:33 INFO - PID 1680 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:33 INFO - PID 1680 | 2017-04-15 04:36:33.020 plugin-container[1681:10643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c17, name = 'com.apple.CFPasteboardClient' 04:36:33 INFO - PID 1680 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:33 INFO - PID 1680 | 2017-04-15 04:36:33.020 plugin-container[1681:10643] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:42 INFO - PID 1680 | RSS: Main: 238579712 04:36:42 INFO - PID 1680 | 04:39:46 INFO - PID 1680 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 04:39:48 INFO - PID 1680 | RSS: Main: 259272704 04:39:48 INFO - PID 1680 | 04:41:30 INFO - PID 1680 | ************************* 04:41:30 INFO - PID 1680 | A coding exception was thrown and uncaught in a Task. 04:41:30 INFO - PID 1680 | 04:41:30 ERROR - PID 1680 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:41:30 INFO - PID 1680 | Full stack: 04:41:30 INFO - PID 1680 | ************************* 04:41:30 INFO - PID 1680 | ************************* 04:41:30 INFO - PID 1680 | A coding exception was thrown and uncaught in a Task. 04:41:30 INFO - PID 1680 | 04:41:30 ERROR - PID 1680 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:41:30 INFO - PID 1680 | Full stack: 04:41:30 INFO - PID 1680 | ************************* 04:41:30 INFO - PID 1680 | ************************* 04:41:30 INFO - PID 1680 | A coding exception was thrown and uncaught in a Task. 04:41:30 INFO - PID 1680 | 04:41:30 ERROR - PID 1680 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:41:30 INFO - PID 1680 | Full stack: 04:41:30 INFO - PID 1680 | ************************* 04:41:30 INFO - PID 1680 | ************************* 04:41:30 INFO - PID 1680 | A coding exception was thrown and uncaught in a Task. 04:41:30 INFO - PID 1680 | 04:41:30 ERROR - PID 1680 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:41:30 INFO - PID 1680 | Full stack: 04:41:30 INFO - PID 1680 | ************************* 04:42:50 INFO - PID 1680 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 04:42:51 INFO - PID 1680 | RSS: Main: 262619136 04:42:51 INFO - PID 1680 | 04:45:53 INFO - PID 1680 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 04:45:53 INFO - PID 1680 | RSS: Main: 272261120 04:45:53 INFO - PID 1680 | 04:48:55 INFO - PID 1680 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 04:48:56 INFO - PID 1680 | RSS: Main: 264695808 04:48:56 INFO - PID 1680 | 04:51:58 INFO - PID 1680 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 04:51:59 INFO - PID 1680 | RSS: Main: 274022400 04:51:59 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 04:55:01 INFO - PID 1680 | RSS: Main: 268742656 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | __start_tp_report 04:55:01 INFO - PID 1680 | _x_x_mozilla_page_load 04:55:01 INFO - PID 1680 | _x_x_mozilla_page_load_details 04:55:01 INFO - PID 1680 | |i|pagename|runs| 04:55:01 INFO - PID 1680 | |0;dojo.html;3405.5232267482547;3472.496488009237;3574.981130377843;3645.854165833367;3665.4135338345855;5658.886822263552;6075.210222671047;6181.6600086995195;6185.319614842364;6206.193194884659;5036;6143.389059649642;6158.076288556718;6205.286392064914;6243;5295.099833028395;5429.809956651518;5469.835904922858;5504.4770746778995;5559.416261292567;5084.440711521748;5375.247465354834;5470.9452905471035;5560.165975103747;5630.324361076677;5387.568994480433;5429.511343979061;5446.455354464561;5471.097268950638;5510.752016159283;5456.236126942231;5481.232627432123;5493.917591236134;5497.697626630534;5503.642263252876;4382.6055654991205;5405.783768649249;5419.647722897999;5425.050616142199;5432.103702889019;6130.184124957599;6135.600157732645;6159.168512250833;6174.722137503778;6183.690815459209;6641.335866413368;6659.866802663968;6675.566088204299;6691.665416729193;6697.19633643961;6784.151981002375;6790.3888650021245;6797.048413222153;6804.251532331439;6813.454923606099;6165.660888651078;6208.844778880474;6229.190205273286;6293.402126797947;6322.051692246154;6843.213030501556;6867.931320686729;6931.202911665223;6932.722691092401;6974.686139123752;6321.462675672619;6386.393292637192;6415.1981002374705;6538.574992625464;6548.083268342436;6624.536282460182;6698.33016698336;6707.3628005339415;6731.124953755981;6757.560758550679;6344.809655710336;6431.067495213168;6682.198136223684;6688.899666505006;6695.531312808057;6544.44372228366;6551.312112228243;6622.668866556653;6639.070530125786;6656.467482601381;4584.724916504953;5376.78492860289;5392.622516423891;5419.214213939035;5429.837104886859;4702.130105930414;4773.284007398918;4787.114383839001;4796.640251981115;4816;6137.131844484766;6291.087792270096;6324.272708638566;6363.459105975951;6367;6769.221539523018;6783.864322713518;6784.59292442455;6785.42323902464;6790.660466976631;5803.970980145073;6306.905396419057;6373.745050198033;6380.840478988062;6393.808185754435;5787.1319302104175;5838.883222335529;5978.55160862937;5996.730147143302;6044.184035155197;6915.965420172867;6930.237673855972;6934.687939042654;6938.861222775416;6959.686814093277;6668.433183179484;6694.966525167343;6740.921452567565;6748.865022699617;6777.762778302736;6592.868142637216;6686.231083425469;6876.484263680144;6893.724251029903;6903.965480172567;6629.5359324846795;6675.299093595297;6680.699368528525;6682.665866706742;6717.664116794239;5312.946870531246;6360.713767880549;6752.459803215829;6769.323067693192;6789.626570538668;6247.781327653511;6356.078368636614;6397.840053998501;6453.354664533509;6468.223813142265;6526.738930442729;6540.803775886731;6546.312637173219;6547.869042619026;6559.344065593403;6284.277308109626;6308.810735677937;6406;6434.8391290218115;6454.806355809334;4677.836275730333;6022.518198544019;6227.439530442282;6525.249596296487;6529.542931994904;5904.3210030845285;5992.460678538952;6354.841128971812;6354.951433013501;6441.355864413521 04:55:01 INFO - PID 1680 | |1;ext.html;596.991085066238;727.2618292433178;806.133406587918;1152.8847115288477;1266.6580023393678;37439.43840842389;38524.614753852526;38546.22907541851;38581.61418385815;38620.61379386205;38879;39417.620383286594;39418.81743547691;39486.01284967877;39526.40710389339;8058.274755272039;8210.630521626541;8469.74590762278;8673.522956237404;8716.912830871674;8526.147385261485;8627.870581941275;8635.654573817072;8643.913560864405;8644.740657780276;8580.656773729042;8593;8643.956780216091;8669.263112635434;8677.869831952494;8544.78638034051;8607.526586037766;8638.09300023501;8639.136086391374;8639.43843650167;8404.285635720971;8449.94375703037;8455.069942306342;8471.915280847174;8479.236868681848;37770;37790.81104594487;37876.62123378786;37887;38058.42912356317;3627.9455808162897;3672.338978983782;3674.7978861162624;3677.42999835026;3677.5770786359644;30594.541081883788;30663.08010759681;30722.539161912588;30763.38473230523;30840.845795771103;3107.673694262115;3131.984340078285;3135.3885992231526;3144.166795799115;3146.65386807451;250290;254880.72559637084;283399;298468.99999999785;298847;47995.76002120037;48080;48240.758796205795;48256;48260.82826272826;50218.224904135765;50244.49755502398;50509.49490505048;50578.747106264236;50642.493575064516;14370.99403041798;14460.493882714054;14564.980451368303;14585.270736463135;14606.269686515632;11851.288922664668;11882.049436045269;11959.222650527689;11960.820587691192;11969.700757480958;13331.40008699611;13510;13559.728805423836;13589.320533973261;13618.319084045757;5907.1139329100115;5958.165856780054;5960;5971.312909190881;5973.163757073926;888.8888888888889;944.15026476172;978.4325091446943;1018.5416562546884;1067.770429357692;23962.52074958491;24064.398390040038;24220.636690449657;24374.87812560961;24438.511229775304;1013.2451323763843;1143.9656810295705;1175.4710380328715;1176.3882780953857;1180.4097951024487;11660.53357865676;12454;12493.437795299233;12530.624081277576;12545.623631291075;327696;328600;330241;330914;331063;55014.449855501734;55282;55397.72301138549;55542;55630;1486.0118021515786;1520.3766455753089;1572.2374648295568;1572.300326354784;1576.7556028815552;20655.483612909797;23782.762172378054;23878;24046.87976560106;24101.397465063514;37695.623043769214;37772.2445551093;37867.242655147296;37885.62114378821;37891.86324410272;296235.5188224045;297251;298077;298313;298999;33071.50392744063;33538.83230583832;33618.49572256369;33646;34302.48546271758;35438.82280588581;42925;43288.783556083275;43404;43879;28739.568906466837;29800;30053.3989320208;30449.391012180076;30605.23486912756;29611.40777184487;30189.849050754605;30270.54594181045;30432.847835761564;30452.39095218039;35116.29767404689;35187.82406087953;35640.10899727424;35824.52193475816;35999.820000899825;29641.851790740908;30083.247918802204;30772.38455230838;30855.69144308528;31143.377132457677;20655.58688826185;22674;23705.644415333438;23939.28182154538;23961.880190598935 04:55:01 INFO - PID 1680 | |2;jquery.html;347.6297742903808;421.2669954279553;422.85200179937044;425.7871064467766;459.1803630519521;19694.409167724956;21254.681179782314;21941.670874936848;22032.779672203273;22117.668234976467;20487;22658;23345.949432275545;24073.39816504588;24250.272491825275;6234.625922444668;6257.405546473089;6478.481721462272;6489.805305840832;6491.2535058468175;6052.606580572271;6348.26994895586;6420.967895160541;6428.582142160744;6429.196350456193;5958.046712525997;6358.554901156921;6373.649449280288;6382.361763823604;6383.0744542041375;6179.19670442844;6267.871783079044;6272.435480806749;6285.748570057192;6291.276503202122;5456.836294911159;5474.315710536183;5505.229267902497;5540.418256083134;5557.277553917965;27414.45171096567;27939.86030069857;28450.430991380264;28591.57112643312;28812.42375152506;1993.4119434766778;2209.55808838233;2266.841321107523;2271.931842044741;2274.55646149001;14382.28088595566;17848.643027139515;18378.448646540626;18419.35532256378;18630.25478980839;2121.872687638747;2144.6997420361163;2182.639864422368;2193.320070778064;2197.7142971413773;155442;159418;160638;161823.99999999884;162991;11514.539418423337;12199.14605977573;12280;12630.716013836469;12684.42920068599;16419.67160656804;16584.585385365463;16660.58348541296;16663.83336166647;16676.249568769435;8748.343874209333;9025.368224224241;9081.727548173565;9207.401518901384;9236.214921731593;8662.91337086621;8675.089115642893;8703.737957996182;8720.345974051972;8763.605637746317;7284.688756023967;7943.960280198562;8052.235037671412;8093.433459657767;8153.899223604856;2168.750593681715;2173.793489618484;2177.421369507095;2178.9346319610436;2255.289583781104;895.1853813030242;920.8204400142042;927.1840780113457;930.5114814722325;952.5761036338763;19771.30800422007;20302.898485507478;20720.06759695817;21033.68449473259;21450.678239826415;839.8656215005569;864.2092485375811;954.9761255968656;956.8469044952774;989.7773001074701;10390.376577405228;10975.50610222542;10994.450277486254;11010.449477526092;11018.44907754609;563670;565495;570320;575949;580612;114762.85237147522;127977.27895562844;135310.97033544505;146407.80388294184;147090.82000980098;1181.5451051345294;1215.380156120385;1257.698152443407;1261.7949857885696;1262.5770366927181;16601.83398166051;20912.05895734726;22618.208362707228;23330.883345583843;23370.182043628392;59222.09156319184;59575.10637340356;60416.69791651014;61275.69362153339;62179;64190;81578;81962.59018705107;82659;83085;8971.327150463872;9285.9785423602;9307.72076837696;13312.600621981355;13601.455941762219;11610.6516804496;12323.69190770238;14142.22217778032;15034;15047.924760376129;11837.704057398289;12252.693682658004;12348.88860002604;12439.06706996997;12452.501899923902;11780.587679431179;11817.29096254193;11819.881801181878;11882.108841836724;12120;10763;12549.560765373168;12785.424655890693;12930.806037909251;13042.347882605642;13628;13657.863421365659;13671.974601905096;13782.793258101337;13969.882409407426;11843.703907402383;12220.816687749868;12237.694057648274;12482.563110291096;12609.87390126087 04:55:01 INFO - PID 1680 | |3;mootools.html;1252.2048499203006;1406.9366878490473;1409.6396976917279;1422.3315041930289;1430.8068410764547;11508.769824603514;11792.233504822181;11949.283043017425;11967;12206.755864882696;11891.940540297308;12045.337506437143;12112.81830772539;12136.93931530341;12140.210886292385;2523.419613488894;2552.3619095226195;2567.499337629163;2568.024150822685;2574.7167811540717;2482.7765501104896;2496.1887386599337;2538.390786211305;2543.7710606045453;2555.3100662821025;2461.5323088613104;2519.748025197484;2534.8605826679527;2538.6953565572157;2540.491901619674;2448.2165706973865;2512.9120480783176;2527.8609676467786;2528.873556322195;2530.708968468631;2412.4210189554556;2511.824172307939;2524.924252272416;2525.229804909502;2529.127451029392;11991.520339186422;12055.578054768128;12056.819147712704;12075.215111017844;12099.939500302531;6569.572977756478;6789.388954994025;6818.795436136924;6832;6832.59004459729;4009.4386785850006;4220.556841531657;4302.290122129845;4304.182205380999;4337.7180483268485;1234.2594443334017;1241.819936109259;1250.6156073246038;1258.4966013594544;1260.6974326161746;15097.3206205721;15679.059256444763;16610.58473538171;16763.245653945603;16827.41104061352;5519.199716041152;5626.803061892896;5817.854553636108;5854.795082172103;5858.912116318259;11311.095112390989;11752.353620550952;12458.875411245952;12460.937695311466;12500.812487812691;6535.705893234815;6577.6053436793945;6584.078229047937;6588.967055164693;6596.4393026592315;6084.330723620398;6196.566240363131;6224.719887604978;6225.533085018642;6230.626162430269;3774.641409066134;4421.447319085114;4531.45622525299;4537.3647689323525;4548;1312;1327.8340207474066;1333.240053169684;1344.8251727275588;1348.7909374047038;767.6929228308721;775.6625867747548;797.0833541427405;800.6237068577759;803.9227435236811;6387.872242555123;6841.931580684229;6955.130608673916;6995.510314277952;7105.324994125654;934.9439033658002;942.2038377570941;942.6700654770775;945.3429866243033;977.9511024448749;4198.8110535026;4382.364557139261;4404.735715856995;4404.757738324423;4423.867283981485;13313.40089695966;14630.634234144232;14798.186099764402;15469;15476.839237057266;14759.557213283619;15310.770338444932;15312.923435382974;15385.38458461649;15441.845581544265;7327.303906128909;8539.402241843136;8765.737027889047;8787.516686582172;8807.647694092164;6058.182145410313;6504.764094821969;6985;7003.964980175067;7213.098362704662;11568.363739994382;13010.284434356201;13814.171149731048;13894.957878159381;13940.721185576029;11797.76404471923;13792.517261895786;14245.287735613385;14312.71374572482;14389.208593527457;9584.137427631547;9667.081627245401;9774.413535187912;9799.951000244953;9809.117179453884;10870;10879.891201087888;10994.230403871652;11046.889531104907;11050.447477625925;7842.9215707842195;9159;9258.444493330422;9474.052594740471;9474.478903660365;9064.592093355683;9186.448813071238;9191;9220.124088211609;9229.815403691755;7071.611061391673;8176.427650064438;8223.465474744122;8231.300339471212;8274;5895.498882595028;6134.601250918855;6134.773045391029;6168.8766224674355;6247.875042499216;4920.794405370707;4930.82742104039;6047.66737829406;6180.969095154495;6400.9039864403 04:55:01 INFO - PID 1680 | |4;prototype.html;394.9743266687663;397.2729904275176;399.3069385804191;401.1835913915181;409.9979500102497;5089.567386772129;5356.892862142755;5403.946230485057;6082.118092876536;6158.1994340735755;5499.010178167928;5921.763129474826;6026.548008899328;6049.727762250698;6066.241719785027;3726.621150174439;4198.328267477189;4612.3542704021465;4639.327297541854;4643.4892161862335;4661.976690116561;4662.950836061893;4668.719876807386;4668.906621867561;4669.509701481329;4423.51341352451;4566.2876421342;4576.427946506687;4603.240465323234;4615.399998000255;4571.679982401233;4572.5427457254345;4578.267477203664;4589.357489951392;4597.241455159895;4074.9828834727;4092.8158232879296;4101.097758493127;4116.156187981456;4123.814428350732;4778.761061946889;5854.736536855852;5934.5845790794665;5943.375945525744;5959.582829201958;5060.291559181717;5315.627906046579;5332.546733527654;5333.2266821310695;5334.973325133349;6362.713677884506;6483.935160648381;6537.477001839841;6570.310117437648;6575.210974683021;3740.4576336431337;3988.581198974124;4018.598140185987;4068.837246510136;4381.9123617527475;6210.844728881814;6678.866422671568;6930.5148639594745;6941.68762405693;6979;4002.599740025974;4399.846005389796;4440.955590444054;4442.888927776831;4453.287474004143;4284.7145856243005;4525.637948964075;4533.002739397327;4534.251848445036;4542.818287268472;4782.832600858953;5226.790928362823;5261.263423120766;5271.920921186185;5368.570514358842;5034.697918124851;6531.982830559267;6565.310642382481;6573.769918052845;6579.80260592183;1500.5423345879394;1527.6715506166006;1529.1283968138277;1532.7317719399061;1546.9303881325368;775.2402645407532;847.8304339132198;890.123228619809;900.5902314447042;986.1306771959801;6025.945459544562;6228.875422491616;6247.219097612799;6258.937410625836;6335.271443784024;6734.8653026940165;6767.390934815791;6774.627395493197;6777.72889084441;6787.490938179656;5310.734463276821;6145.569810113249;6203.379662033761;6204;6232.407921247474;2755.5040092783493;2956.3200463893427;3532.293541291752;3545.592256890439;3551.5560554930635;6812.557183783138;6962.443004559623;6974.128233970754;7013.158420989514;7020.719171233093;5820;6044.516438684895;6946.687399067054;6952.7218911244;6963.61700106499;5445.019896418604;6710.261871194165;6861.725530978705;6927.930720692729;6994.922234216929;5395.946040539544;5648.604597678123;6055.757769689163;6176.104464852481;6788.7284508619105;6299.370062993664;6612.735490580323;6638.970959501285;6652.434543063894;6653.600783952978;5707.714614269187;6297.110866740051;6318.62088274705;6566;6904.723811047502;3599.9820000899826;3881.7088718346804;4403.5156132826005;4412.161689279027;4457.7771111444945;5684.806190699834;6389.393007664265;6648.1357423536565;6692.096566963398;6738.898916516354;5828;5880.764769409176;6381.968090159519;6532.477401807939;6534.575252608755;5286.942611477797;5699.943000569941;6421.486281097595;6485.573173901734;6504.934950650433;5665.920537213365;5966.880662386815;6230.940740074107;6384.201974753156;6413.230412350548;6484.319146489739;6521.445677117498;6528.477721782341;6530.640814755234;6543.116679248241;5078.720670363018;5296.549793267615;6007.038873780349;6345.206849143857;6348.809535713936 04:55:01 INFO - PID 1680 | |5;yui.html;769.5651956644496;832.3549249331771;841.2554888923305;866.4844417571546;871.7079778274277;13806.654833629163;14612.904032197588;14728.337224824882;16294.83705162948;16787.580310492245;16573.91713041433;17054.48836534903;17125.82874171258;17241;17348.392806251784;981.563204374052;995.5619527407954;1010.5149528226456;1016.8118898003856;1018.1396719771781;1003.9648612298571;1006.6828948881079;1011.7116621762799;1013.1185868294557;1016.2581315639587;1038.1124138861278;1046.8063408269495;1047.984280235797;1049.412329095705;1051.2641151194196;1030.3766221436;1033.62272770439;1038.9480525973709;1041.229490177271;1041.9374837509774;767.1982777997007;775.0853992289096;775.1202385292734;775.4765533265023;777.211130702332;16340.428085017085;16821.327146914107;16881.83118168815;16891.070991095487;16902.830971690248;16293.185340732916;16711.415100471426;16783.16084195785;17006.659866802718;17036.233369498277;13625.25061121638;13980.951428642791;14112.71774564503;14116.082454640415;14132.081414708011;3037.331787006855;3388.542546756181;3406.199543107368;3410.539577157077;3458.757886947915;111305.88694113036;111898;112026.87973120245;112342.99999999919;113260.4336978318;12044;12115.636530904087;12161.452734626962;12189.939050304693;12213.389330533439;20066.19735210575;20137;20333.694994575093;20350.796492035188;24492.265232043068;6361.681915904186;7804.843903121906;7805.570693611792;7827.686892524235;7829.686812527549;3791.3933770596573;3812.5615554211067;3837.57786643469;3864.420336949424;3869.690424766012;4233.682473814476;4320;4320.790178749955;4325.307950727868;4330.566943305645;931.2456909903;959.9616015359447;973.1582181413169;977.7848873247874;980.5587485631352;633.3128555517316;664.6045602866287;668.8428219368444;681.0465348512123;687.2405991379553;10598;10860.782784344268;11364.261323013978;12043.09676774228;12240.265584064984;630.7697690342992;638.3010603389281;664.2659860853784;691.87892118879;697.6581475077176;5438.374586922476;5477.20580515823;5615.157726341082;5643.746031428514;5731.340895796953;99516.50241748746;100602.49698751606;105564;108451;109675;87275;88526.55736721405;88612.5569372149;89403.10596894078;90815;80990.380192397;84036.57981710053;85408.15663295166;86788.56605716932;86980;8022.518648881086;8584.65661373538;10095.394276343442;11243.931826476472;11351.035162011322;32480.187995300308;42925.356119657605;42988.49540266076;44009.89975250644;44775.32837007513;55291.682499050185;56545;70648.23379415351;70895.72339215755;71022;15313;16667.833321667113;16901.239444224793;17145;17188.82811171872;18040.729389059437;18199.45401637953;18431.63136737231;18532.81467185311;18717.251309947995;16935.491935241964;17007.404740834012;17053.891497052653;17240.224189911736;17337.959722416694;17043.31826726917;17089.658206836044;17406.216720247365;17598.29606815713;17626.64746705033;16366;17038.744418833976;17045.91477042607;17136.657266854843;17250.568735781202;11610;11951.940240298743;12164.635060948185;12203.389830508617;12526.87473125257;12251.448684809384;13183;13222.603321900358;13409;13449.596512104652 04:55:01 INFO - PID 1680 | __end_tp_report 04:55:01 INFO - PID 1680 | __start_cc_report 04:55:01 INFO - PID 1680 | _x_x_mozilla_cycle_collect,427 04:55:01 INFO - PID 1680 | __end_cc_report 04:55:01 INFO - PID 1680 | __startTimestamp1492257301602__endTimestamp 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | ------- Summary: start ------- 04:55:01 INFO - PID 1680 | Number of tests: 6 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | [#0] dojo.html Cycles:165 Average:6121.52 Median:6354.95 stddev:748.91 (11.8%) stddev-sans-first:720.26 04:55:01 INFO - PID 1680 | Values: 3405.5 3472.5 3575.0 3645.9 3665.4 5658.9 6075.2 6181.7 6185.3 6206.2 5036.0 6143.4 6158.1 6205.3 6243.0 5295.1 5429.8 5469.8 5504.5 5559.4 5084.4 5375.2 5470.9 5560.2 5630.3 5387.6 5429.5 5446.5 5471.1 5510.8 5456.2 5481.2 5493.9 5497.7 5503.6 4382.6 5405.8 5419.6 5425.1 5432.1 6130.2 6135.6 6159.2 6174.7 6183.7 6641.3 6659.9 6675.6 6691.7 6697.2 6784.2 6790.4 6797.0 6804.3 6813.5 6165.7 6208.8 6229.2 6293.4 6322.1 6843.2 6867.9 6931.2 6932.7 6974.7 6321.5 6386.4 6415.2 6538.6 6548.1 6624.5 6698.3 6707.4 6731.1 6757.6 6344.8 6431.1 6682.2 6688.9 6695.5 6544.4 6551.3 6622.7 6639.1 6656.5 4584.7 5376.8 5392.6 5419.2 5429.8 4702.1 4773.3 4787.1 4796.6 4816.0 6137.1 6291.1 6324.3 6363.5 6367.0 6769.2 6783.9 6784.6 6785.4 6790.7 5804.0 6306.9 6373.7 6380.8 6393.8 5787.1 5838.9 5978.6 5996.7 6044.2 6916.0 6930.2 6934.7 6938.9 6959.7 6668.4 6695.0 6740.9 6748.9 6777.8 6592.9 6686.2 6876.5 6893.7 6904.0 6629.5 6675.3 6680.7 6682.7 6717.7 5312.9 6360.7 6752.5 6769.3 6789.6 6247.8 6356.1 6397.8 6453.4 6468.2 6526.7 6540.8 6546.3 6547.9 6559.3 6284.3 6308.8 6406.0 6434.8 6454.8 4677.8 6022.5 6227.4 6525.2 6529.5 5904.3 5992.5 6354.8 6355.0 6441.4 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | [#1] ext.html Cycles:180 Average:45199.83 Median:33578.66 stddev:79368.60 (236.4%) stddev-sans-first:79520.60 04:55:01 INFO - PID 1680 | Values: 597.0 727.3 806.1 1152.9 1266.7 37439.4 38524.6 38546.2 38581.6 38620.6 38879.0 39417.6 39418.8 39486.0 39526.4 8058.3 8210.6 8469.7 8673.5 8716.9 8526.1 8627.9 8635.7 8643.9 8644.7 8580.7 8593.0 8644.0 8669.3 8677.9 8544.8 8607.5 8638.1 8639.1 8639.4 8404.3 8449.9 8455.1 8471.9 8479.2 37770.0 37790.8 37876.6 37887.0 38058.4 3627.9 3672.3 3674.8 3677.4 3677.6 30594.5 30663.1 30722.5 30763.4 30840.8 3107.7 3132.0 3135.4 3144.2 3146.7 250290.0 254880.7 283399.0 298469.0 298847.0 47995.8 48080.0 48240.8 48256.0 48260.8 50218.2 50244.5 50509.5 50578.7 50642.5 14371.0 14460.5 14565.0 14585.3 14606.3 11851.3 11882.0 11959.2 11960.8 11969.7 13331.4 13510.0 13559.7 13589.3 13618.3 5907.1 5958.2 5960.0 5971.3 5973.2 888.9 944.2 978.4 1018.5 1067.8 23962.5 24064.4 24220.6 24374.9 24438.5 1013.2 1144.0 1175.5 1176.4 1180.4 11660.5 12454.0 12493.4 12530.6 12545.6 327696.0 328600.0 330241.0 330914.0 331063.0 55014.4 55282.0 55397.7 55542.0 55630.0 1486.0 1520.4 1572.2 1572.3 1576.8 20655.5 23782.8 23878.0 24046.9 24101.4 37695.6 37772.2 37867.2 37885.6 37891.9 296235.5 297251.0 298077.0 298313.0 298999.0 33071.5 33538.8 33618.5 33646.0 34302.5 35438.8 42925.0 43288.8 43404.0 43879.0 28739.6 29800.0 30053.4 30449.4 30605.2 29611.4 30189.8 30270.5 30432.8 30452.4 35116.3 35187.8 35640.1 35824.5 35999.8 29641.9 30083.2 30772.4 30855.7 31143.4 20655.6 22674.0 23705.6 23939.3 23961.9 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | [#2] jquery.html Cycles:180 Average:36954.02 Median:12186.48 stddev:96869.81 (794.9%) stddev-sans-first:97102.56 04:55:01 INFO - PID 1680 | Values: 347.6 421.3 422.9 425.8 459.2 19694.4 21254.7 21941.7 22032.8 22117.7 20487.0 22658.0 23345.9 24073.4 24250.3 6234.6 6257.4 6478.5 6489.8 6491.3 6052.6 6348.3 6421.0 6428.6 6429.2 5958.0 6358.6 6373.6 6382.4 6383.1 6179.2 6267.9 6272.4 6285.7 6291.3 5456.8 5474.3 5505.2 5540.4 5557.3 27414.5 27939.9 28450.4 28591.6 28812.4 1993.4 2209.6 2266.8 2271.9 2274.6 14382.3 17848.6 18378.4 18419.4 18630.3 2121.9 2144.7 2182.6 2193.3 2197.7 155442.0 159418.0 160638.0 161824.0 162991.0 11514.5 12199.1 12280.0 12630.7 12684.4 16419.7 16584.6 16660.6 16663.8 16676.2 8748.3 9025.4 9081.7 9207.4 9236.2 8662.9 8675.1 8703.7 8720.3 8763.6 7284.7 7944.0 8052.2 8093.4 8153.9 2168.8 2173.8 2177.4 2178.9 2255.3 895.2 920.8 927.2 930.5 952.6 19771.3 20302.9 20720.1 21033.7 21450.7 839.9 864.2 955.0 956.8 989.8 10390.4 10975.5 10994.5 11010.4 11018.4 563670.0 565495.0 570320.0 575949.0 580612.0 114762.9 127977.3 135311.0 146407.8 147090.8 1181.5 1215.4 1257.7 1261.8 1262.6 16601.8 20912.1 22618.2 23330.9 23370.2 59222.1 59575.1 60416.7 61275.7 62179.0 64190.0 81578.0 81962.6 82659.0 83085.0 8971.3 9286.0 9307.7 13312.6 13601.5 11610.7 12323.7 14142.2 15034.0 15047.9 11837.7 12252.7 12348.9 12439.1 12452.5 11780.6 11817.3 11819.9 11882.1 12120.0 10763.0 12549.6 12785.4 12930.8 13042.3 13628.0 13657.9 13672.0 13782.8 13969.9 11843.7 12220.8 12237.7 12482.6 12609.9 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | [#3] mootools.html Cycles:180 Average:7182.17 Median:3892.04 stddev:4531.55 (116.4%) stddev-sans-first:4522.35 04:55:01 INFO - PID 1680 | Values: 1252.2 1406.9 1409.6 1422.3 1430.8 11508.8 11792.2 11949.3 11967.0 12206.8 11891.9 12045.3 12112.8 12136.9 12140.2 2523.4 2552.4 2567.5 2568.0 2574.7 2482.8 2496.2 2538.4 2543.8 2555.3 2461.5 2519.7 2534.9 2538.7 2540.5 2448.2 2512.9 2527.9 2528.9 2530.7 2412.4 2511.8 2524.9 2525.2 2529.1 11991.5 12055.6 12056.8 12075.2 12099.9 6569.6 6789.4 6818.8 6832.0 6832.6 4009.4 4220.6 4302.3 4304.2 4337.7 1234.3 1241.8 1250.6 1258.5 1260.7 15097.3 15679.1 16610.6 16763.2 16827.4 5519.2 5626.8 5817.9 5854.8 5858.9 11311.1 11752.4 12458.9 12460.9 12500.8 6535.7 6577.6 6584.1 6589.0 6596.4 6084.3 6196.6 6224.7 6225.5 6230.6 3774.6 4421.4 4531.5 4537.4 4548.0 1312.0 1327.8 1333.2 1344.8 1348.8 767.7 775.7 797.1 800.6 803.9 6387.9 6841.9 6955.1 6995.5 7105.3 934.9 942.2 942.7 945.3 978.0 4198.8 4382.4 4404.7 4404.8 4423.9 13313.4 14630.6 14798.2 15469.0 15476.8 14759.6 15310.8 15312.9 15385.4 15441.8 7327.3 8539.4 8765.7 8787.5 8807.6 6058.2 6504.8 6985.0 7004.0 7213.1 11568.4 13010.3 13814.2 13895.0 13940.7 11797.8 13792.5 14245.3 14312.7 14389.2 9584.1 9667.1 9774.4 9800.0 9809.1 10870.0 10879.9 10994.2 11046.9 11050.4 7842.9 9159.0 9258.4 9474.1 9474.5 9064.6 9186.4 9191.0 9220.1 9229.8 7071.6 8176.4 8223.5 8231.3 8274.0 5895.5 6134.6 6134.8 6168.9 6247.9 4920.8 4930.8 6047.7 6181.0 6400.9 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | [#4] prototype.html Cycles:180 Average:5217.09 Median:5901.26 stddev:1640.66 (27.8%) stddev-sans-first:1604.84 04:55:01 INFO - PID 1680 | Values: 395.0 397.3 399.3 401.2 410.0 5089.6 5356.9 5403.9 6082.1 6158.2 5499.0 5921.8 6026.5 6049.7 6066.2 3726.6 4198.3 4612.4 4639.3 4643.5 4662.0 4663.0 4668.7 4668.9 4669.5 4423.5 4566.3 4576.4 4603.2 4615.4 4571.7 4572.5 4578.3 4589.4 4597.2 4075.0 4092.8 4101.1 4116.2 4123.8 4778.8 5854.7 5934.6 5943.4 5959.6 5060.3 5315.6 5332.5 5333.2 5335.0 6362.7 6483.9 6537.5 6570.3 6575.2 3740.5 3988.6 4018.6 4068.8 4381.9 6210.8 6678.9 6930.5 6941.7 6979.0 4002.6 4399.8 4441.0 4442.9 4453.3 4284.7 4525.6 4533.0 4534.3 4542.8 4782.8 5226.8 5261.3 5271.9 5368.6 5034.7 6532.0 6565.3 6573.8 6579.8 1500.5 1527.7 1529.1 1532.7 1546.9 775.2 847.8 890.1 900.6 986.1 6025.9 6228.9 6247.2 6258.9 6335.3 6734.9 6767.4 6774.6 6777.7 6787.5 5310.7 6145.6 6203.4 6204.0 6232.4 2755.5 2956.3 3532.3 3545.6 3551.6 6812.6 6962.4 6974.1 7013.2 7020.7 5820.0 6044.5 6946.7 6952.7 6963.6 5445.0 6710.3 6861.7 6927.9 6994.9 5395.9 5648.6 6055.8 6176.1 6788.7 6299.4 6612.7 6639.0 6652.4 6653.6 5707.7 6297.1 6318.6 6566.0 6904.7 3600.0 3881.7 4403.5 4412.2 4457.8 5684.8 6389.4 6648.1 6692.1 6738.9 5828.0 5880.8 6382.0 6532.5 6534.6 5286.9 5699.9 6421.5 6485.6 6504.9 5665.9 5966.9 6230.9 6384.2 6413.2 6484.3 6521.4 6528.5 6530.6 6543.1 5078.7 5296.5 6007.0 6345.2 6348.8 04:55:01 INFO - PID 1680 | 04:55:01 INFO - PID 1680 | [#5] yui.html Cycles:180 Average:21544.64 Median:17343.18 stddev:29915.89 (172.5%) stddev-sans-first:29959.14 04:55:01 INFO - PID 1680 | Values: 769.6 832.4 841.3 866.5 871.7 13806.7 14612.9 14728.3 16294.8 16787.6 16573.9 17054.5 17125.8 17241.0 17348.4 981.6 995.6 1010.5 1016.8 1018.1 1004.0 1006.7 1011.7 1013.1 1016.3 1038.1 1046.8 1048.0 1049.4 1051.3 1030.4 1033.6 1038.9 1041.2 1041.9 767.2 775.1 775.1 775.5 777.2 16340.4 16821.3 16881.8 16891.1 16902.8 16293.2 16711.4 16783.2 17006.7 17036.2 13625.3 13981.0 14112.7 14116.1 14132.1 3037.3 3388.5 3406.2 3410.5 3458.8 111305.9 111898.0 112026.9 112343.0 113260.4 12044.0 12115.6 12161.5 12189.9 12213.4 20066.2 20137.0 20333.7 20350.8 24492.3 6361.7 7804.8 7805.6 7827.7 7829.7 3791.4 3812.6 3837.6 3864.4 3869.7 4233.7 4320.0 4320.8 4325.3 4330.6 931.2 960.0 973.2 977.8 980.6 633.3 664.6 668.8 681.0 687.2 10598.0 10860.8 11364.3 12043.1 12240.3 630.8 638.3 664.3 691.9 697.7 5438.4 5477.2 5615.2 5643.7 5731.3 99516.5 100602.5 105564.0 108451.0 109675.0 87275.0 88526.6 88612.6 89403.1 90815.0 80990.4 84036.6 85408.2 86788.6 86980.0 8022.5 8584.7 10095.4 11243.9 11351.0 32480.2 42925.4 42988.5 44009.9 44775.3 55291.7 56545.0 70648.2 70895.7 71022.0 15313.0 16667.8 16901.2 17145.0 17188.8 18040.7 18199.5 18431.6 18532.8 18717.3 16935.5 17007.4 17053.9 17240.2 17338.0 17043.3 17089.7 17406.2 17598.3 17626.6 16366.0 17038.7 17045.9 17136.7 17250.6 11610.0 11951.9 12164.6 12203.4 12526.9 12251.4 13183.0 13222.6 13409.0 13449.6 04:55:01 INFO - PID 1680 | -------- Summary: end -------- 04:55:01 INFO - PID 1680 | 04:55:02 INFO - TEST-INFO | 1680: exit 0 04:55:02 INFO - TEST-OK | dromaeo_css | took 1116515ms 04:55:02 INFO - TEST-START | kraken 04:55:02 INFO - operating with platform_type : mac_ 04:55:02 INFO - Initialising browser for kraken test... 04:55:02 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpleCc0X/profile http://localhost:49236/getInfo.html) 04:55:05 INFO - PID 1691 | 2017-04-15 04:55:05.094 plugin-container[1692:12902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:55:05 INFO - PID 1691 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:05 INFO - PID 1691 | 2017-04-15 04:55:05.095 plugin-container[1692:12902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.CFPasteboardClient' 04:55:05 INFO - PID 1691 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:05 INFO - PID 1691 | 2017-04-15 04:55:05.095 plugin-container[1692:12902] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:55:05 INFO - PID 1691 | __metrics Screen width/height:1600/1200 04:55:05 INFO - PID 1691 | colorDepth:24 04:55:05 INFO - PID 1691 | Browser inner width/height: 1024/689 04:55:05 INFO - PID 1691 | __metrics 04:55:05 ERROR - PID 1691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 04:55:06 INFO - TEST-INFO | 1691: exit 0 04:55:06 INFO - Browser initialized. 04:55:06 INFO - Running cycle 1/1 for kraken test... 04:55:06 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpleCc0X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:08 INFO - PID 1693 | 2017-04-15 04:55:08.729 plugin-container[1694:13023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 04:55:08 INFO - PID 1693 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:08 INFO - PID 1693 | 2017-04-15 04:55:08.729 plugin-container[1694:13023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 04:55:08 INFO - PID 1693 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:08 INFO - PID 1693 | 2017-04-15 04:55:08.729 plugin-container[1694:13023] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:55:18 INFO - PID 1693 | RSS: Main: 238051328 04:55:18 INFO - PID 1693 | 04:55:21 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:22 INFO - PID 1693 | RSS: Main: 251023360 04:55:22 INFO - PID 1693 | 04:55:24 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 04:55:25 INFO - PID 1693 | RSS: Main: 259272704 04:55:25 INFO - PID 1693 | 04:55:28 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 04:55:29 INFO - PID 1693 | RSS: Main: 261718016 04:55:29 INFO - PID 1693 | 04:55:31 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 04:55:32 INFO - PID 1693 | RSS: Main: 262762496 04:55:32 INFO - PID 1693 | 04:55:34 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:34 INFO - PID 1693 | RSS: Main: 264474624 04:55:34 INFO - PID 1693 | 04:55:37 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:38 INFO - PID 1693 | RSS: Main: 269991936 04:55:38 INFO - PID 1693 | 04:55:41 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:41 INFO - PID 1693 | RSS: Main: 271777792 04:55:41 INFO - PID 1693 | 04:55:45 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 04:55:45 INFO - PID 1693 | RSS: Main: 271060992 04:55:45 INFO - PID 1693 | 04:55:47 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:47 INFO - PID 1693 | RSS: Main: 270491648 04:55:47 INFO - PID 1693 | 04:55:49 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:50 INFO - PID 1693 | RSS: Main: 270569472 04:55:50 INFO - PID 1693 | 04:55:52 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:53 INFO - PID 1693 | RSS: Main: 270143488 04:55:53 INFO - PID 1693 | 04:55:55 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:56 INFO - PID 1693 | RSS: Main: 270475264 04:55:56 INFO - PID 1693 | 04:55:59 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:00 INFO - PID 1693 | RSS: Main: 270569472 04:56:00 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 04:56:02 INFO - PID 1693 | RSS: Main: 272297984 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | __start_tp_report 04:56:02 INFO - PID 1693 | _x_x_mozilla_page_load 04:56:02 INFO - PID 1693 | _x_x_mozilla_page_load_details 04:56:02 INFO - PID 1693 | |i|pagename|runs| 04:56:02 INFO - PID 1693 | |0;ai-astar;104;121;114;115;114;115;121;168;132;116 04:56:02 INFO - PID 1693 | |1;audio-beat-detection;147;113;112;153;112;113;113;115;169;146 04:56:02 INFO - PID 1693 | |2;audio-dft;197;203;213;218;221;200;200;202;202;198 04:56:02 INFO - PID 1693 | |3;audio-fft;79;58;61;93;60;64;63;62;82;48 04:56:02 INFO - PID 1693 | |4;audio-oscillator;88;95;69;58;64;73;110;108;101;81 04:56:02 INFO - PID 1693 | |5;imaging-gaussian-blur;89;91;89;89;91;89;90;91;92;88 04:56:02 INFO - PID 1693 | |6;imaging-darkroom;97;99;97;97;98;97;124;97;97;99 04:56:02 INFO - PID 1693 | |7;imaging-desaturate;90;147;81;148;143;91;90;89;110;89 04:56:02 INFO - PID 1693 | |8;json-parse-financial;51;52;50;52;49;53;65;63;69;82 04:56:02 INFO - PID 1693 | |9;json-stringify-tinderbox;58;57;59;62;63;58;55;57;58;66 04:56:02 INFO - PID 1693 | |10;stanford-crypto-aes;82;87;85;82;84;84;83;86;87;85 04:56:02 INFO - PID 1693 | |11;stanford-crypto-ccm;140;140;156;143;142;139;141;141;203;141 04:56:02 INFO - PID 1693 | |12;stanford-crypto-pbkdf2;191;194;186;185;188;231;240;222;184;188 04:56:02 INFO - PID 1693 | |13;stanford-crypto-sha256-iterative;65;98;89;68;70;67;70;67;70;72 04:56:02 INFO - PID 1693 | __end_tp_report 04:56:02 INFO - PID 1693 | __start_cc_report 04:56:02 INFO - PID 1693 | _x_x_mozilla_cycle_collect,1034 04:56:02 INFO - PID 1693 | __end_cc_report 04:56:02 INFO - PID 1693 | __startTimestamp1492257362667__endTimestamp 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | ------- Summary: start ------- 04:56:02 INFO - PID 1693 | Number of tests: 14 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#0] ai-astar Cycles:10 Average:122.00 Median:118.50 stddev:17.65 (14.9%) stddev-sans-first:17.48 04:56:02 INFO - PID 1693 | Values: 104.0 121.0 114.0 115.0 114.0 115.0 121.0 168.0 132.0 116.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:130.50 stddev:21.93 (16.8%) stddev-sans-first:22.31 04:56:02 INFO - PID 1693 | Values: 147.0 113.0 112.0 153.0 112.0 113.0 113.0 115.0 169.0 146.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#2] audio-dft Cycles:10 Average:205.40 Median:202.50 stddev:8.64 (4.3%) stddev-sans-first:8.62 04:56:02 INFO - PID 1693 | Values: 197.0 203.0 213.0 218.0 221.0 200.0 200.0 202.0 202.0 198.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#3] audio-fft Cycles:10 Average:67.00 Median:63.50 stddev:13.42 (21.1%) stddev-sans-first:13.52 04:56:02 INFO - PID 1693 | Values: 79.0 58.0 61.0 93.0 60.0 64.0 63.0 62.0 82.0 48.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:71.00 stddev:18.57 (26.2%) stddev-sans-first:19.66 04:56:02 INFO - PID 1693 | Values: 88.0 95.0 69.0 58.0 64.0 73.0 110.0 108.0 101.0 81.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:90.50 stddev:1.29 (1.4%) stddev-sans-first:1.32 04:56:02 INFO - PID 1693 | Values: 89.0 91.0 89.0 89.0 91.0 89.0 90.0 91.0 92.0 88.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:97.00 stddev:8.40 (8.7%) stddev-sans-first:8.83 04:56:02 INFO - PID 1693 | Values: 97.0 99.0 97.0 97.0 98.0 97.0 124.0 97.0 97.0 99.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:89.00 stddev:27.36 (30.7%) stddev-sans-first:28.25 04:56:02 INFO - PID 1693 | Values: 90.0 147.0 81.0 148.0 143.0 91.0 90.0 89.0 110.0 89.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:10.84 (18.7%) stddev-sans-first:11.15 04:56:02 INFO - PID 1693 | Values: 51.0 52.0 50.0 52.0 49.0 53.0 65.0 63.0 69.0 82.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:58.50 stddev:3.33 (5.7%) stddev-sans-first:3.50 04:56:02 INFO - PID 1693 | Values: 58.0 57.0 59.0 62.0 63.0 58.0 55.0 57.0 58.0 66.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:1.84 (2.2%) stddev-sans-first:1.72 04:56:02 INFO - PID 1693 | Values: 82.0 87.0 85.0 82.0 84.0 84.0 83.0 86.0 87.0 85.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:141.50 stddev:19.73 (13.9%) stddev-sans-first:20.68 04:56:02 INFO - PID 1693 | Values: 140.0 140.0 156.0 143.0 142.0 139.0 141.0 141.0 203.0 141.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.90 Median:192.50 stddev:21.39 (11.1%) stddev-sans-first:22.39 04:56:02 INFO - PID 1693 | Values: 191.0 194.0 186.0 185.0 188.0 231.0 240.0 222.0 184.0 188.0 04:56:02 INFO - PID 1693 | 04:56:02 INFO - PID 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:70.00 stddev:10.89 (15.6%) stddev-sans-first:11.09 04:56:02 INFO - PID 1693 | Values: 65.0 98.0 89.0 68.0 70.0 67.0 70.0 67.0 70.0 72.0 04:56:02 INFO - PID 1693 | -------- Summary: end -------- 04:56:02 INFO - PID 1693 | 04:56:03 INFO - TEST-INFO | 1693: exit 0 04:56:03 INFO - TEST-OK | kraken | took 61642ms 04:56:03 INFO - SUITE-END | took 1178s 04:56:04 INFO - Completed test suite (00:19:38) 04:56:04 INFO - javascript benchmark 04:56:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7905.02435394338, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.5232267482547, 3472.496488009237, 3574.981130377843, 3645.854165833367, 3665.4135338345855, 5658.886822263552, 6075.210222671047, 6181.6600086995195, 6185.319614842364, 6206.193194884659, 5036.0, 6143.389059649642, 6158.076288556718, 6205.286392064914, 6243.0, 5295.099833028395, 5429.809956651518, 5469.835904922858, 5504.4770746778995, 5559.416261292567, 5084.440711521748, 5375.247465354834, 5470.9452905471035, 5560.165975103747, 5630.324361076677, 5387.568994480433, 5429.511343979061, 5446.455354464561, 5471.097268950638, 5510.752016159283, 5456.236126942231, 5481.232627432123, 5493.917591236134, 5497.697626630534, 5503.642263252876, 4382.6055654991205, 5405.783768649249, 5419.647722897999, 5425.050616142199, 5432.103702889019, 6130.184124957599, 6135.600157732645, 6159.168512250833, 6174.722137503778, 6183.690815459209, 6641.335866413368, 6659.866802663968, 6675.566088204299, 6691.665416729193, 6697.19633643961, 6784.151981002375, 6790.3888650021245, 6797.048413222153, 6804.251532331439, 6813.454923606099, 6165.660888651078, 6208.844778880474, 6229.190205273286, 6293.402126797947, 6322.051692246154, 6843.213030501556, 6867.931320686729, 6931.202911665223, 6932.722691092401, 6974.686139123752, 6321.462675672619, 6386.393292637192, 6415.1981002374705, 6538.574992625464, 6548.083268342436, 6624.536282460182, 6698.33016698336, 6707.3628005339415, 6731.124953755981, 6757.560758550679, 6344.809655710336, 6431.067495213168, 6682.198136223684, 6688.899666505006, 6695.531312808057, 6544.44372228366, 6551.312112228243, 6622.668866556653, 6639.070530125786, 6656.467482601381, 4584.724916504953, 5376.78492860289, 5392.622516423891, 5419.214213939035, 5429.837104886859, 4702.130105930414, 4773.284007398918, 4787.114383839001, 4796.640251981115, 4816.0, 6137.131844484766, 6291.087792270096, 6324.272708638566, 6363.459105975951, 6367.0, 6769.221539523018, 6783.864322713518, 6784.59292442455, 6785.42323902464, 6790.660466976631, 5803.970980145073, 6306.905396419057, 6373.745050198033, 6380.840478988062, 6393.808185754435, 5787.1319302104175, 5838.883222335529, 5978.55160862937, 5996.730147143302, 6044.184035155197, 6915.965420172867, 6930.237673855972, 6934.687939042654, 6938.861222775416, 6959.686814093277, 6668.433183179484, 6694.966525167343, 6740.921452567565, 6748.865022699617, 6777.762778302736, 6592.868142637216, 6686.231083425469, 6876.484263680144, 6893.724251029903, 6903.965480172567, 6629.5359324846795, 6675.299093595297, 6680.699368528525, 6682.665866706742, 6717.664116794239, 5312.946870531246, 6360.713767880549, 6752.459803215829, 6769.323067693192, 6789.626570538668, 6247.781327653511, 6356.078368636614, 6397.840053998501, 6453.354664533509, 6468.223813142265, 6526.738930442729, 6540.803775886731, 6546.312637173219, 6547.869042619026, 6559.344065593403, 6284.277308109626, 6308.810735677937, 6406.0, 6434.8391290218115, 6454.806355809334, 4677.836275730333, 6022.518198544019, 6227.439530442282, 6525.249596296487, 6529.542931994904, 5904.3210030845285, 5992.460678538952, 6354.841128971812, 6354.951433013501, 6441.355864413521], "value": 6072.50950146451, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.991085066238, 727.2618292433178, 806.133406587918, 1152.8847115288477, 1266.6580023393678, 37439.43840842389, 38524.614753852526, 38546.22907541851, 38581.61418385815, 38620.61379386205, 38879.0, 39417.620383286594, 39418.81743547691, 39486.01284967877, 39526.40710389339, 8058.274755272039, 8210.630521626541, 8469.74590762278, 8673.522956237404, 8716.912830871674, 8526.147385261485, 8627.870581941275, 8635.654573817072, 8643.913560864405, 8644.740657780276, 8580.656773729042, 8593.0, 8643.956780216091, 8669.263112635434, 8677.869831952494, 8544.78638034051, 8607.526586037766, 8638.09300023501, 8639.136086391374, 8639.43843650167, 8404.285635720971, 8449.94375703037, 8455.069942306342, 8471.915280847174, 8479.236868681848, 37770.0, 37790.81104594487, 37876.62123378786, 37887.0, 38058.42912356317, 3627.9455808162897, 3672.338978983782, 3674.7978861162624, 3677.42999835026, 3677.5770786359644, 30594.541081883788, 30663.08010759681, 30722.539161912588, 30763.38473230523, 30840.845795771103, 3107.673694262115, 3131.984340078285, 3135.3885992231526, 3144.166795799115, 3146.65386807451, 250290.0, 254880.72559637084, 283399.0, 298468.99999999785, 298847.0, 47995.76002120037, 48080.0, 48240.758796205795, 48256.0, 48260.82826272826, 50218.224904135765, 50244.49755502398, 50509.49490505048, 50578.747106264236, 50642.493575064516, 14370.99403041798, 14460.493882714054, 14564.980451368303, 14585.270736463135, 14606.269686515632, 11851.288922664668, 11882.049436045269, 11959.222650527689, 11960.820587691192, 11969.700757480958, 13331.40008699611, 13510.0, 13559.728805423836, 13589.320533973261, 13618.319084045757, 5907.1139329100115, 5958.165856780054, 5960.0, 5971.312909190881, 5973.163757073926, 888.8888888888889, 944.15026476172, 978.4325091446943, 1018.5416562546884, 1067.770429357692, 23962.52074958491, 24064.398390040038, 24220.636690449657, 24374.87812560961, 24438.511229775304, 1013.2451323763843, 1143.9656810295705, 1175.4710380328715, 1176.3882780953857, 1180.4097951024487, 11660.53357865676, 12454.0, 12493.437795299233, 12530.624081277576, 12545.623631291075, 327696.0, 328600.0, 330241.0, 330914.0, 331063.0, 55014.449855501734, 55282.0, 55397.72301138549, 55542.0, 55630.0, 1486.0118021515786, 1520.3766455753089, 1572.2374648295568, 1572.300326354784, 1576.7556028815552, 20655.483612909797, 23782.762172378054, 23878.0, 24046.87976560106, 24101.397465063514, 37695.623043769214, 37772.2445551093, 37867.242655147296, 37885.62114378821, 37891.86324410272, 296235.5188224045, 297251.0, 298077.0, 298313.0, 298999.0, 33071.50392744063, 33538.83230583832, 33618.49572256369, 33646.0, 34302.48546271758, 35438.82280588581, 42925.0, 43288.783556083275, 43404.0, 43879.0, 28739.568906466837, 29800.0, 30053.3989320208, 30449.391012180076, 30605.23486912756, 29611.40777184487, 30189.849050754605, 30270.54594181045, 30432.847835761564, 30452.39095218039, 35116.29767404689, 35187.82406087953, 35640.10899727424, 35824.52193475816, 35999.820000899825, 29641.851790740908, 30083.247918802204, 30772.38455230838, 30855.69144308528, 31143.377132457677, 20655.58688826185, 22674.0, 23705.644415333438, 23939.28182154538, 23961.880190598935], "value": 17544.475984923803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.6297742903808, 421.2669954279553, 422.85200179937044, 425.7871064467766, 459.1803630519521, 19694.409167724956, 21254.681179782314, 21941.670874936848, 22032.779672203273, 22117.668234976467, 20487.0, 22658.0, 23345.949432275545, 24073.39816504588, 24250.272491825275, 6234.625922444668, 6257.405546473089, 6478.481721462272, 6489.805305840832, 6491.2535058468175, 6052.606580572271, 6348.26994895586, 6420.967895160541, 6428.582142160744, 6429.196350456193, 5958.046712525997, 6358.554901156921, 6373.649449280288, 6382.361763823604, 6383.0744542041375, 6179.19670442844, 6267.871783079044, 6272.435480806749, 6285.748570057192, 6291.276503202122, 5456.836294911159, 5474.315710536183, 5505.229267902497, 5540.418256083134, 5557.277553917965, 27414.45171096567, 27939.86030069857, 28450.430991380264, 28591.57112643312, 28812.42375152506, 1993.4119434766778, 2209.55808838233, 2266.841321107523, 2271.931842044741, 2274.55646149001, 14382.28088595566, 17848.643027139515, 18378.448646540626, 18419.35532256378, 18630.25478980839, 2121.872687638747, 2144.6997420361163, 2182.639864422368, 2193.320070778064, 2197.7142971413773, 155442.0, 159418.0, 160638.0, 161823.99999999884, 162991.0, 11514.539418423337, 12199.14605977573, 12280.0, 12630.716013836469, 12684.42920068599, 16419.67160656804, 16584.585385365463, 16660.58348541296, 16663.83336166647, 16676.249568769435, 8748.343874209333, 9025.368224224241, 9081.727548173565, 9207.401518901384, 9236.214921731593, 8662.91337086621, 8675.089115642893, 8703.737957996182, 8720.345974051972, 8763.605637746317, 7284.688756023967, 7943.960280198562, 8052.235037671412, 8093.433459657767, 8153.899223604856, 2168.750593681715, 2173.793489618484, 2177.421369507095, 2178.9346319610436, 2255.289583781104, 895.1853813030242, 920.8204400142042, 927.1840780113457, 930.5114814722325, 952.5761036338763, 19771.30800422007, 20302.898485507478, 20720.06759695817, 21033.68449473259, 21450.678239826415, 839.8656215005569, 864.2092485375811, 954.9761255968656, 956.8469044952774, 989.7773001074701, 10390.376577405228, 10975.50610222542, 10994.450277486254, 11010.449477526092, 11018.44907754609, 563670.0, 565495.0, 570320.0, 575949.0, 580612.0, 114762.85237147522, 127977.27895562844, 135310.97033544505, 146407.80388294184, 147090.82000980098, 1181.5451051345294, 1215.380156120385, 1257.698152443407, 1261.7949857885696, 1262.5770366927181, 16601.83398166051, 20912.05895734726, 22618.208362707228, 23330.883345583843, 23370.182043628392, 59222.09156319184, 59575.10637340356, 60416.69791651014, 61275.69362153339, 62179.0, 64190.0, 81578.0, 81962.59018705107, 82659.0, 83085.0, 8971.327150463872, 9285.9785423602, 9307.72076837696, 13312.600621981355, 13601.455941762219, 11610.6516804496, 12323.69190770238, 14142.22217778032, 15034.0, 15047.924760376129, 11837.704057398289, 12252.693682658004, 12348.88860002604, 12439.06706996997, 12452.501899923902, 11780.587679431179, 11817.29096254193, 11819.881801181878, 11882.108841836724, 12120.0, 10763.0, 12549.560765373168, 12785.424655890693, 12930.806037909251, 13042.347882605642, 13628.0, 13657.863421365659, 13671.974601905096, 13782.793258101337, 13969.882409407426, 11843.703907402383, 12220.816687749868, 12237.694057648274, 12482.563110291096, 12609.87390126087], "value": 10798.833567385906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.2048499203006, 1406.9366878490473, 1409.6396976917279, 1422.3315041930289, 1430.8068410764547, 11508.769824603514, 11792.233504822181, 11949.283043017425, 11967.0, 12206.755864882696, 11891.940540297308, 12045.337506437143, 12112.81830772539, 12136.93931530341, 12140.210886292385, 2523.419613488894, 2552.3619095226195, 2567.499337629163, 2568.024150822685, 2574.7167811540717, 2482.7765501104896, 2496.1887386599337, 2538.390786211305, 2543.7710606045453, 2555.3100662821025, 2461.5323088613104, 2519.748025197484, 2534.8605826679527, 2538.6953565572157, 2540.491901619674, 2448.2165706973865, 2512.9120480783176, 2527.8609676467786, 2528.873556322195, 2530.708968468631, 2412.4210189554556, 2511.824172307939, 2524.924252272416, 2525.229804909502, 2529.127451029392, 11991.520339186422, 12055.578054768128, 12056.819147712704, 12075.215111017844, 12099.939500302531, 6569.572977756478, 6789.388954994025, 6818.795436136924, 6832.0, 6832.59004459729, 4009.4386785850006, 4220.556841531657, 4302.290122129845, 4304.182205380999, 4337.7180483268485, 1234.2594443334017, 1241.819936109259, 1250.6156073246038, 1258.4966013594544, 1260.6974326161746, 15097.3206205721, 15679.059256444763, 16610.58473538171, 16763.245653945603, 16827.41104061352, 5519.199716041152, 5626.803061892896, 5817.854553636108, 5854.795082172103, 5858.912116318259, 11311.095112390989, 11752.353620550952, 12458.875411245952, 12460.937695311466, 12500.812487812691, 6535.705893234815, 6577.6053436793945, 6584.078229047937, 6588.967055164693, 6596.4393026592315, 6084.330723620398, 6196.566240363131, 6224.719887604978, 6225.533085018642, 6230.626162430269, 3774.641409066134, 4421.447319085114, 4531.45622525299, 4537.3647689323525, 4548.0, 1312.0, 1327.8340207474066, 1333.240053169684, 1344.8251727275588, 1348.7909374047038, 767.6929228308721, 775.6625867747548, 797.0833541427405, 800.6237068577759, 803.9227435236811, 6387.872242555123, 6841.931580684229, 6955.130608673916, 6995.510314277952, 7105.324994125654, 934.9439033658002, 942.2038377570941, 942.6700654770775, 945.3429866243033, 977.9511024448749, 4198.8110535026, 4382.364557139261, 4404.735715856995, 4404.757738324423, 4423.867283981485, 13313.40089695966, 14630.634234144232, 14798.186099764402, 15469.0, 15476.839237057266, 14759.557213283619, 15310.770338444932, 15312.923435382974, 15385.38458461649, 15441.845581544265, 7327.303906128909, 8539.402241843136, 8765.737027889047, 8787.516686582172, 8807.647694092164, 6058.182145410313, 6504.764094821969, 6985.0, 7003.964980175067, 7213.098362704662, 11568.363739994382, 13010.284434356201, 13814.171149731048, 13894.957878159381, 13940.721185576029, 11797.76404471923, 13792.517261895786, 14245.287735613385, 14312.71374572482, 14389.208593527457, 9584.137427631547, 9667.081627245401, 9774.413535187912, 9799.951000244953, 9809.117179453884, 10870.0, 10879.891201087888, 10994.230403871652, 11046.889531104907, 11050.447477625925, 7842.9215707842195, 9159.0, 9258.444493330422, 9474.052594740471, 9474.478903660365, 9064.592093355683, 9186.448813071238, 9191.0, 9220.124088211609, 9229.815403691755, 7071.611061391673, 8176.427650064438, 8223.465474744122, 8231.300339471212, 8274.0, 5895.498882595028, 6134.601250918855, 6134.773045391029, 6168.8766224674355, 6247.875042499216, 4920.794405370707, 4930.82742104039, 6047.66737829406, 6180.969095154495, 6400.9039864403], "value": 5438.398459824448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.9743266687663, 397.2729904275176, 399.3069385804191, 401.1835913915181, 409.9979500102497, 5089.567386772129, 5356.892862142755, 5403.946230485057, 6082.118092876536, 6158.1994340735755, 5499.010178167928, 5921.763129474826, 6026.548008899328, 6049.727762250698, 6066.241719785027, 3726.621150174439, 4198.328267477189, 4612.3542704021465, 4639.327297541854, 4643.4892161862335, 4661.976690116561, 4662.950836061893, 4668.719876807386, 4668.906621867561, 4669.509701481329, 4423.51341352451, 4566.2876421342, 4576.427946506687, 4603.240465323234, 4615.399998000255, 4571.679982401233, 4572.5427457254345, 4578.267477203664, 4589.357489951392, 4597.241455159895, 4074.9828834727, 4092.8158232879296, 4101.097758493127, 4116.156187981456, 4123.814428350732, 4778.761061946889, 5854.736536855852, 5934.5845790794665, 5943.375945525744, 5959.582829201958, 5060.291559181717, 5315.627906046579, 5332.546733527654, 5333.2266821310695, 5334.973325133349, 6362.713677884506, 6483.935160648381, 6537.477001839841, 6570.310117437648, 6575.210974683021, 3740.4576336431337, 3988.581198974124, 4018.598140185987, 4068.837246510136, 4381.9123617527475, 6210.844728881814, 6678.866422671568, 6930.5148639594745, 6941.68762405693, 6979.0, 4002.599740025974, 4399.846005389796, 4440.955590444054, 4442.888927776831, 4453.287474004143, 4284.7145856243005, 4525.637948964075, 4533.002739397327, 4534.251848445036, 4542.818287268472, 4782.832600858953, 5226.790928362823, 5261.263423120766, 5271.920921186185, 5368.570514358842, 5034.697918124851, 6531.982830559267, 6565.310642382481, 6573.769918052845, 6579.80260592183, 1500.5423345879394, 1527.6715506166006, 1529.1283968138277, 1532.7317719399061, 1546.9303881325368, 775.2402645407532, 847.8304339132198, 890.123228619809, 900.5902314447042, 986.1306771959801, 6025.945459544562, 6228.875422491616, 6247.219097612799, 6258.937410625836, 6335.271443784024, 6734.8653026940165, 6767.390934815791, 6774.627395493197, 6777.72889084441, 6787.490938179656, 5310.734463276821, 6145.569810113249, 6203.379662033761, 6204.0, 6232.407921247474, 2755.5040092783493, 2956.3200463893427, 3532.293541291752, 3545.592256890439, 3551.5560554930635, 6812.557183783138, 6962.443004559623, 6974.128233970754, 7013.158420989514, 7020.719171233093, 5820.0, 6044.516438684895, 6946.687399067054, 6952.7218911244, 6963.61700106499, 5445.019896418604, 6710.261871194165, 6861.725530978705, 6927.930720692729, 6994.922234216929, 5395.946040539544, 5648.604597678123, 6055.757769689163, 6176.104464852481, 6788.7284508619105, 6299.370062993664, 6612.735490580323, 6638.970959501285, 6652.434543063894, 6653.600783952978, 5707.714614269187, 6297.110866740051, 6318.62088274705, 6566.0, 6904.723811047502, 3599.9820000899826, 3881.7088718346804, 4403.5156132826005, 4412.161689279027, 4457.7771111444945, 5684.806190699834, 6389.393007664265, 6648.1357423536565, 6692.096566963398, 6738.898916516354, 5828.0, 5880.764769409176, 6381.968090159519, 6532.477401807939, 6534.575252608755, 5286.942611477797, 5699.943000569941, 6421.486281097595, 6485.573173901734, 6504.934950650433, 5665.920537213365, 5966.880662386815, 6230.940740074107, 6384.201974753156, 6413.230412350548, 6484.319146489739, 6521.445677117498, 6528.477721782341, 6530.640814755234, 6543.116679248241, 5078.720670363018, 5296.549793267615, 6007.038873780349, 6345.206849143857, 6348.809535713936], "value": 4698.134247447341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.5651956644496, 832.3549249331771, 841.2554888923305, 866.4844417571546, 871.7079778274277, 13806.654833629163, 14612.904032197588, 14728.337224824882, 16294.83705162948, 16787.580310492245, 16573.91713041433, 17054.48836534903, 17125.82874171258, 17241.0, 17348.392806251784, 981.563204374052, 995.5619527407954, 1010.5149528226456, 1016.8118898003856, 1018.1396719771781, 1003.9648612298571, 1006.6828948881079, 1011.7116621762799, 1013.1185868294557, 1016.2581315639587, 1038.1124138861278, 1046.8063408269495, 1047.984280235797, 1049.412329095705, 1051.2641151194196, 1030.3766221436, 1033.62272770439, 1038.9480525973709, 1041.229490177271, 1041.9374837509774, 767.1982777997007, 775.0853992289096, 775.1202385292734, 775.4765533265023, 777.211130702332, 16340.428085017085, 16821.327146914107, 16881.83118168815, 16891.070991095487, 16902.830971690248, 16293.185340732916, 16711.415100471426, 16783.16084195785, 17006.659866802718, 17036.233369498277, 13625.25061121638, 13980.951428642791, 14112.71774564503, 14116.082454640415, 14132.081414708011, 3037.331787006855, 3388.542546756181, 3406.199543107368, 3410.539577157077, 3458.757886947915, 111305.88694113036, 111898.0, 112026.87973120245, 112342.99999999919, 113260.4336978318, 12044.0, 12115.636530904087, 12161.452734626962, 12189.939050304693, 12213.389330533439, 20066.19735210575, 20137.0, 20333.694994575093, 20350.796492035188, 24492.265232043068, 6361.681915904186, 7804.843903121906, 7805.570693611792, 7827.686892524235, 7829.686812527549, 3791.3933770596573, 3812.5615554211067, 3837.57786643469, 3864.420336949424, 3869.690424766012, 4233.682473814476, 4320.0, 4320.790178749955, 4325.307950727868, 4330.566943305645, 931.2456909903, 959.9616015359447, 973.1582181413169, 977.7848873247874, 980.5587485631352, 633.3128555517316, 664.6045602866287, 668.8428219368444, 681.0465348512123, 687.2405991379553, 10598.0, 10860.782784344268, 11364.261323013978, 12043.09676774228, 12240.265584064984, 630.7697690342992, 638.3010603389281, 664.2659860853784, 691.87892118879, 697.6581475077176, 5438.374586922476, 5477.20580515823, 5615.157726341082, 5643.746031428514, 5731.340895796953, 99516.50241748746, 100602.49698751606, 105564.0, 108451.0, 109675.0, 87275.0, 88526.55736721405, 88612.5569372149, 89403.10596894078, 90815.0, 80990.380192397, 84036.57981710053, 85408.15663295166, 86788.56605716932, 86980.0, 8022.518648881086, 8584.65661373538, 10095.394276343442, 11243.931826476472, 11351.035162011322, 32480.187995300308, 42925.356119657605, 42988.49540266076, 44009.89975250644, 44775.32837007513, 55291.682499050185, 56545.0, 70648.23379415351, 70895.72339215755, 71022.0, 15313.0, 16667.833321667113, 16901.239444224793, 17145.0, 17188.82811171872, 18040.729389059437, 18199.45401637953, 18431.63136737231, 18532.81467185311, 18717.251309947995, 16935.491935241964, 17007.404740834012, 17053.891497052653, 17240.224189911736, 17337.959722416694, 17043.31826726917, 17089.658206836044, 17406.216720247365, 17598.29606815713, 17626.64746705033, 16366.0, 17038.744418833976, 17045.91477042607, 17136.657266854843, 17250.568735781202, 11610.0, 11951.940240298743, 12164.635060948185, 12203.389830508617, 12526.87473125257, 12251.448684809384, 13183.0, 13222.603321900358, 13409.0, 13449.596512104652], "value": 8300.531651096646, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 121.0, 114.0, 115.0, 114.0, 115.0, 121.0, 168.0, 132.0, 116.0], "value": 122.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 112.0, 153.0, 112.0, 113.0, 113.0, 115.0, 169.0, 146.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 203.0, 213.0, 218.0, 221.0, 200.0, 200.0, 202.0, 202.0, 198.0], "value": 205.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 61.0, 93.0, 60.0, 64.0, 63.0, 62.0, 82.0, 48.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 95.0, 69.0, 58.0, 64.0, 73.0, 110.0, 108.0, 101.0, 81.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 89.0, 89.0, 91.0, 89.0, 90.0, 91.0, 92.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 97.0, 97.0, 98.0, 97.0, 124.0, 97.0, 97.0, 99.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 147.0, 81.0, 148.0, 143.0, 91.0, 90.0, 89.0, 110.0, 89.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 50.0, 52.0, 49.0, 53.0, 65.0, 63.0, 69.0, 82.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 59.0, 62.0, 63.0, 58.0, 55.0, 57.0, 58.0, 66.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 85.0, 82.0, 84.0, 84.0, 83.0, 86.0, 87.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 156.0, 143.0, 142.0, 139.0, 141.0, 141.0, 203.0, 141.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 194.0, 186.0, 185.0, 188.0, 231.0, 240.0, 222.0, 184.0, 188.0], "value": 200.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 98.0, 89.0, 68.0, 70.0, 67.0, 70.0, 67.0, 70.0, 72.0], "value": 73.6, "unit": "score"}]}]} 04:56:04 INFO - Return code: 0 04:56:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:04 ERROR - # TBPL SUCCESS # 04:56:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:56:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:56:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:56:04 INFO - 2017-04-15 04:56:04.522 screenresolution[1699:13419] starting screenresolution argv=screenresolution get 04:56:04 INFO - 2017-04-15 04:56:04.524 screenresolution[1699:13419] Display 0: 1600x1200x32@60 04:56:04 INFO - 2017-04-15 04:56:04.530 screenresolution[1700:13422] starting screenresolution argv=screenresolution list 04:56:04 INFO - Available Modes on Display 0 04:56:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:56:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:56:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:56:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:56:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:56:04 INFO - Intel Iris: 04:56:04 INFO - Chipset Model: Intel Iris 04:56:04 INFO - Type: GPU 04:56:04 INFO - Bus: Built-In 04:56:04 INFO - VRAM (Dynamic, Max): 1536 MB 04:56:04 INFO - Vendor: Intel (0x8086) 04:56:04 INFO - Device ID: 0x0a2e 04:56:04 INFO - Revision ID: 0x0009 04:56:04 INFO - Displays: 04:56:04 INFO - Display: 04:56:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:56:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:56:04 INFO - Display Serial Number: 1600x1200 60 04:56:04 INFO - Main Display: Yes 04:56:04 INFO - Mirror: Off 04:56:04 INFO - Online: Yes 04:56:04 INFO - Rotation: Supported 04:56:04 INFO - Return code: 0 04:56:04 INFO - Running post-action listener: _resource_record_post_action 04:56:04 INFO - [mozharness: 2017-04-15 11:56:04.772904Z] Finished run-tests step (success) 04:56:04 INFO - Running post-run listener: _resource_record_post_run 04:56:04 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 34189824; Write bytes: 521259008; Read time: 209; Write time: 1716 04:56:04 INFO - TinderboxPrint: CPU usage
54.3% 04:56:04 INFO - TinderboxPrint: I/O read bytes / time
34,189,824 / 209 04:56:04 INFO - TinderboxPrint: I/O write bytes / time
521,259,008 / 1,716 04:56:04 INFO - TinderboxPrint: CPU idle
2,193.5 (45.7%) 04:56:04 INFO - TinderboxPrint: CPU system
966.8 (20.2%) 04:56:04 INFO - TinderboxPrint: CPU user
1,637.5 (34.1%) 04:56:04 INFO - TinderboxPrint: Swap in / out
238,374,912 / 0 04:56:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207571456; Write bytes: 203034624; Read time: 16205; Write time: 451 04:56:04 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 32088576; Write bytes: 311146496; Read time: 189; Write time: 1237 04:56:05 INFO - Running post-run listener: _upload_blobber_files 04:56:05 INFO - Blob upload gear active. 04:56:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:05 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 04:56:05 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'] 04:56:05 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 04:56:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:56:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:56:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:09 INFO - (blobuploader) - INFO - Done attempting. 04:56:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:56:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:12 INFO - (blobuploader) - INFO - Done attempting. 04:56:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:56:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:15 INFO - (blobuploader) - INFO - Done attempting. 04:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:56:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:18 INFO - (blobuploader) - INFO - Done attempting. 04:56:18 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:18 INFO - Return code: 0 04:56:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856b0d6525726b55c115f05f70beafa7108a5396b0dc5ffa4ea48c23b8700efd12e10f646e3d6df45a0cfd3e1f2a751c58ac1aaa0f3fdefa87eba0f732d297b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514ee42f455334ddbd0419dda17409899b90239972af1737d8afb3ae4cecd8ad9537fb6b7d8ca48b1c96ace26fc877da0961523731c056f259e3de8415147bbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411fb01c3a8903145bcd2521e5aeb9ddcbd49a657f232135273fd2baf73c785959ffbd25152045afa0d5f01428781d62ef3be08e894052169efccfcb2fac1c20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92c5cae830428af8bc952a23089b5899ec6badb261177dd66984b79a8787f3284ea843e0fc777f64fc7c9a6b230fe2b181e4b67db9f7c506b3bc40b94883ae83"} 04:56:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:18 INFO - Contents: 04:56:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856b0d6525726b55c115f05f70beafa7108a5396b0dc5ffa4ea48c23b8700efd12e10f646e3d6df45a0cfd3e1f2a751c58ac1aaa0f3fdefa87eba0f732d297b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514ee42f455334ddbd0419dda17409899b90239972af1737d8afb3ae4cecd8ad9537fb6b7d8ca48b1c96ace26fc877da0961523731c056f259e3de8415147bbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411fb01c3a8903145bcd2521e5aeb9ddcbd49a657f232135273fd2baf73c785959ffbd25152045afa0d5f01428781d62ef3be08e894052169efccfcb2fac1c20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92c5cae830428af8bc952a23089b5899ec6badb261177dd66984b79a8787f3284ea843e0fc777f64fc7c9a6b230fe2b181e4b67db9f7c506b3bc40b94883ae83"} 04:56:18 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:18 INFO - Copying logs to upload dir... 04:56:18 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.500212 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-15 04:56:18.967052) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-15 04:56:18.970399) ========= 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.munbnufUA4/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.KehKitXzbs/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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/856b0d6525726b55c115f05f70beafa7108a5396b0dc5ffa4ea48c23b8700efd12e10f646e3d6df45a0cfd3e1f2a751c58ac1aaa0f3fdefa87eba0f732d297b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514ee42f455334ddbd0419dda17409899b90239972af1737d8afb3ae4cecd8ad9537fb6b7d8ca48b1c96ace26fc877da0961523731c056f259e3de8415147bbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411fb01c3a8903145bcd2521e5aeb9ddcbd49a657f232135273fd2baf73c785959ffbd25152045afa0d5f01428781d62ef3be08e894052169efccfcb2fac1c20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92c5cae830428af8bc952a23089b5899ec6badb261177dd66984b79a8787f3284ea843e0fc777f64fc7c9a6b230fe2b181e4b67db9f7c506b3bc40b94883ae83"} build_url:https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010907 build_url: 'https://queue.taskcluster.net/v1/task/cBG3x9cjRjSMZCyS25GAwg/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/856b0d6525726b55c115f05f70beafa7108a5396b0dc5ffa4ea48c23b8700efd12e10f646e3d6df45a0cfd3e1f2a751c58ac1aaa0f3fdefa87eba0f732d297b6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514ee42f455334ddbd0419dda17409899b90239972af1737d8afb3ae4cecd8ad9537fb6b7d8ca48b1c96ace26fc877da0961523731c056f259e3de8415147bbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411fb01c3a8903145bcd2521e5aeb9ddcbd49a657f232135273fd2baf73c785959ffbd25152045afa0d5f01428781d62ef3be08e894052169efccfcb2fac1c20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92c5cae830428af8bc952a23089b5899ec6badb261177dd66984b79a8787f3284ea843e0fc777f64fc7c9a6b230fe2b181e4b67db9f7c506b3bc40b94883ae83"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-15 04:56:19.009269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 04:56:19.009611) ========= 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.munbnufUA4/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.KehKitXzbs/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.005102 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-15 04:56:19.061622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-15 04:56:19.062362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-15 04:56:19.063167) ========= ========= Total master_lag: 0.31 =========