builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0163 starttime: 1492462229.42 results: success (0) buildid: 20170417124206 builduid: a8e0d08f661e4d02ae7905ca3783f27c revision: cac374fb0de1d5a5ccf53e0d61e3f47a66fe0603 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.417267) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.417861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.418183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.445896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.446340) ========= 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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-17 13:50:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2017-04-17 13:50:29 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170215 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.641956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.642384) ========= 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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.029103 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:29.693685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 13:50:29.694371) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cac374fb0de1d5a5ccf53e0d61e3f47a66fe0603 --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 cac374fb0de1d5a5ccf53e0d61e3f47a66fe0603 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6FPwr3fdy2/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.K5q1IfTAl2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-17 13:50:29,752 truncating revision to first 12 chars 2017-04-17 13:50:29,752 Setting DEBUG logging. 2017-04-17 13:50:29,752 attempt 1/10 2017-04-17 13:50:29,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cac374fb0de1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 13:50:30,899 unpacking tar archive at: mozilla-central-cac374fb0de1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.418400 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 13:50:31.139377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:31.139765) ========= script_repo_revision: cac374fb0de1d5a5ccf53e0d61e3f47a66fe0603 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:31.140217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:31.140524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 13:50:31.161287) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-17 13:50:31.161708) ========= /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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:50:31 INFO - MultiFileLogger online at 20170417 13:50:31 in /builds/slave/test 13:50:31 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 13:50:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:31 INFO - {'append_to_log': False, 13:50:31 INFO - 'base_work_dir': '/builds/slave/test', 13:50:31 INFO - 'blob_upload_branch': 'Firefox', 13:50:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:31 INFO - 'branch': 'Firefox', 13:50:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:31 INFO - 'config_files': ('talos/mac_config.py',), 13:50:31 INFO - 'default_actions': ('clobber', 13:50:31 INFO - 'read-buildbot-config', 13:50:31 INFO - 'download-and-extract', 13:50:31 INFO - 'populate-webroot', 13:50:31 INFO - 'create-virtualenv', 13:50:31 INFO - 'install', 13:50:31 INFO - 'run-tests'), 13:50:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:31 INFO - 'download_minidump_stackwalk': True, 13:50:31 INFO - 'download_symbols': 'ondemand', 13:50:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:31 INFO - 'gecko_profile': False, 13:50:31 INFO - 'gecko_profile_interval': 0, 13:50:31 INFO - 'installer_path': 'installer.exe', 13:50:31 INFO - 'log_level': 'info', 13:50:31 INFO - 'log_name': 'talos', 13:50:31 INFO - 'log_to_console': True, 13:50:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:31 INFO - 'opt_config_files': (), 13:50:31 INFO - 'pip_index': False, 13:50:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:31 INFO - 'cmd': ('bash', 13:50:31 INFO - '-c', 13:50:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:31 INFO - 'enabled': True, 13:50:31 INFO - 'halt_on_failure': False, 13:50:31 INFO - 'name': 'check_screen_resolution'},), 13:50:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:31 INFO - 'cmd': ('bash', 13:50:31 INFO - '-c', 13:50:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:31 INFO - 'enabled': True, 13:50:31 INFO - 'halt_on_failure': False, 13:50:31 INFO - 'name': 'check_screen_resolution'},), 13:50:31 INFO - 'run_cmd_checks_enabled': True, 13:50:31 INFO - 'suite': 'dromaeojs-e10s', 13:50:31 INFO - 'system_bits': '32', 13:50:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:31 INFO - 'title': 't-yosemite-r7-0163', 13:50:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:31 INFO - 'use_talos_json': True, 13:50:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:31 INFO - 'work_dir': 'build'} 13:50:31 INFO - [mozharness: 2017-04-17 20:50:31.331768Z] Running clobber step. 13:50:31 INFO - Running pre-action listener: _resource_record_pre_action 13:50:31 INFO - Running main action method: clobber 13:50:31 INFO - rmtree: /builds/slave/test/build 13:50:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:34 INFO - Running post-action listener: _resource_record_post_action 13:50:34 INFO - [mozharness: 2017-04-17 20:50:34.084163Z] Finished clobber step (success) 13:50:34 INFO - [mozharness: 2017-04-17 20:50:34.084326Z] Running read-buildbot-config step. 13:50:34 INFO - Running pre-action listener: _resource_record_pre_action 13:50:34 INFO - Running main action method: read_buildbot_config 13:50:34 INFO - Using buildbot properties: 13:50:34 INFO - { 13:50:34 INFO - "project": "", 13:50:34 INFO - "product": "firefox", 13:50:34 INFO - "script_repo_revision": "production", 13:50:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:50:34 INFO - "repository": "", 13:50:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:50:34 INFO - "buildid": "20170417124206", 13:50:34 INFO - "pgo_build": "False", 13:50:34 INFO - "basedir": "/builds/slave/test", 13:50:34 INFO - "buildnumber": 40, 13:50:34 INFO - "slavename": "t-yosemite-r7-0163", 13:50:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:50:34 INFO - "platform": "yosemite_r7", 13:50:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:50:34 INFO - "branch": "mozilla-central", 13:50:34 INFO - "repo_path": "mozilla-central", 13:50:34 INFO - "revision": "cac374fb0de1d5a5ccf53e0d61e3f47a66fe0603", 13:50:34 INFO - "stage_platform": "macosx64", 13:50:34 INFO - "builduid": "a8e0d08f661e4d02ae7905ca3783f27c", 13:50:34 INFO - "slavebuilddir": "test" 13:50:34 INFO - } 13:50:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 13:50:34 INFO - Running post-action listener: _resource_record_post_action 13:50:34 INFO - [mozharness: 2017-04-17 20:50:34.087642Z] Finished read-buildbot-config step (success) 13:50:34 INFO - [mozharness: 2017-04-17 20:50:34.087757Z] Running download-and-extract step. 13:50:34 INFO - Running pre-action listener: _resource_record_pre_action 13:50:34 INFO - Running main action method: download_and_extract 13:50:34 INFO - mkdir: /builds/slave/test/build/tests 13:50:34 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')]} 13:50:34 INFO - trying https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 13:50:34 INFO - Downloading https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/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 13:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/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 13:50:35 INFO - Downloaded 1325 bytes. 13:50:35 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:50:35 INFO - Using the following test package requirements: 13:50:35 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 13:50:35 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:50:35 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:35 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 13:50:35 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'jsshell-mac.zip'], 13:50:35 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 13:50:35 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:50:35 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 13:50:35 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 13:50:35 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 13:50:35 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:50:35 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:50:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:50:37 INFO - Expected file size: 52663618 13:50:37 INFO - Obtained file size: 52663618 13:50:53 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 13:50:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:50:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:53 INFO - Fetch https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:50:55 INFO - Expected file size: 52663618 13:50:55 INFO - Obtained file size: 52663618 13:51:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 13:51:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:51:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 13:51:12 INFO - Expected file size: 14408802 13:51:12 INFO - Obtained file size: 14408802 13:51:13 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')]} 13:51:13 INFO - trying https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:51:13 INFO - Downloading https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 13:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/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 13:51:15 INFO - Downloaded 71426957 bytes. 13:51:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:51:15 INFO - mkdir: /builds/slave/test/properties 13:51:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:15 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:15 INFO - Contents: 13:51:15 INFO - build_url:https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:51:15 INFO - Running post-action listener: _resource_record_post_action 13:51:15 INFO - Running post-action listener: set_extra_try_arguments 13:51:15 INFO - [mozharness: 2017-04-17 20:51:15.869051Z] Finished download-and-extract step (success) 13:51:15 INFO - [mozharness: 2017-04-17 20:51:15.869199Z] Running populate-webroot step. 13:51:15 INFO - Running pre-action listener: _resource_record_pre_action 13:51:15 INFO - Running main action method: populate_webroot 13:51:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:15 INFO - '--tppagecycles', 13:51:15 INFO - '7'], 13:51:15 INFO - 'tests': ['tsvgm']}}, 13:51:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['damp', 'tps']}, 13:51:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:51:15 INFO - 'tests': ['damp', 'tps']}, 13:51:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['dromaeo_dom']}, 13:51:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:51:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:51:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:51:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:51:15 INFO - 'bloom_basic_ref']}, 13:51:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tsvgx', 13:51:15 INFO - 'tsvgr_opacity', 13:51:15 INFO - 'tart', 13:51:15 INFO - 'tscrollx', 13:51:15 INFO - 'cart', 13:51:15 INFO - 'tsvg_static']}, 13:51:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:15 INFO - 'tsvgr_opacity', 13:51:15 INFO - 'tart', 13:51:15 INFO - 'tscrollx', 13:51:15 INFO - 'cart', 13:51:15 INFO - 'tsvg_static']}, 13:51:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tp5o']}, 13:51:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:51:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s', 13:51:15 INFO - '--xperf_path', 13:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:15 INFO - 'tests': ['tp5n']}, 13:51:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:51:15 INFO - 'talos_options': ['--xperf_path', 13:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:15 INFO - 'tests': ['tp5n']}}, 13:51:15 INFO - 'talos.zip': {'path': '', 13:51:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:15 INFO - Running post-action listener: _resource_record_post_action 13:51:15 INFO - [mozharness: 2017-04-17 20:51:15.888999Z] Finished populate-webroot step (success) 13:51:15 INFO - [mozharness: 2017-04-17 20:51:15.889134Z] Running create-virtualenv step. 13:51:15 INFO - Running pre-action listener: _resource_record_pre_action 13:51:15 INFO - Running main action method: create_virtualenv 13:51:15 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:15 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 13:51:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:16 INFO - Using real prefix '/tools/python27' 13:51:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:19 INFO - Installing pip.................done. 13:51:19 INFO - Return code: 0 13:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:19 INFO - Reading from file tmpfile_stdout 13:51:19 INFO - Output received: 13:51:19 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) 13:51:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51:19 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')]} 13:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:19 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')]} 13:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:19 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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:19 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 13:51:19 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 13:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:19 INFO - 'HOME': '/Users/cltbld', 13:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:19 INFO - 'LOGNAME': 'cltbld', 13:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:19 INFO - 'MOZ_NO_REMOTE': '1', 13:51:19 INFO - 'NO_EM_RESTART': '1', 13:51:19 INFO - 'PAGER': '/bin/cat', 13:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:19 INFO - 'PWD': '/builds/slave/test', 13:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:19 INFO - 'SHELL': '/bin/bash', 13:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:19 INFO - 'USER': 'cltbld', 13:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:19 INFO - 'XPC_FLAGS': '0x0', 13:51:19 INFO - 'XPC_SERVICE_NAME': '0', 13:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:20 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 13:51:20 INFO - Cleaning up... 13:51:20 INFO - Return code: 0 13:51:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:20 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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:20 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 13:51:20 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 13:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:20 INFO - 'HOME': '/Users/cltbld', 13:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:20 INFO - 'LOGNAME': 'cltbld', 13:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:20 INFO - 'MOZ_NO_REMOTE': '1', 13:51:20 INFO - 'NO_EM_RESTART': '1', 13:51:20 INFO - 'PAGER': '/bin/cat', 13:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:20 INFO - 'PWD': '/builds/slave/test', 13:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:20 INFO - 'SHELL': '/bin/bash', 13:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:20 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:20 INFO - 'USER': 'cltbld', 13:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:20 INFO - 'XPC_FLAGS': '0x0', 13:51:20 INFO - 'XPC_SERVICE_NAME': '0', 13:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:20 INFO - Downloading/unpacking psutil>=3.1.1 13:51:20 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 13:51:20 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 13:51:20 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 13:51:20 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 13:51:20 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 13:51:20 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 13:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:23 INFO - Installing collected packages: psutil 13:51:23 INFO - Running setup.py install for psutil 13:51:24 INFO - building 'psutil._psutil_osx' extension 13:51:24 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 13:51:24 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 13:51:24 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 13:51:24 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 13:51:24 INFO - building 'psutil._psutil_posix' extension 13:51:24 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 13:51:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:24 INFO - ^ 13:51:24 INFO - 1 warning generated. 13:51:24 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 13:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:25 INFO - Successfully installed psutil 13:51:25 INFO - Cleaning up... 13:51:25 INFO - Return code: 0 13:51:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:25 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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:25 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 13:51:25 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 13:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:25 INFO - 'HOME': '/Users/cltbld', 13:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:25 INFO - 'LOGNAME': 'cltbld', 13:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:25 INFO - 'MOZ_NO_REMOTE': '1', 13:51:25 INFO - 'NO_EM_RESTART': '1', 13:51:25 INFO - 'PAGER': '/bin/cat', 13:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:25 INFO - 'PWD': '/builds/slave/test', 13:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:25 INFO - 'SHELL': '/bin/bash', 13:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:25 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:25 INFO - 'USER': 'cltbld', 13:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:25 INFO - 'XPC_FLAGS': '0x0', 13:51:25 INFO - 'XPC_SERVICE_NAME': '0', 13:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51:25 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 13:51:25 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 13:51:25 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 13:51:25 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 13:51:25 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 13:51:25 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 13:51:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:28 INFO - Installing collected packages: mozsystemmonitor 13:51:28 INFO - Running setup.py install for mozsystemmonitor 13:51:29 INFO - Successfully installed mozsystemmonitor 13:51:29 INFO - Cleaning up... 13:51:29 INFO - Return code: 0 13:51:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:29 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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:29 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 13:51:29 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 13:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:29 INFO - 'HOME': '/Users/cltbld', 13:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:29 INFO - 'LOGNAME': 'cltbld', 13:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:29 INFO - 'MOZ_NO_REMOTE': '1', 13:51:29 INFO - 'NO_EM_RESTART': '1', 13:51:29 INFO - 'PAGER': '/bin/cat', 13:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:29 INFO - 'PWD': '/builds/slave/test', 13:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:29 INFO - 'SHELL': '/bin/bash', 13:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:29 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:29 INFO - 'USER': 'cltbld', 13:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:29 INFO - 'XPC_FLAGS': '0x0', 13:51:29 INFO - 'XPC_SERVICE_NAME': '0', 13:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:29 INFO - Downloading/unpacking jsonschema==2.5.1 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51:32 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 13:51:32 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 13:51:32 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 13:51:32 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 13:51:32 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 13:51:32 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 13:51:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:32 INFO - warning: no files found matching '*.txt' 13:51:32 INFO - no previously-included directories found matching 'build' 13:51:32 INFO - no previously-included directories found matching 'dist' 13:51:32 INFO - no previously-included directories found matching '.git*' 13:51:32 INFO - Installing collected packages: jsonschema, functools32 13:51:32 INFO - Running setup.py install for functools32 13:51:33 INFO - warning: no files found matching '*.txt' 13:51:33 INFO - no previously-included directories found matching 'build' 13:51:33 INFO - no previously-included directories found matching 'dist' 13:51:33 INFO - no previously-included directories found matching '.git*' 13:51:33 INFO - Successfully installed jsonschema functools32 13:51:33 INFO - Cleaning up... 13:51:33 INFO - Return code: 0 13:51:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:33 INFO - 'HOME': '/Users/cltbld', 13:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:33 INFO - 'LOGNAME': 'cltbld', 13:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:33 INFO - 'MOZ_NO_REMOTE': '1', 13:51:33 INFO - 'NO_EM_RESTART': '1', 13:51:33 INFO - 'PAGER': '/bin/cat', 13:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:33 INFO - 'PWD': '/builds/slave/test', 13:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:33 INFO - 'SHELL': '/bin/bash', 13:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:33 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:33 INFO - 'USER': 'cltbld', 13:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:33 INFO - 'XPC_FLAGS': '0x0', 13:51:33 INFO - 'XPC_SERVICE_NAME': '0', 13:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:33 INFO - Cleaning up... 13:51:33 INFO - Return code: 0 13:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:33 INFO - 'HOME': '/Users/cltbld', 13:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:33 INFO - 'LOGNAME': 'cltbld', 13:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:33 INFO - 'MOZ_NO_REMOTE': '1', 13:51:33 INFO - 'NO_EM_RESTART': '1', 13:51:33 INFO - 'PAGER': '/bin/cat', 13:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:33 INFO - 'PWD': '/builds/slave/test', 13:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:33 INFO - 'SHELL': '/bin/bash', 13:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:33 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:33 INFO - 'USER': 'cltbld', 13:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:33 INFO - 'XPC_FLAGS': '0x0', 13:51:33 INFO - 'XPC_SERVICE_NAME': '0', 13:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:37 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 13:51:37 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 13:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:37 INFO - Downloading docopt-0.6.1.tar.gz 13:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:37 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:37 INFO - Running setup.py install for blobuploader 13:51:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:37 INFO - Running setup.py install for requests 13:51:38 INFO - Running setup.py install for docopt 13:51:38 INFO - Successfully installed blobuploader requests docopt 13:51:38 INFO - Cleaning up... 13:51:38 INFO - Return code: 0 13:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:38 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')]} 13:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:38 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')]} 13:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:38 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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:38 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 13:51:38 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 13:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:38 INFO - 'HOME': '/Users/cltbld', 13:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:38 INFO - 'LOGNAME': 'cltbld', 13:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:38 INFO - 'MOZ_NO_REMOTE': '1', 13:51:38 INFO - 'NO_EM_RESTART': '1', 13:51:38 INFO - 'PAGER': '/bin/cat', 13:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:38 INFO - 'PWD': '/builds/slave/test', 13:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:38 INFO - 'SHELL': '/bin/bash', 13:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:38 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:38 INFO - 'USER': 'cltbld', 13:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:38 INFO - 'XPC_FLAGS': '0x0', 13:51:38 INFO - 'XPC_SERVICE_NAME': '0', 13:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:38 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-IuCnTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9WCqX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EfklSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PueDI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bZNRXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-aLU31K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VNrf_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-waQUqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-oPWtWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-T12hFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-XHjRO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1a8wbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-8Hwlwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3G7qwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-02E3Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5IxvTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9j2h9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:40 INFO - Running setup.py install for manifestparser 13:51:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Running setup.py install for mozcrash 13:51:40 INFO - Running setup.py install for mozdebug 13:51:41 INFO - Running setup.py install for mozdevice 13:51:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozfile 13:51:41 INFO - Running setup.py install for mozhttpd 13:51:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozinfo 13:51:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozInstall 13:51:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozleak 13:51:41 INFO - Running setup.py install for mozlog 13:51:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for moznetwork 13:51:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozprocess 13:51:42 INFO - Running setup.py install for mozprofile 13:51:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozrunner 13:51:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozscreenshot 13:51:42 INFO - Running setup.py install for moztest 13:51:43 INFO - Running setup.py install for mozversion 13:51:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:43 INFO - Cleaning up... 13:51:43 INFO - Return code: 0 13:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:43 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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:43 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 13:51:43 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 13:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:43 INFO - 'HOME': '/Users/cltbld', 13:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:43 INFO - 'LOGNAME': 'cltbld', 13:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:43 INFO - 'MOZ_NO_REMOTE': '1', 13:51:43 INFO - 'NO_EM_RESTART': '1', 13:51:43 INFO - 'PAGER': '/bin/cat', 13:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:43 INFO - 'PWD': '/builds/slave/test', 13:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:43 INFO - 'SHELL': '/bin/bash', 13:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:43 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:43 INFO - 'USER': 'cltbld', 13:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:43 INFO - 'XPC_FLAGS': '0x0', 13:51:43 INFO - 'XPC_SERVICE_NAME': '0', 13:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:43 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cznlMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:43 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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:43 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rZ8nES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:43 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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:43 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rDpoNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:43 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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:43 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9g7IWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:43 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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:43 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YlPcU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-4FZyuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-XQOw7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-InV_ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-HUnK61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-x34Vsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ZasdWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-CGzhbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-lPxQZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GJ8Fok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:44 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)) 13:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-v7HQUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ZyZ0ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PXcaEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:45 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)) 13:51:45 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)) 13:51:45 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)) 13:51:45 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)) 13:51:45 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)) 13:51:45 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)) 13:51:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:47 INFO - Downloading blessings-1.6.tar.gz 13:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:47 INFO - Installing collected packages: blessings 13:51:47 INFO - Running setup.py install for blessings 13:51:48 INFO - Successfully installed blessings 13:51:48 INFO - Cleaning up... 13:51:48 INFO - Return code: 0 13:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:48 INFO - Reading from file tmpfile_stdout 13:51:48 INFO - Current package versions: 13:51:48 INFO - blessings == 1.6 13:51:48 INFO - blobuploader == 1.2.4 13:51:48 INFO - docopt == 0.6.1 13:51:48 INFO - functools32 == 3.2.3-2 13:51:48 INFO - jsonschema == 2.5.1 13:51:48 INFO - manifestparser == 1.1 13:51:48 INFO - mozInstall == 1.12 13:51:48 INFO - mozcrash == 1.0 13:51:48 INFO - mozdebug == 0.1 13:51:48 INFO - mozdevice == 0.50 13:51:48 INFO - mozfile == 1.2 13:51:48 INFO - mozhttpd == 0.7 13:51:48 INFO - mozinfo == 0.9 13:51:48 INFO - mozleak == 0.1 13:51:48 INFO - mozlog == 3.4 13:51:48 INFO - moznetwork == 0.27 13:51:48 INFO - mozprocess == 0.25 13:51:48 INFO - mozprofile == 0.28 13:51:48 INFO - mozrunner == 6.13 13:51:48 INFO - mozscreenshot == 0.1 13:51:48 INFO - mozsystemmonitor == 0.3 13:51:48 INFO - moztest == 0.8 13:51:48 INFO - mozversion == 1.4 13:51:48 INFO - psutil == 3.1.1 13:51:48 INFO - requests == 1.2.3 13:51:48 INFO - wsgiref == 0.1.2 13:51:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:48 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 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:48 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 13:51:48 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 13:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:48 INFO - 'HOME': '/Users/cltbld', 13:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:48 INFO - 'LOGNAME': 'cltbld', 13:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:48 INFO - 'MOZ_NO_REMOTE': '1', 13:51:48 INFO - 'NO_EM_RESTART': '1', 13:51:48 INFO - 'PAGER': '/bin/cat', 13:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:48 INFO - 'PWD': '/builds/slave/test', 13:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:48 INFO - 'SHELL': '/bin/bash', 13:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:48 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:48 INFO - 'USER': 'cltbld', 13:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:48 INFO - 'XPC_FLAGS': '0x0', 13:51:48 INFO - 'XPC_SERVICE_NAME': '0', 13:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 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)) 13:51:48 INFO - Cleaning up... 13:51:48 INFO - Return code: 0 13:51:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9804c92c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, '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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 13:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:48 INFO - 'HOME': '/Users/cltbld', 13:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:48 INFO - 'LOGNAME': 'cltbld', 13:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:48 INFO - 'MOZ_NO_REMOTE': '1', 13:51:48 INFO - 'NO_EM_RESTART': '1', 13:51:48 INFO - 'PAGER': '/bin/cat', 13:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:48 INFO - 'PWD': '/builds/slave/test', 13:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:48 INFO - 'SHELL': '/bin/bash', 13:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:51:48 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:48 INFO - 'USER': 'cltbld', 13:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:48 INFO - 'XPC_FLAGS': '0x0', 13:51:48 INFO - 'XPC_SERVICE_NAME': '0', 13:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:49 INFO - Cleaning up... 13:51:49 INFO - Return code: 0 13:51:49 INFO - Running post-action listener: _resource_record_post_action 13:51:49 INFO - Running post-action listener: _start_resource_monitoring 13:51:49 INFO - Starting resource monitoring. 13:51:49 INFO - [mozharness: 2017-04-17 20:51:49.087081Z] Finished create-virtualenv step (success) 13:51:49 INFO - [mozharness: 2017-04-17 20:51:49.087894Z] Running install step. 13:51:49 INFO - Running pre-action listener: _resource_record_pre_action 13:51:49 INFO - Running main action method: install 13:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:49 INFO - Reading from file tmpfile_stdout 13:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:49 INFO - Reading from file tmpfile_stdout 13:51:49 INFO - Output received: 13:51:49 INFO - Usage: mozinstall [options] installer 13:51:49 INFO - Options: 13:51:49 INFO - -h, --help show this help message and exit 13:51:49 INFO - -d DEST, --destination=DEST 13:51:49 INFO - Directory to install application into. [default: 13:51:49 INFO - "/builds/slave/test"] 13:51:49 INFO - --app=APP Application being installed. [default: firefox] 13:51:49 INFO - mkdir: /builds/slave/test/build/application 13:51:49 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'] 13:51:49 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 13:52:09 INFO - Reading from file tmpfile_stdout 13:52:09 INFO - Output received: 13:52:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:52:09 INFO - Running post-action listener: _resource_record_post_action 13:52:09 INFO - [mozharness: 2017-04-17 20:52:09.783060Z] Finished install step (success) 13:52:09 INFO - [mozharness: 2017-04-17 20:52:09.783190Z] Running run-tests step. 13:52:09 INFO - Running pre-action listener: _resource_record_pre_action 13:52:09 INFO - Running main action method: run_tests 13:52:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:09 INFO - 2017-04-17 13:52:09.797 screenresolution[1626:7392] starting screenresolution argv=screenresolution get 13:52:09 INFO - 2017-04-17 13:52:09.800 screenresolution[1626:7392] Display 0: 1600x1200x32@60 13:52:09 INFO - 2017-04-17 13:52:09.806 screenresolution[1627:7395] starting screenresolution argv=screenresolution list 13:52:09 INFO - Available Modes on Display 0 13:52:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:10 INFO - Intel Iris: 13:52:10 INFO - Chipset Model: Intel Iris 13:52:10 INFO - Type: GPU 13:52:10 INFO - Bus: Built-In 13:52:10 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:10 INFO - Vendor: Intel (0x8086) 13:52:10 INFO - Device ID: 0x0a2e 13:52:10 INFO - Revision ID: 0x0009 13:52:10 INFO - Displays: 13:52:10 INFO - Display: 13:52:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:10 INFO - Display Serial Number: 1600x1200 60 13:52:10 INFO - Main Display: Yes 13:52:10 INFO - Mirror: Off 13:52:10 INFO - Online: Yes 13:52:10 INFO - Rotation: Supported 13:52:10 INFO - Return code: 0 13:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:10 INFO - Python 2.7.3 13:52:10 INFO - Return code: 0 13:52:10 INFO - grabbing minidump binary from tooltool 13:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:10 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 0x104969d30>, '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 0x10488fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10495ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:10 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 13:52:10 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 13:52:10 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 13:52:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:10 INFO - Return code: 0 13:52:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:10 INFO - ENV: RUST_BACKTRACE is now 1 13:52:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 13:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 13:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6FPwr3fdy2/Render', 13:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:10 INFO - 'HOME': '/Users/cltbld', 13:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:10 INFO - 'LOGNAME': 'cltbld', 13:52:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:10 INFO - 'MOZ_NO_REMOTE': '1', 13:52:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:10 INFO - 'NO_EM_RESTART': '1', 13:52:10 INFO - 'PAGER': '/bin/cat', 13:52:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:10 INFO - 'PWD': '/builds/slave/test', 13:52:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:10 INFO - 'RUST_BACKTRACE': '1', 13:52:10 INFO - 'SHELL': '/bin/bash', 13:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K5q1IfTAl2/Listeners', 13:52:10 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 13:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:10 INFO - 'USER': 'cltbld', 13:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:10 INFO - 'XPC_FLAGS': '0x0', 13:52:10 INFO - 'XPC_SERVICE_NAME': '0', 13:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 13:52:10 INFO - mozversion application_buildid: 20170417124206 13:52:10 INFO - mozversion application_changeset: cac374fb0de1d5a5ccf53e0d61e3f47a66fe0603 13:52:10 INFO - mozversion application_display_name: Nightly 13:52:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:10 INFO - mozversion application_name: Firefox 13:52:10 INFO - mozversion application_remotingname: firefox 13:52:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:10 INFO - mozversion application_vendor: Mozilla 13:52:10 INFO - mozversion application_version: 55.0a1 13:52:10 INFO - mozversion platform_buildid: 20170417124206 13:52:10 INFO - mozversion platform_changeset: cac374fb0de1d5a5ccf53e0d61e3f47a66fe0603 13:52:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:10 INFO - mozversion platform_version: 55.0a1 13:52:10 INFO - using testdate: 1492462330 13:52:10 INFO - actual date: 1492462330 13:52:10 INFO - starting webserver on 'localhost:49237' 13:52:10 INFO - SUITE-START | Running 2 tests 13:52:10 INFO - TEST-START | dromaeo_css 13:52:10 INFO - operating with platform_type : mac_ 13:52:10 INFO - Initialising browser for dromaeo_css test... 13:52:10 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpYZLjzv/profile http://localhost:49237/getInfo.html) 13:52:13 INFO - PID 1637 | 2017-04-17 13:52:13.492 plugin-container[1639:7577] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 13:52:13 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:13 INFO - PID 1637 | 2017-04-17 13:52:13.495 plugin-container[1639:7577] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 13:52:13 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:13 INFO - PID 1637 | 2017-04-17 13:52:13.495 plugin-container[1639:7577] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:13 INFO - PID 1637 | __metrics Screen width/height:1600/1200 13:52:13 INFO - PID 1637 | colorDepth:24 13:52:13 INFO - PID 1637 | Browser inner width/height: 1024/689 13:52:13 INFO - PID 1637 | __metrics 13:52:13 ERROR - PID 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 13:52:14 INFO - TEST-INFO | 1637: exit 0 13:52:14 INFO - Browser initialized. 13:52:14 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:14 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpYZLjzv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:17 INFO - PID 1640 | 2017-04-17 13:52:17.361 plugin-container[1641:7714] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 13:52:17 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:17 INFO - PID 1640 | 2017-04-17 13:52:17.362 plugin-container[1641:7714] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 13:52:17 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:17 INFO - PID 1640 | 2017-04-17 13:52:17.362 plugin-container[1641:7714] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:27 INFO - PID 1640 | RSS: Main: 236154880 13:52:27 INFO - PID 1640 | 13:55:30 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 13:55:32 INFO - PID 1640 | RSS: Main: 251772928 13:55:32 INFO - PID 1640 | 13:57:15 INFO - PID 1640 | ************************* 13:57:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 13:57:15 INFO - PID 1640 | 13:57:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:57:15 INFO - PID 1640 | Full stack: 13:57:15 INFO - PID 1640 | ************************* 13:57:15 INFO - PID 1640 | ************************* 13:57:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 13:57:15 INFO - PID 1640 | 13:57:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:57:15 INFO - PID 1640 | Full stack: 13:57:15 INFO - PID 1640 | ************************* 13:57:15 INFO - PID 1640 | ************************* 13:57:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 13:57:15 INFO - PID 1640 | 13:57:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:57:15 INFO - PID 1640 | Full stack: 13:57:15 INFO - PID 1640 | ************************* 13:57:15 INFO - PID 1640 | ************************* 13:57:15 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 13:57:15 INFO - PID 1640 | 13:57:15 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:57:15 INFO - PID 1640 | Full stack: 13:57:15 INFO - PID 1640 | ************************* 13:58:34 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 13:58:35 INFO - PID 1640 | RSS: Main: 258142208 13:58:35 INFO - PID 1640 | 14:01:37 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 14:01:37 INFO - PID 1640 | RSS: Main: 267788288 14:01:37 INFO - PID 1640 | 14:04:39 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 14:04:40 INFO - PID 1640 | RSS: Main: 260100096 14:04:40 INFO - PID 1640 | 14:07:43 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 14:07:43 INFO - PID 1640 | RSS: Main: 270671872 14:07:43 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 14:10:45 INFO - PID 1640 | RSS: Main: 265195520 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | __start_tp_report 14:10:45 INFO - PID 1640 | _x_x_mozilla_page_load 14:10:45 INFO - PID 1640 | _x_x_mozilla_page_load_details 14:10:45 INFO - PID 1640 | |i|pagename|runs| 14:10:45 INFO - PID 1640 | |0;dojo.html;3449.4998225257336;3594.999999999998;3630.328389247991;3634.400323946549;3640.1991561856385;4748.430188377395;5965.880682386355;6117.035835319757;6238.62568245905;6298.149749783778;6145.0643047440135;6187.102870083835;6222.595531290474;6251.4998800096;6289.5597308188335;5400.405955344909;5443.863903402417;5458.6724796512135;5462.644928079682;5529.30883639545;5467.015937131315;5469.425710300421;5512.366077901052;5527.44725527446;5613.747381367828;5294.391145018334;5403.135498320289;5458.235846981426;5481.095619222863;5523.364813046511;5366.087765079946;5386.703731294777;5401.459854014606;5429.4570542945785;5465.6447330923365;5365.275687782138;5422.783088676449;5436.238926550286;5450.04624190765;5450.236966824647;4653.7207767534055;6064.9090263646085;6258.06129080637;6282.968585157045;6297.33877942814;5220.973895130538;6411.647359395231;6439.517036222255;6620.172478440195;6663.933770596681;6745.696443660047;6793.422559082434;6807.421369183576;6815.965920170417;6837.487188460836;6317.178766760292;6354.332795056499;6362.6818659067785;6384.648844313608;6403.391677790602;6650.135482387355;6728.293529179464;6990.405815505637;7006.124234470692;7033.120859892513;6557.2131344239;6601.438877695354;6645.800625981228;6672.699728512229;6677.699503522354;6763.086983257295;6807.319268073153;6812.455003599799;6815.93184068153;6825.726970921108;6318.936810631835;6654.833629159213;6672;6687.364700353459;6742.157230346207;6541.5093867960095;6665.666716664147;6689.297623749533;6740.764073257413;6754.797356079325;5364.275822763955;5381.67709937405;5382.973085134628;5394.352677678704;5403.648762830403;4751.239801631722;4792.808287668524;4793.281007848781;4817.78319975602;4860.027994401134;5002.624803139779;5121.590272778169;6132.141360525245;6295.37046295376;6323.841903952438;6772.83067923296;6787.660616969132;6834.692438840165;6839.965800170968;6876.931230687729;5203.271541984125;6307.05394190875;6333.778317758856;6339.587926784744;6358.936410635834;5788.363280039192;5799.797007104731;5847.26909136358;5849.64902105875;5946.256717910262;5736.19693242938;6788.456923446112;6879.58722476653;6902.965485172743;6910.308969103049;5380.596455265792;6313.2424109107205;6676.732930682719;6754.763583274562;6856.142982127234;5739.05305624584;6684.030815531818;6754.93245067543;6896.27589103157;6940.514164008471;6603.966980165068;6704.66476676174;6726.697298621476;6731.259561448334;6768.255491895986;6572.80281591553;6667.399934005963;6674.098996635392;6675.365840245169;6781.152355955505;6540.37866402691;6622.205335359788;6650.268470468342;6652.800415987528;6658.766943156967;6614.735410583715;6619.371159739817;6626.768063117768;6634.568753031038;6654.168228971379;6238.719257633508;6293.276273228637;6366.108744775643;6399.93600064012;6511.706973186313;6529.444997175104;6599.769008084694;6624.536282460182;6636.535442519171;6639.435647969976;6358.968205158944;6416.262129854939;6440.581362211441;6442.387973142544;6468.15913931186 14:10:45 INFO - PID 1640 | |1;ext.html;786.0999155966418;813.5647428625684;1104.790089882922;1137.5734099712608;1280.0335746511382;31122.84438577804;37220.44169337462;37989.430158547606;38082.42876356857;38129.856104316845;37981;38289.425658615146;38340.80829595855;38451.615483845155;38503.807480962554;7788.454808163417;7948.2051794820345;7955.761327160194;8456.534890581015;8681;7161.355478006978;8397.244248017678;8478.66085356585;8506.617202225883;8541.701040463586;8436.746897593082;8508.149185081473;8509;8520.829583408358;8522.616482258281;7397.408207343399;8496.532690702008;8505.574721263974;8536.8719469208;8543.871841922377;7966.721164759264;8435.325173986066;8492.278156356717;8502.362322825751;8515;37608.87173384803;37767.62232377696;37775;37914.620853791384;37965.62034379649;3566.32239874423;3585.103724068983;3607.494950706903;3612.6567976042234;3614.8011859347725;29908.252293692614;30101.849490752626;30197.69802301993;30230.84884575585;30267.848660756776;2744.533429317001;2899.5650652402096;2925.2979284971666;2935.6183696119583;2936.6769655337894;257208;257470.71264643743;258479;258837;258908.9999999981;47055.29417058747;47376;47645.047099057825;48105;48333;50051;50498.74750626297;50515;50671;50695.49304506907;11640.476178571984;14345.6413589659;14445.06107103035;14462.421503139756;14474.901139334737;11364.886351136549;11537.423128843524;11591.710207244718;11604;11607.535698572132;13326.466941322433;13334;13349.599512014654;13410.530631427853;13472.932635336761;5874.412558744091;5893.970530147321;5927.644341339534;5940.316863560746;5949.553783466257;1004.6433516101824;1016.9068251629528;1025.4462590201356;1046.759245373553;1061.4639606998417;18356.908215459105;23986.640200397007;24054.797260136922;24159.912803923864;24198.758012420003;1110.7334239782394;1116.1517246892258;1149.68383694483;1151.4875880233383;1155.6590805712335;11880.40597970098;12339.13626046168;12347.567835125728;12377.257364558156;12402.317872516918;341426;341681;342730;343101;343415;53245.46754532483;53321;53560.46439535633;53604.73197633987;53607.73196134072;1504.5335945856818;1548.0943647966067;1562.015929964138;1566.4752307976955;1567.42005457979;20698.275560355316;23248.721320327546;24011.27966161018;24105.397365066012;24177.274681759576;37950.62049379471;37993.81003095077;38034.809825950695;38079.428808568446;38083.23833523369;284751.57624211744;286130;286353;286569;287016;33985.830070849486;34159.97520074402;36078.63921360753;36572;36738.8163059183;36999.81500092482;44902.55097448984;45894.541054589026;45998.08003839971;46072;29731.70268297376;30772.230694232825;30845;31498.370032598763;31720.682793172695;25328.620070698587;30692.693073068982;31516.369672606877;31842.20394490156;31950.68049319477;31455.842720787165;36957.445638315985;37317.44023839699;37454.438183426726;37573;25608.975640974153;28805.7119428803;30855;31392.686073138975;31479.370412592078;24241.272761817174;24498.085467883684;24516.387090322885;24533.87733061323;24779.13273035435 14:10:45 INFO - PID 1640 | |2;jquery.html;404.67423723902255;406.6154743099746;414.6164797562256;419.9958000419995;425.00548716004545;20933.267335643257;21419.57160856784;21858.89070554647;22096.33710988673;22407.439814004658;22100.33698989029;23399.245056620737;23876.761232387715;23932.76067239327;24087.39781505463;6115.755369785204;6308.274548426921;6309.77915772948;6318.368163183668;6327.24073111225;5884.941150588482;6159.26088869334;6232.875342493147;6235.220597425322;6260.123582698426;5466.1527463243265;6161.829252442021;6207.503399728033;6219.315875253741;6742.988551717232;6941.305869413069;7031.7890463286185;7045.718171273143;7084.716611335541;7085.362317391434;5572.721363931828;6880.58716477013;6926.168859736814;7001.369876711069;7016.508844380895;29038.419231615462;29524.704752952624;29854.701452985628;29986.70013299861;30247.395052098836;2362.8109751219863;2402.615581506968;2409.421738782697;2416.4562973331035;2416.903323867043;18541.814581854145;18909.7163542547;19903.203871845108;20013;20048.79951200484;2148.52732398872;2205.1730601024615;2325.6046472099783;2377.239283429303;2397.952040959171;147656.52343476427;150829;152222;154623;156883;21664;22444.775552244268;22508.662370064463;24660.260192194262;24887.626685599367;41051.794741026104;41520;41540.376894346606;41684.95787605274;41713.374299385534;10625.309354891908;10968.396738179317;10969.780604388026;11092.833607495893;11162.888371116347;8400.873986890201;8472;8496.49021058726;8658.090900455487;8679.956600216958;9564.378315409476;9803.313768036169;11271.718207044889;11297.096232301396;11563.942180289045;4461.397711308931;4542.795574199169;4566.520515345907;4571.634269258451;4601.585857272861;823.8146417056234;976.1263669016332;986.3588667366126;999.205631522941;1020.0972139656309;21322.040508177168;21409.89295053546;21443.46391340229;21527.8923605381;21825.454363641034;761.4061032394741;980.9313348065567;1009.414539567064;1028.321307936758;1038.1227862456212;10718.464076796128;11030.393328367018;11033.448327583588;11050.668479945614;11063.170262230366;551249;570146;574226;578154;590524;117738;125610;143200.8519872203;147253.26373368065;148713.51286487214;1149.9292995482056;1186.3297237061033;1229.489761748864;1238.8637249902504;1243.4093805442524;22025.678459292492;22142.88928555347;22203.444913877283;22330.77669223287;22434.663480047486;59700.40299596948;60166.69916650389;61553.69223153855;61626.07560886501;62912.05631915433;83651.16348836677;84187.15812841793;85438;85733;85915.69716574161;8394.832103358021;8777.91222087771;8861.867071993796;9155;9206.401583897024;14228.928855355656;14367.568972930829;14393.64015899611;14690.55928322152;14692.502274613555;12042.458089385824;12073.57742479009;12080.275183489019;12118.818217726564;12153.817692734792;11370.31778093317;11533.769324613293;11611.361375124112;11638.12714046433;11832.11259155584;11459.48432320531;11958.22271552381;12280.938595306967;12312.630621081382;12366.319852408204;8009;8737.606807693795;8890.777730556529;8960.193582577338;9146.725598232064;11838.940805296263;12000.939995299968;12049.939750301193;12270.570530031406;12307.076969227164 14:10:45 INFO - PID 1640 | |3;mootools.html;1286.176846818036;1379.910305830121;1439.237204281731;1448.0515262503059;1452.5134080083176;11375.886241137587;11865.881341186585;11881.821772673406;11994.16040877139;12333.383330833467;10005.59977600895;11772.646820595395;11818.05455563555;11819.468123934423;11987.820182697267;2512.974870251297;2541.885615147323;2542.4533725249066;2547.656066431036;2549.3499157714755;2459.950800983979;2490.340059884132;2529.140092368594;2530.177692250017;2540.3649087727977;2312.8496647717843;2473.863937483438;2491.6511688363644;2520.848749075052;2522.6342180383836;2062.8659137156037;2429.854208747472;2488.9377765555914;2500.574902266619;2506.6240063990367;2414.3239892830034;2480.06997375984;2499.1627804685454;2520.974790252111;2528.329992551975;11974.521019159223;12011.399430028463;12070.758584828254;12079.335636539987;12194.512219511209;6476.870462590722;6687.364700353459;6717.462602991749;6722;6727.831804204885;3530.6645868642436;4020.8190631421658;4379.299312110079;4398.516163222043;4406.272964960777;1229.9016078713682;1247.1706315300314;1287.1633438265203;1293.3210064716006;1302.095043944459;13609.931950340284;16265.430709925215;16961.321547137977;16988.660226795517;16998.575035624086;4954.851354459372;5406.567259676189;5500.202470641814;5595.916061259084;5686.317641883001;12339.6915077122;12420.62738117858;12467.875321246853;12486.250824950532;12500.24998500093;6549.329920870147;6568.638724870178;6579.440747536513;6587.110740050128;6604.042413849965;5959.791407300723;6195.287541932646;6235.781747638902;6248.625082495065;6278;3812.370958791824;4108.746832216143;4362.934555981663;4519.892626306576;4527.320901864747;1301.841361188543;1333.466613354666;1335.619348485677;1344.1330341929402;1350.9054366194273;797.4656979823532;807.3944541593804;819.3240576524272;829.4567058576642;866.1944391715765;5993.4905533029305;6195.96902015487;6355.428011478989;6429.97120460724;6470.805875823733;593.8277899409123;601.5428274511403;605.5397897597858;916.7295647783919;980.8675828763169;3572.982135089308;4073;4342.457192850894;4432.201954592124;4560.338750881104;14791.408343666348;15177.848221517643;15239.23803809805;15376.61558461025;15394.692106157814;12306.446209920576;14698.779518307234;15142.54572362831;15284.465043723416;15329.233538323038;7226.626940881216;7387.704491820267;8538.274246688978;8779.604917778715;8812.691555795516;5647.632903861236;6309.684515774285;6756;6843.144606924135;7034.859302813813;13080.542181023618;13418.798718019043;13818.516351927634;13822.723545529234;13846.030777845857;10944.726381840517;13477.730445390842;13616.591502254949;13807.102538334975;14294.069715708047;10554.947225263824;10765.623203187852;10887.51006204707;10892.945535272589;10894.67315980522;8015.7595272141925;10805.081568066802;10805.837912431163;10836;10862.782744344911;9154.084591540792;9216.124468175512;9289.62841486333;9376.718698439057;9437.622495100119;8863.005823689618;9016.459012459274;9070.229030532479;9082.59128339213;9238.584263708284;8161.551114688749;8303.83392332138;8317.875231871647;8323.6670533178;8324.83350333002;6035.1249068885645;6066.393360663898;6170.228721409824;6221.688915554114;6272.937270627235;6116.694165291628;6280.120783090462;6302.054691796267;6314.400131987454;6388.977763557808 14:10:45 INFO - PID 1640 | |4;prototype.html;349.3903139022406;379.96770274526665;386.8433284519771;398.47799382808506;402.19159489426255;4371.934420983688;5090.490950904908;5998.730057147428;6183.752649893999;6187.474064704495;5919.37846526115;6043.099312330073;6053.818385448443;6061.9696901515545;6096;3912.39357899526;4051.8784436466954;4110.794460276989;4217.304144816102;4469.463664360282;4431.290993441034;4432.667549933752;4451.977740111295;4460.420145381096;4503.684742068057;3876.4185372194115;4418.094290670421;4421.894526368408;4425;4469.932951005738;3881.971277611435;4037.354023356278;4369.453818272716;4427.623651989585;4456.153330867141;3184.7133757961665;3790.128270497801;3793.9241215175543;3813.6377044181036;3822.923541529182;5892.675902825343;5894.616849904743;5894.8821023579285;5898.469137777621;5935.940640593625;5106.4638212987475;5195.9480405195845;5234.7644356004075;5262.710550919698;5288.550473209782;5661.150827375926;6431.774887878902;6442.323556026643;6456.643325186274;6474.546781725281;3669.504616876714;3838.596947320547;4118.897027574335;4337.392765012869;4339.220919423022;5358.5981051421295;5677.51741102011;5835.358110607872;6740.595564266159;6754.3921047105505;3836;4275.508316543575;4368.126374725068;4405.163019026375;4432.512423633398;3898.6101389861356;4426.026274219666;4452.48796388413;4466.7939656293265;4472.239719247736;4402.977985110054;4495.9325610115875;4569.200389931749;4986.301917731521;5240.371155461369;6481.837954051092;6482.254540727782;6492.772752953624;6504.9674751625935;6528.67356632176;1275.9362031898554;1491.597268737435;1505.856943590357;1525.7711343298595;1534.9309281082378;836.9121242269596;893.8480458322101;964.4599024546277;996.960121595128;1005.1556692378291;6040.728167232485;6057.939420605826;6072.635641861502;6090;6112.388761123941;6171.321154672983;6700.49746269022;6730.899036514358;6793.286704895915;6821.965890170517;4977.925331120036;5621.381648018796;5919.437653422918;6008.789692360747;6031.457168854737;3241.3517296540786;3495.2310491691787;3504.789712617251;3515.945216435059;3527.0020482589593;6603.405693487513;6788.558743681645;6832.93167068323;6867.553609015498;6927.411170050602;5906.350301466835;6411.557399585149;6707.792597332429;6798.014287928223;6860;5368.489993450616;5633.366323766062;5989.910151347646;6386.904196437057;6852.725890964405;6717.16035495563;6733.326667333227;6738.292479289604;6764.391204791593;6800.803622297512;5611.775528978795;6288.371162883675;6363.93636063652;6422.807315780534;6589.155036589763;5270.631055826056;6716.462682985447;6830.248672645906;6869.793906182823;6910.550814197061;4032.2741906457118;4165.291900376883;4296.93554596675;4337.371081193272;4391.934120988124;6233.909065913538;6612.140421745143;6762.087118239171;6788.694508747217;6826.624535650587;6201.224846894138;6467.5472716911245;6513.185851768529;6513.837154071186;6514.990176522647;5405.8918821622565;6298.590591611531;6416.422521972858;6418.390252925965;6572.8356791080605;6033.370989832808;6322.905156422566;6347.381992264365;6354.491640668828;6356.841078973062;6111.847203819762;6439.710213040331;6450.516211284266;6512.413882750575;6512.5766825156215;6345.841353966188;6357.014662727284;6364.167945264313;6367.52243581724;6378.138951241523 14:10:45 INFO - PID 1640 | |5;yui.html;793.2226418110251;828.2049232736573;847.6016272351997;871.7079778274277;879.0945326313895;14081.859181408208;14636.926815365909;16069.035857848537;16706.248218830166;16728.66542669146;16678.749818752698;16910.577235569115;17054.23255953482;17347.73978390322;17443.47669569912;706.8196112492151;952.200151872427;978.6623614852864;980.5881529757519;985.3742873275486;966.5988614724881;984.5520288268856;990.7968866382411;991.3506653142204;994.328828041073;907.9228265597433;1047.0524175621038;1049.942253176075;1052.27393098762;1054.0671505717419;1044.8537204791335;1044.879838818538;1050.4800123938662;1050.6427814543054;1052.6947185316249;776.2082675670785;776.867932451479;777.1296148313868;779.4738551477786;787.0712559180165;16726;17106.91446542772;17189.7421538677;17207;17279.568010799703;16692.415765448273;16823.91588042064;17116.828831711773;17288.827111728846;17330.3934362298;13682.631736826337;14018.579442616738;14090.577282681536;14126.505572305023;14474.782878256834;3246.5130230465384;3541.256336169382;3543.273628906068;3548.1661809474754;3551.271989242199;110964.4451777744;112375;114180;114410.42794786056;115787.68424631545;13228.669283267804;13448.924086073092;13658.658533536742;13769.518066867811;13769.793453098211;24773.25680229596;25444.363890902507;25514.74485255161;25617;25640;7831.334336581341;7903.920960790433;7943.086545047394;7948.602569871599;7950.363970882316;4010.9598904010586;4020.2562525932794;4031.254217969685;4050.6556942660204;4097.119119389286;4241.151769646083;4337.0458499130145;4343.891402714894;4360.716553424018;4375.584319489643;863.9891327147253;877.0440220160057;878.6704985630389;934.9111834375724;968.6948611187594;588.1794896119889;619.8760247950428;648.1023782061784;648.8961766117399;670.3196255800367;9933.850992235122;10456.215783816244;11314.377709225906;11681.415929203506;12084.637460876012;634.6160572853449;640;641.7112299465259;644.2333622988629;645.4803882874331;5274.894502109936;5381.192821076792;5386.272853164851;5398.433164517748;5477.67133971963;97957;98311.50844245733;98715;99964;102390.48804755928;60356.09465858016;76461.61769191119;77375.78628871717;78779.8183027255;78917.60541197257;72507.63746181235;73252;74217;74483;74530.31105956191;10046;10649.201309901633;10684.83972740425;10946.343219406861;11050.502727377127;31010;38570;40093.59906400899;40112.799436002635;41355.1728965413;63968.36031639624;65039.67480162569;67005;67377.66311168413;71224;12592.685182870502;12692.428840702007;16202.837971620133;16467.258973346467;16486.422975195812;18436.539086522946;18567.814321856607;18588.163532640792;18665;18707.438776836716;13834.446622135001;16674.416395426586;16783.91608041952;16923.49229523067;17144;16467;16946.40687575929;17033.829661703225;17051.573710657332;17130.057846818545;15281.770773438186;15979.201039948188;16333.509994700178;16734.07962562022;16756.832431676015;10633.468326583794;10871.184661150288;10996.2852414596;11812.232204906653;12488.375581221084;11596.304221746723;13127;13287.867121328663;13557.25435101079;13576.86423135756 14:10:45 INFO - PID 1640 | __end_tp_report 14:10:45 INFO - PID 1640 | __start_cc_report 14:10:45 INFO - PID 1640 | _x_x_mozilla_cycle_collect,421 14:10:45 INFO - PID 1640 | __end_cc_report 14:10:45 INFO - PID 1640 | __startTimestamp1492463445943__endTimestamp 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | ------- Summary: start ------- 14:10:45 INFO - PID 1640 | Number of tests: 6 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6130.22 Median:6366.11 stddev:754.09 (11.8%) stddev-sans-first:726.49 14:10:45 INFO - PID 1640 | Values: 3449.5 3595.0 3630.3 3634.4 3640.2 4748.4 5965.9 6117.0 6238.6 6298.1 6145.1 6187.1 6222.6 6251.5 6289.6 5400.4 5443.9 5458.7 5462.6 5529.3 5467.0 5469.4 5512.4 5527.4 5613.7 5294.4 5403.1 5458.2 5481.1 5523.4 5366.1 5386.7 5401.5 5429.5 5465.6 5365.3 5422.8 5436.2 5450.0 5450.2 4653.7 6064.9 6258.1 6283.0 6297.3 5221.0 6411.6 6439.5 6620.2 6663.9 6745.7 6793.4 6807.4 6816.0 6837.5 6317.2 6354.3 6362.7 6384.6 6403.4 6650.1 6728.3 6990.4 7006.1 7033.1 6557.2 6601.4 6645.8 6672.7 6677.7 6763.1 6807.3 6812.5 6815.9 6825.7 6318.9 6654.8 6672.0 6687.4 6742.2 6541.5 6665.7 6689.3 6740.8 6754.8 5364.3 5381.7 5383.0 5394.4 5403.6 4751.2 4792.8 4793.3 4817.8 4860.0 5002.6 5121.6 6132.1 6295.4 6323.8 6772.8 6787.7 6834.7 6840.0 6876.9 5203.3 6307.1 6333.8 6339.6 6358.9 5788.4 5799.8 5847.3 5849.6 5946.3 5736.2 6788.5 6879.6 6903.0 6910.3 5380.6 6313.2 6676.7 6754.8 6856.1 5739.1 6684.0 6754.9 6896.3 6940.5 6604.0 6704.7 6726.7 6731.3 6768.3 6572.8 6667.4 6674.1 6675.4 6781.2 6540.4 6622.2 6650.3 6652.8 6658.8 6614.7 6619.4 6626.8 6634.6 6654.2 6238.7 6293.3 6366.1 6399.9 6511.7 6529.4 6599.8 6624.5 6636.5 6639.4 6359.0 6416.3 6440.6 6442.4 6468.2 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:44616.46 Median:187705.92 stddev:78118.59 (41.6%) stddev-sans-first:78268.42 14:10:45 INFO - PID 1640 | Values: 786.1 813.6 1104.8 1137.6 1280.0 31122.8 37220.4 37989.4 38082.4 38129.9 37981.0 38289.4 38340.8 38451.6 38503.8 7788.5 7948.2 7955.8 8456.5 8681.0 7161.4 8397.2 8478.7 8506.6 8541.7 8436.7 8508.1 8509.0 8520.8 8522.6 7397.4 8496.5 8505.6 8536.9 8543.9 7966.7 8435.3 8492.3 8502.4 8515.0 37608.9 37767.6 37775.0 37914.6 37965.6 3566.3 3585.1 3607.5 3612.7 3614.8 29908.3 30101.8 30197.7 30230.8 30267.8 2744.5 2899.6 2925.3 2935.6 2936.7 257208.0 257470.7 258479.0 258837.0 258909.0 47055.3 47376.0 47645.0 48105.0 48333.0 50051.0 50498.7 50515.0 50671.0 50695.5 11640.5 14345.6 14445.1 14462.4 14474.9 11364.9 11537.4 11591.7 11604.0 11607.5 13326.5 13334.0 13349.6 13410.5 13472.9 5874.4 5894.0 5927.6 5940.3 5949.6 1004.6 1016.9 1025.4 1046.8 1061.5 18356.9 23986.6 24054.8 24159.9 24198.8 1110.7 1116.2 1149.7 1151.5 1155.7 11880.4 12339.1 12347.6 12377.3 12402.3 341426.0 341681.0 342730.0 343101.0 343415.0 53245.5 53321.0 53560.5 53604.7 53607.7 1504.5 1548.1 1562.0 1566.5 1567.4 20698.3 23248.7 24011.3 24105.4 24177.3 37950.6 37993.8 38034.8 38079.4 38083.2 284751.6 286130.0 286353.0 286569.0 287016.0 33985.8 34160.0 36078.6 36572.0 36738.8 36999.8 44902.6 45894.5 45998.1 46072.0 29731.7 30772.2 30845.0 31498.4 31720.7 25328.6 30692.7 31516.4 31842.2 31950.7 31455.8 36957.4 37317.4 37454.4 37573.0 25609.0 28805.7 30855.0 31392.7 31479.4 24241.3 24498.1 24516.4 24533.9 24779.1 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:38253.65 Median:13245.01 stddev:96846.93 (731.2%) stddev-sans-first:97076.92 14:10:45 INFO - PID 1640 | Values: 404.7 406.6 414.6 420.0 425.0 20933.3 21419.6 21858.9 22096.3 22407.4 22100.3 23399.2 23876.8 23932.8 24087.4 6115.8 6308.3 6309.8 6318.4 6327.2 5884.9 6159.3 6232.9 6235.2 6260.1 5466.2 6161.8 6207.5 6219.3 6743.0 6941.3 7031.8 7045.7 7084.7 7085.4 5572.7 6880.6 6926.2 7001.4 7016.5 29038.4 29524.7 29854.7 29986.7 30247.4 2362.8 2402.6 2409.4 2416.5 2416.9 18541.8 18909.7 19903.2 20013.0 20048.8 2148.5 2205.2 2325.6 2377.2 2398.0 147656.5 150829.0 152222.0 154623.0 156883.0 21664.0 22444.8 22508.7 24660.3 24887.6 41051.8 41520.0 41540.4 41685.0 41713.4 10625.3 10968.4 10969.8 11092.8 11162.9 8400.9 8472.0 8496.5 8658.1 8680.0 9564.4 9803.3 11271.7 11297.1 11563.9 4461.4 4542.8 4566.5 4571.6 4601.6 823.8 976.1 986.4 999.2 1020.1 21322.0 21409.9 21443.5 21527.9 21825.5 761.4 980.9 1009.4 1028.3 1038.1 10718.5 11030.4 11033.4 11050.7 11063.2 551249.0 570146.0 574226.0 578154.0 590524.0 117738.0 125610.0 143200.9 147253.3 148713.5 1149.9 1186.3 1229.5 1238.9 1243.4 22025.7 22142.9 22203.4 22330.8 22434.7 59700.4 60166.7 61553.7 61626.1 62912.1 83651.2 84187.2 85438.0 85733.0 85915.7 8394.8 8777.9 8861.9 9155.0 9206.4 14228.9 14367.6 14393.6 14690.6 14692.5 12042.5 12073.6 12080.3 12118.8 12153.8 11370.3 11533.8 11611.4 11638.1 11832.1 11459.5 11958.2 12280.9 12312.6 12366.3 8009.0 8737.6 8890.8 8960.2 9146.7 11838.9 12000.9 12049.9 12270.6 12307.1 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7142.87 Median:2542.17 stddev:4543.45 (178.7%) stddev-sans-first:4534.88 14:10:45 INFO - PID 1640 | Values: 1286.2 1379.9 1439.2 1448.1 1452.5 11375.9 11865.9 11881.8 11994.2 12333.4 10005.6 11772.6 11818.1 11819.5 11987.8 2513.0 2541.9 2542.5 2547.7 2549.3 2460.0 2490.3 2529.1 2530.2 2540.4 2312.8 2473.9 2491.7 2520.8 2522.6 2062.9 2429.9 2488.9 2500.6 2506.6 2414.3 2480.1 2499.2 2521.0 2528.3 11974.5 12011.4 12070.8 12079.3 12194.5 6476.9 6687.4 6717.5 6722.0 6727.8 3530.7 4020.8 4379.3 4398.5 4406.3 1229.9 1247.2 1287.2 1293.3 1302.1 13609.9 16265.4 16961.3 16988.7 16998.6 4954.9 5406.6 5500.2 5595.9 5686.3 12339.7 12420.6 12467.9 12486.3 12500.2 6549.3 6568.6 6579.4 6587.1 6604.0 5959.8 6195.3 6235.8 6248.6 6278.0 3812.4 4108.7 4362.9 4519.9 4527.3 1301.8 1333.5 1335.6 1344.1 1350.9 797.5 807.4 819.3 829.5 866.2 5993.5 6196.0 6355.4 6430.0 6470.8 593.8 601.5 605.5 916.7 980.9 3573.0 4073.0 4342.5 4432.2 4560.3 14791.4 15177.8 15239.2 15376.6 15394.7 12306.4 14698.8 15142.5 15284.5 15329.2 7226.6 7387.7 8538.3 8779.6 8812.7 5647.6 6309.7 6756.0 6843.1 7034.9 13080.5 13418.8 13818.5 13822.7 13846.0 10944.7 13477.7 13616.6 13807.1 14294.1 10554.9 10765.6 10887.5 10892.9 10894.7 8015.8 10805.1 10805.8 10836.0 10862.8 9154.1 9216.1 9289.6 9376.7 9437.6 8863.0 9016.5 9070.2 9082.6 9238.6 8161.6 8303.8 8317.9 8323.7 8324.8 6035.1 6066.4 6170.2 6221.7 6272.9 6116.7 6280.1 6302.1 6314.4 6389.0 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5167.61 Median:5927.69 stddev:1653.99 (27.9%) stddev-sans-first:1618.62 14:10:45 INFO - PID 1640 | Values: 349.4 380.0 386.8 398.5 402.2 4371.9 5090.5 5998.7 6183.8 6187.5 5919.4 6043.1 6053.8 6062.0 6096.0 3912.4 4051.9 4110.8 4217.3 4469.5 4431.3 4432.7 4452.0 4460.4 4503.7 3876.4 4418.1 4421.9 4425.0 4469.9 3882.0 4037.4 4369.5 4427.6 4456.2 3184.7 3790.1 3793.9 3813.6 3822.9 5892.7 5894.6 5894.9 5898.5 5935.9 5106.5 5195.9 5234.8 5262.7 5288.6 5661.2 6431.8 6442.3 6456.6 6474.5 3669.5 3838.6 4118.9 4337.4 4339.2 5358.6 5677.5 5835.4 6740.6 6754.4 3836.0 4275.5 4368.1 4405.2 4432.5 3898.6 4426.0 4452.5 4466.8 4472.2 4403.0 4495.9 4569.2 4986.3 5240.4 6481.8 6482.3 6492.8 6505.0 6528.7 1275.9 1491.6 1505.9 1525.8 1534.9 836.9 893.8 964.5 997.0 1005.2 6040.7 6057.9 6072.6 6090.0 6112.4 6171.3 6700.5 6730.9 6793.3 6822.0 4977.9 5621.4 5919.4 6008.8 6031.5 3241.4 3495.2 3504.8 3515.9 3527.0 6603.4 6788.6 6832.9 6867.6 6927.4 5906.4 6411.6 6707.8 6798.0 6860.0 5368.5 5633.4 5989.9 6386.9 6852.7 6717.2 6733.3 6738.3 6764.4 6800.8 5611.8 6288.4 6363.9 6422.8 6589.2 5270.6 6716.5 6830.2 6869.8 6910.6 4032.3 4165.3 4296.9 4337.4 4391.9 6233.9 6612.1 6762.1 6788.7 6826.6 6201.2 6467.5 6513.2 6513.8 6515.0 5405.9 6298.6 6416.4 6418.4 6572.8 6033.4 6322.9 6347.4 6354.5 6356.8 6111.8 6439.7 6450.5 6512.4 6512.6 6345.8 6357.0 6364.2 6367.5 6378.1 14:10:45 INFO - PID 1640 | 14:10:45 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:20785.26 Median:25479.55 stddev:28188.67 (110.6%) stddev-sans-first:28227.77 14:10:45 INFO - PID 1640 | Values: 793.2 828.2 847.6 871.7 879.1 14081.9 14636.9 16069.0 16706.2 16728.7 16678.7 16910.6 17054.2 17347.7 17443.5 706.8 952.2 978.7 980.6 985.4 966.6 984.6 990.8 991.4 994.3 907.9 1047.1 1049.9 1052.3 1054.1 1044.9 1044.9 1050.5 1050.6 1052.7 776.2 776.9 777.1 779.5 787.1 16726.0 17106.9 17189.7 17207.0 17279.6 16692.4 16823.9 17116.8 17288.8 17330.4 13682.6 14018.6 14090.6 14126.5 14474.8 3246.5 3541.3 3543.3 3548.2 3551.3 110964.4 112375.0 114180.0 114410.4 115787.7 13228.7 13448.9 13658.7 13769.5 13769.8 24773.3 25444.4 25514.7 25617.0 25640.0 7831.3 7903.9 7943.1 7948.6 7950.4 4011.0 4020.3 4031.3 4050.7 4097.1 4241.2 4337.0 4343.9 4360.7 4375.6 864.0 877.0 878.7 934.9 968.7 588.2 619.9 648.1 648.9 670.3 9933.9 10456.2 11314.4 11681.4 12084.6 634.6 640.0 641.7 644.2 645.5 5274.9 5381.2 5386.3 5398.4 5477.7 97957.0 98311.5 98715.0 99964.0 102390.5 60356.1 76461.6 77375.8 78779.8 78917.6 72507.6 73252.0 74217.0 74483.0 74530.3 10046.0 10649.2 10684.8 10946.3 11050.5 31010.0 38570.0 40093.6 40112.8 41355.2 63968.4 65039.7 67005.0 67377.7 71224.0 12592.7 12692.4 16202.8 16467.3 16486.4 18436.5 18567.8 18588.2 18665.0 18707.4 13834.4 16674.4 16783.9 16923.5 17144.0 16467.0 16946.4 17033.8 17051.6 17130.1 15281.8 15979.2 16333.5 16734.1 16756.8 10633.5 10871.2 10996.3 11812.2 12488.4 11596.3 13127.0 13287.9 13557.3 13576.9 14:10:45 INFO - PID 1640 | -------- Summary: end -------- 14:10:45 INFO - PID 1640 | 14:10:46 INFO - TEST-INFO | 1640: exit 0 14:10:46 INFO - TEST-OK | dromaeo_css | took 1116225ms 14:10:46 INFO - TEST-START | kraken 14:10:46 INFO - operating with platform_type : mac_ 14:10:46 INFO - Initialising browser for kraken test... 14:10:46 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp14v0at/profile http://localhost:49237/getInfo.html) 14:10:49 INFO - PID 1652 | 2017-04-17 14:10:49.584 plugin-container[1653:10090] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 14:10:49 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:49 INFO - PID 1652 | 2017-04-17 14:10:49.587 plugin-container[1653:10090] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.CFPasteboardClient' 14:10:49 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:49 INFO - PID 1652 | 2017-04-17 14:10:49.588 plugin-container[1653:10090] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:10:49 INFO - PID 1652 | __metrics Screen width/height:1600/1200 14:10:49 INFO - PID 1652 | colorDepth:24 14:10:49 INFO - PID 1652 | Browser inner width/height: 1024/689 14:10:49 INFO - PID 1652 | __metrics 14:10:49 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 14:10:50 INFO - TEST-INFO | 1652: exit 0 14:10:50 INFO - Browser initialized. 14:10:50 INFO - Running cycle 1/1 for kraken test... 14:10:50 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp14v0at/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:53 INFO - PID 1654 | 2017-04-17 14:10:53.450 plugin-container[1655:10214] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4b, name = 'com.apple.tsm.portname' 14:10:53 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:53 INFO - PID 1654 | 2017-04-17 14:10:53.450 plugin-container[1655:10214] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 14:10:53 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:53 INFO - PID 1654 | 2017-04-17 14:10:53.450 plugin-container[1655:10214] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:03 INFO - PID 1654 | RSS: Main: 236744704 14:11:03 INFO - PID 1654 | 14:11:05 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:06 INFO - PID 1654 | RSS: Main: 248688640 14:11:06 INFO - PID 1654 | 14:11:09 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 14:11:10 INFO - PID 1654 | RSS: Main: 256942080 14:11:10 INFO - PID 1654 | 14:11:13 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 14:11:14 INFO - PID 1654 | RSS: Main: 259469312 14:11:14 INFO - PID 1654 | 14:11:16 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 14:11:16 INFO - PID 1654 | RSS: Main: 260448256 14:11:16 INFO - PID 1654 | 14:11:18 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:19 INFO - PID 1654 | RSS: Main: 260784128 14:11:19 INFO - PID 1654 | 14:11:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:22 INFO - PID 1654 | RSS: Main: 266416128 14:11:22 INFO - PID 1654 | 14:11:26 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:26 INFO - PID 1654 | RSS: Main: 268541952 14:11:26 INFO - PID 1654 | 14:11:29 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 14:11:30 INFO - PID 1654 | RSS: Main: 268607488 14:11:30 INFO - PID 1654 | 14:11:31 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:32 INFO - PID 1654 | RSS: Main: 268148736 14:11:32 INFO - PID 1654 | 14:11:34 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:35 INFO - PID 1654 | RSS: Main: 268197888 14:11:35 INFO - PID 1654 | 14:11:37 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:37 INFO - PID 1654 | RSS: Main: 267894784 14:11:37 INFO - PID 1654 | 14:11:40 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:41 INFO - PID 1654 | RSS: Main: 268091392 14:11:41 INFO - PID 1654 | 14:11:44 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:45 INFO - PID 1654 | RSS: Main: 267968512 14:11:45 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 14:11:47 INFO - PID 1654 | RSS: Main: 269479936 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | __start_tp_report 14:11:47 INFO - PID 1654 | _x_x_mozilla_page_load 14:11:47 INFO - PID 1654 | _x_x_mozilla_page_load_details 14:11:47 INFO - PID 1654 | |i|pagename|runs| 14:11:47 INFO - PID 1654 | |0;ai-astar;105;119;115;116;115;115;115;115;117;116 14:11:47 INFO - PID 1654 | |1;audio-beat-detection;146;103;143;186;151;112;115;114;166;146 14:11:47 INFO - PID 1654 | |2;audio-dft;200;203;213;222;277;266;198;197;197;200 14:11:47 INFO - PID 1654 | |3;audio-fft;81;57;57;85;57;59;58;57;78;57 14:11:47 INFO - PID 1654 | |4;audio-oscillator;91;72;87;84;89;55;81;87;106;111 14:11:47 INFO - PID 1654 | |5;imaging-gaussian-blur;90;92;91;90;91;92;103;90;91;90 14:11:47 INFO - PID 1654 | |6;imaging-darkroom;157;138;97;126;99;100;98;98;99;99 14:11:47 INFO - PID 1654 | |7;imaging-desaturate;92;96;92;92;92;92;90;91;91;92 14:11:47 INFO - PID 1654 | |8;json-parse-financial;51;52;50;51;51;53;61;75;80;51 14:11:47 INFO - PID 1654 | |9;json-stringify-tinderbox;61;88;50;65;92;92;85;83;60;59 14:11:47 INFO - PID 1654 | |10;stanford-crypto-aes;85;87;87;84;88;85;85;88;89;83 14:11:47 INFO - PID 1654 | |11;stanford-crypto-ccm;158;166;150;132;146;140;142;146;212;141 14:11:47 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;186;233;190;185;185;185;184;191;241;214 14:11:47 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;75;85;84;69;70;66;70;67;68;71 14:11:47 INFO - PID 1654 | __end_tp_report 14:11:47 INFO - PID 1654 | __start_cc_report 14:11:47 INFO - PID 1654 | _x_x_mozilla_cycle_collect,988 14:11:47 INFO - PID 1654 | __end_cc_report 14:11:47 INFO - PID 1654 | __startTimestamp1492463507480__endTimestamp 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | ------- Summary: start ------- 14:11:47 INFO - PID 1654 | Number of tests: 14 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:3.68 (3.2%) stddev-sans-first:1.36 14:11:47 INFO - PID 1654 | Values: 105.0 119.0 115.0 116.0 115.0 115.0 115.0 115.0 117.0 116.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:146.00 stddev:26.70 (18.3%) stddev-sans-first:28.17 14:11:47 INFO - PID 1654 | Values: 146.0 103.0 143.0 186.0 151.0 112.0 115.0 114.0 166.0 146.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:217.30 Median:208.00 stddev:29.77 (14.3%) stddev-sans-first:30.91 14:11:47 INFO - PID 1654 | Values: 200.0 203.0 213.0 222.0 277.0 266.0 198.0 197.0 197.0 200.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:64.60 Median:58.50 stddev:11.68 (20.0%) stddev-sans-first:10.78 14:11:47 INFO - PID 1654 | Values: 81.0 57.0 57.0 85.0 57.0 59.0 58.0 57.0 78.0 57.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:85.50 stddev:15.80 (18.5%) stddev-sans-first:16.66 14:11:47 INFO - PID 1654 | Values: 91.0 72.0 87.0 84.0 89.0 55.0 81.0 87.0 106.0 111.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:91.00 stddev:3.94 (4.3%) stddev-sans-first:4.12 14:11:47 INFO - PID 1654 | Values: 90.0 92.0 91.0 90.0 91.0 92.0 103.0 90.0 91.0 90.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:111.10 Median:98.00 stddev:21.49 (21.9%) stddev-sans-first:15.07 14:11:47 INFO - PID 1654 | Values: 157.0 138.0 97.0 126.0 99.0 100.0 98.0 98.0 99.0 99.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:92.00 stddev:1.56 (1.7%) stddev-sans-first:1.66 14:11:47 INFO - PID 1654 | Values: 92.0 96.0 92.0 92.0 92.0 92.0 90.0 91.0 91.0 92.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:52.50 stddev:11.06 (21.1%) stddev-sans-first:11.48 14:11:47 INFO - PID 1654 | Values: 51.0 52.0 50.0 51.0 51.0 53.0 61.0 75.0 80.0 51.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:84.00 stddev:15.95 (19.0%) stddev-sans-first:16.27 14:11:47 INFO - PID 1654 | Values: 61.0 88.0 50.0 65.0 92.0 92.0 85.0 83.0 60.0 59.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:1.97 (2.3%) stddev-sans-first:2.05 14:11:47 INFO - PID 1654 | Values: 85.0 87.0 87.0 84.0 88.0 85.0 85.0 88.0 89.0 83.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:153.30 Median:148.00 stddev:22.75 (15.4%) stddev-sans-first:24.06 14:11:47 INFO - PID 1654 | Values: 158.0 166.0 150.0 132.0 146.0 140.0 142.0 146.0 212.0 141.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.40 Median:190.50 stddev:21.78 (11.4%) stddev-sans-first:22.56 14:11:47 INFO - PID 1654 | Values: 186.0 233.0 190.0 185.0 185.0 185.0 184.0 191.0 241.0 214.0 14:11:47 INFO - PID 1654 | 14:11:47 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:70.50 stddev:6.79 (9.6%) stddev-sans-first:7.14 14:11:47 INFO - PID 1654 | Values: 75.0 85.0 84.0 69.0 70.0 66.0 70.0 67.0 68.0 71.0 14:11:47 INFO - PID 1654 | -------- Summary: end -------- 14:11:47 INFO - PID 1654 | 14:11:48 INFO - TEST-INFO | 1654: exit 0 14:11:48 INFO - TEST-OK | kraken | took 61994ms 14:11:48 INFO - SUITE-END | took 1178s 14:11:48 INFO - Completed test suite (00:19:38) 14:11:48 INFO - javascript benchmark 14:11:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7957.831095457388, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3449.4998225257336, 3594.999999999998, 3630.328389247991, 3634.400323946549, 3640.1991561856385, 4748.430188377395, 5965.880682386355, 6117.035835319757, 6238.62568245905, 6298.149749783778, 6145.0643047440135, 6187.102870083835, 6222.595531290474, 6251.4998800096, 6289.5597308188335, 5400.405955344909, 5443.863903402417, 5458.6724796512135, 5462.644928079682, 5529.30883639545, 5467.015937131315, 5469.425710300421, 5512.366077901052, 5527.44725527446, 5613.747381367828, 5294.391145018334, 5403.135498320289, 5458.235846981426, 5481.095619222863, 5523.364813046511, 5366.087765079946, 5386.703731294777, 5401.459854014606, 5429.4570542945785, 5465.6447330923365, 5365.275687782138, 5422.783088676449, 5436.238926550286, 5450.04624190765, 5450.236966824647, 4653.7207767534055, 6064.9090263646085, 6258.06129080637, 6282.968585157045, 6297.33877942814, 5220.973895130538, 6411.647359395231, 6439.517036222255, 6620.172478440195, 6663.933770596681, 6745.696443660047, 6793.422559082434, 6807.421369183576, 6815.965920170417, 6837.487188460836, 6317.178766760292, 6354.332795056499, 6362.6818659067785, 6384.648844313608, 6403.391677790602, 6650.135482387355, 6728.293529179464, 6990.405815505637, 7006.124234470692, 7033.120859892513, 6557.2131344239, 6601.438877695354, 6645.800625981228, 6672.699728512229, 6677.699503522354, 6763.086983257295, 6807.319268073153, 6812.455003599799, 6815.93184068153, 6825.726970921108, 6318.936810631835, 6654.833629159213, 6672.0, 6687.364700353459, 6742.157230346207, 6541.5093867960095, 6665.666716664147, 6689.297623749533, 6740.764073257413, 6754.797356079325, 5364.275822763955, 5381.67709937405, 5382.973085134628, 5394.352677678704, 5403.648762830403, 4751.239801631722, 4792.808287668524, 4793.281007848781, 4817.78319975602, 4860.027994401134, 5002.624803139779, 5121.590272778169, 6132.141360525245, 6295.37046295376, 6323.841903952438, 6772.83067923296, 6787.660616969132, 6834.692438840165, 6839.965800170968, 6876.931230687729, 5203.271541984125, 6307.05394190875, 6333.778317758856, 6339.587926784744, 6358.936410635834, 5788.363280039192, 5799.797007104731, 5847.26909136358, 5849.64902105875, 5946.256717910262, 5736.19693242938, 6788.456923446112, 6879.58722476653, 6902.965485172743, 6910.308969103049, 5380.596455265792, 6313.2424109107205, 6676.732930682719, 6754.763583274562, 6856.142982127234, 5739.05305624584, 6684.030815531818, 6754.93245067543, 6896.27589103157, 6940.514164008471, 6603.966980165068, 6704.66476676174, 6726.697298621476, 6731.259561448334, 6768.255491895986, 6572.80281591553, 6667.399934005963, 6674.098996635392, 6675.365840245169, 6781.152355955505, 6540.37866402691, 6622.205335359788, 6650.268470468342, 6652.800415987528, 6658.766943156967, 6614.735410583715, 6619.371159739817, 6626.768063117768, 6634.568753031038, 6654.168228971379, 6238.719257633508, 6293.276273228637, 6366.108744775643, 6399.93600064012, 6511.706973186313, 6529.444997175104, 6599.769008084694, 6624.536282460182, 6636.535442519171, 6639.435647969976, 6358.968205158944, 6416.262129854939, 6440.581362211441, 6442.387973142544, 6468.15913931186], "value": 6083.015236763927, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.0999155966418, 813.5647428625684, 1104.790089882922, 1137.5734099712608, 1280.0335746511382, 31122.84438577804, 37220.44169337462, 37989.430158547606, 38082.42876356857, 38129.856104316845, 37981.0, 38289.425658615146, 38340.80829595855, 38451.615483845155, 38503.807480962554, 7788.454808163417, 7948.2051794820345, 7955.761327160194, 8456.534890581015, 8681.0, 7161.355478006978, 8397.244248017678, 8478.66085356585, 8506.617202225883, 8541.701040463586, 8436.746897593082, 8508.149185081473, 8509.0, 8520.829583408358, 8522.616482258281, 7397.408207343399, 8496.532690702008, 8505.574721263974, 8536.8719469208, 8543.871841922377, 7966.721164759264, 8435.325173986066, 8492.278156356717, 8502.362322825751, 8515.0, 37608.87173384803, 37767.62232377696, 37775.0, 37914.620853791384, 37965.62034379649, 3566.32239874423, 3585.103724068983, 3607.494950706903, 3612.6567976042234, 3614.8011859347725, 29908.252293692614, 30101.849490752626, 30197.69802301993, 30230.84884575585, 30267.848660756776, 2744.533429317001, 2899.5650652402096, 2925.2979284971666, 2935.6183696119583, 2936.6769655337894, 257208.0, 257470.71264643743, 258479.0, 258837.0, 258908.9999999981, 47055.29417058747, 47376.0, 47645.047099057825, 48105.0, 48333.0, 50051.0, 50498.74750626297, 50515.0, 50671.0, 50695.49304506907, 11640.476178571984, 14345.6413589659, 14445.06107103035, 14462.421503139756, 14474.901139334737, 11364.886351136549, 11537.423128843524, 11591.710207244718, 11604.0, 11607.535698572132, 13326.466941322433, 13334.0, 13349.599512014654, 13410.530631427853, 13472.932635336761, 5874.412558744091, 5893.970530147321, 5927.644341339534, 5940.316863560746, 5949.553783466257, 1004.6433516101824, 1016.9068251629528, 1025.4462590201356, 1046.759245373553, 1061.4639606998417, 18356.908215459105, 23986.640200397007, 24054.797260136922, 24159.912803923864, 24198.758012420003, 1110.7334239782394, 1116.1517246892258, 1149.68383694483, 1151.4875880233383, 1155.6590805712335, 11880.40597970098, 12339.13626046168, 12347.567835125728, 12377.257364558156, 12402.317872516918, 341426.0, 341681.0, 342730.0, 343101.0, 343415.0, 53245.46754532483, 53321.0, 53560.46439535633, 53604.73197633987, 53607.73196134072, 1504.5335945856818, 1548.0943647966067, 1562.015929964138, 1566.4752307976955, 1567.42005457979, 20698.275560355316, 23248.721320327546, 24011.27966161018, 24105.397365066012, 24177.274681759576, 37950.62049379471, 37993.81003095077, 38034.809825950695, 38079.428808568446, 38083.23833523369, 284751.57624211744, 286130.0, 286353.0, 286569.0, 287016.0, 33985.830070849486, 34159.97520074402, 36078.63921360753, 36572.0, 36738.8163059183, 36999.81500092482, 44902.55097448984, 45894.541054589026, 45998.08003839971, 46072.0, 29731.70268297376, 30772.230694232825, 30845.0, 31498.370032598763, 31720.682793172695, 25328.620070698587, 30692.693073068982, 31516.369672606877, 31842.20394490156, 31950.68049319477, 31455.842720787165, 36957.445638315985, 37317.44023839699, 37454.438183426726, 37573.0, 25608.975640974153, 28805.7119428803, 30855.0, 31392.686073138975, 31479.370412592078, 24241.272761817174, 24498.085467883684, 24516.387090322885, 24533.87733061323, 24779.13273035435], "value": 17427.673963992853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.67423723902255, 406.6154743099746, 414.6164797562256, 419.9958000419995, 425.00548716004545, 20933.267335643257, 21419.57160856784, 21858.89070554647, 22096.33710988673, 22407.439814004658, 22100.33698989029, 23399.245056620737, 23876.761232387715, 23932.76067239327, 24087.39781505463, 6115.755369785204, 6308.274548426921, 6309.77915772948, 6318.368163183668, 6327.24073111225, 5884.941150588482, 6159.26088869334, 6232.875342493147, 6235.220597425322, 6260.123582698426, 5466.1527463243265, 6161.829252442021, 6207.503399728033, 6219.315875253741, 6742.988551717232, 6941.305869413069, 7031.7890463286185, 7045.718171273143, 7084.716611335541, 7085.362317391434, 5572.721363931828, 6880.58716477013, 6926.168859736814, 7001.369876711069, 7016.508844380895, 29038.419231615462, 29524.704752952624, 29854.701452985628, 29986.70013299861, 30247.395052098836, 2362.8109751219863, 2402.615581506968, 2409.421738782697, 2416.4562973331035, 2416.903323867043, 18541.814581854145, 18909.7163542547, 19903.203871845108, 20013.0, 20048.79951200484, 2148.52732398872, 2205.1730601024615, 2325.6046472099783, 2377.239283429303, 2397.952040959171, 147656.52343476427, 150829.0, 152222.0, 154623.0, 156883.0, 21664.0, 22444.775552244268, 22508.662370064463, 24660.260192194262, 24887.626685599367, 41051.794741026104, 41520.0, 41540.376894346606, 41684.95787605274, 41713.374299385534, 10625.309354891908, 10968.396738179317, 10969.780604388026, 11092.833607495893, 11162.888371116347, 8400.873986890201, 8472.0, 8496.49021058726, 8658.090900455487, 8679.956600216958, 9564.378315409476, 9803.313768036169, 11271.718207044889, 11297.096232301396, 11563.942180289045, 4461.397711308931, 4542.795574199169, 4566.520515345907, 4571.634269258451, 4601.585857272861, 823.8146417056234, 976.1263669016332, 986.3588667366126, 999.205631522941, 1020.0972139656309, 21322.040508177168, 21409.89295053546, 21443.46391340229, 21527.8923605381, 21825.454363641034, 761.4061032394741, 980.9313348065567, 1009.414539567064, 1028.321307936758, 1038.1227862456212, 10718.464076796128, 11030.393328367018, 11033.448327583588, 11050.668479945614, 11063.170262230366, 551249.0, 570146.0, 574226.0, 578154.0, 590524.0, 117738.0, 125610.0, 143200.8519872203, 147253.26373368065, 148713.51286487214, 1149.9292995482056, 1186.3297237061033, 1229.489761748864, 1238.8637249902504, 1243.4093805442524, 22025.678459292492, 22142.88928555347, 22203.444913877283, 22330.77669223287, 22434.663480047486, 59700.40299596948, 60166.69916650389, 61553.69223153855, 61626.07560886501, 62912.05631915433, 83651.16348836677, 84187.15812841793, 85438.0, 85733.0, 85915.69716574161, 8394.832103358021, 8777.91222087771, 8861.867071993796, 9155.0, 9206.401583897024, 14228.928855355656, 14367.568972930829, 14393.64015899611, 14690.55928322152, 14692.502274613555, 12042.458089385824, 12073.57742479009, 12080.275183489019, 12118.818217726564, 12153.817692734792, 11370.31778093317, 11533.769324613293, 11611.361375124112, 11638.12714046433, 11832.11259155584, 11459.48432320531, 11958.22271552381, 12280.938595306967, 12312.630621081382, 12366.319852408204, 8009.0, 8737.606807693795, 8890.777730556529, 8960.193582577338, 9146.725598232064, 11838.940805296263, 12000.939995299968, 12049.939750301193, 12270.570530031406, 12307.076969227164], "value": 11693.868464240802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.176846818036, 1379.910305830121, 1439.237204281731, 1448.0515262503059, 1452.5134080083176, 11375.886241137587, 11865.881341186585, 11881.821772673406, 11994.16040877139, 12333.383330833467, 10005.59977600895, 11772.646820595395, 11818.05455563555, 11819.468123934423, 11987.820182697267, 2512.974870251297, 2541.885615147323, 2542.4533725249066, 2547.656066431036, 2549.3499157714755, 2459.950800983979, 2490.340059884132, 2529.140092368594, 2530.177692250017, 2540.3649087727977, 2312.8496647717843, 2473.863937483438, 2491.6511688363644, 2520.848749075052, 2522.6342180383836, 2062.8659137156037, 2429.854208747472, 2488.9377765555914, 2500.574902266619, 2506.6240063990367, 2414.3239892830034, 2480.06997375984, 2499.1627804685454, 2520.974790252111, 2528.329992551975, 11974.521019159223, 12011.399430028463, 12070.758584828254, 12079.335636539987, 12194.512219511209, 6476.870462590722, 6687.364700353459, 6717.462602991749, 6722.0, 6727.831804204885, 3530.6645868642436, 4020.8190631421658, 4379.299312110079, 4398.516163222043, 4406.272964960777, 1229.9016078713682, 1247.1706315300314, 1287.1633438265203, 1293.3210064716006, 1302.095043944459, 13609.931950340284, 16265.430709925215, 16961.321547137977, 16988.660226795517, 16998.575035624086, 4954.851354459372, 5406.567259676189, 5500.202470641814, 5595.916061259084, 5686.317641883001, 12339.6915077122, 12420.62738117858, 12467.875321246853, 12486.250824950532, 12500.24998500093, 6549.329920870147, 6568.638724870178, 6579.440747536513, 6587.110740050128, 6604.042413849965, 5959.791407300723, 6195.287541932646, 6235.781747638902, 6248.625082495065, 6278.0, 3812.370958791824, 4108.746832216143, 4362.934555981663, 4519.892626306576, 4527.320901864747, 1301.841361188543, 1333.466613354666, 1335.619348485677, 1344.1330341929402, 1350.9054366194273, 797.4656979823532, 807.3944541593804, 819.3240576524272, 829.4567058576642, 866.1944391715765, 5993.4905533029305, 6195.96902015487, 6355.428011478989, 6429.97120460724, 6470.805875823733, 593.8277899409123, 601.5428274511403, 605.5397897597858, 916.7295647783919, 980.8675828763169, 3572.982135089308, 4073.0, 4342.457192850894, 4432.201954592124, 4560.338750881104, 14791.408343666348, 15177.848221517643, 15239.23803809805, 15376.61558461025, 15394.692106157814, 12306.446209920576, 14698.779518307234, 15142.54572362831, 15284.465043723416, 15329.233538323038, 7226.626940881216, 7387.704491820267, 8538.274246688978, 8779.604917778715, 8812.691555795516, 5647.632903861236, 6309.684515774285, 6756.0, 6843.144606924135, 7034.859302813813, 13080.542181023618, 13418.798718019043, 13818.516351927634, 13822.723545529234, 13846.030777845857, 10944.726381840517, 13477.730445390842, 13616.591502254949, 13807.102538334975, 14294.069715708047, 10554.947225263824, 10765.623203187852, 10887.51006204707, 10892.945535272589, 10894.67315980522, 8015.7595272141925, 10805.081568066802, 10805.837912431163, 10836.0, 10862.782744344911, 9154.084591540792, 9216.124468175512, 9289.62841486333, 9376.718698439057, 9437.622495100119, 8863.005823689618, 9016.459012459274, 9070.229030532479, 9082.59128339213, 9238.584263708284, 8161.551114688749, 8303.83392332138, 8317.875231871647, 8323.6670533178, 8324.83350333002, 6035.1249068885645, 6066.393360663898, 6170.228721409824, 6221.688915554114, 6272.937270627235, 6116.694165291628, 6280.120783090462, 6302.054691796267, 6314.400131987454, 6388.977763557808], "value": 5374.302298953677, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.3903139022406, 379.96770274526665, 386.8433284519771, 398.47799382808506, 402.19159489426255, 4371.934420983688, 5090.490950904908, 5998.730057147428, 6183.752649893999, 6187.474064704495, 5919.37846526115, 6043.099312330073, 6053.818385448443, 6061.9696901515545, 6096.0, 3912.39357899526, 4051.8784436466954, 4110.794460276989, 4217.304144816102, 4469.463664360282, 4431.290993441034, 4432.667549933752, 4451.977740111295, 4460.420145381096, 4503.684742068057, 3876.4185372194115, 4418.094290670421, 4421.894526368408, 4425.0, 4469.932951005738, 3881.971277611435, 4037.354023356278, 4369.453818272716, 4427.623651989585, 4456.153330867141, 3184.7133757961665, 3790.128270497801, 3793.9241215175543, 3813.6377044181036, 3822.923541529182, 5892.675902825343, 5894.616849904743, 5894.8821023579285, 5898.469137777621, 5935.940640593625, 5106.4638212987475, 5195.9480405195845, 5234.7644356004075, 5262.710550919698, 5288.550473209782, 5661.150827375926, 6431.774887878902, 6442.323556026643, 6456.643325186274, 6474.546781725281, 3669.504616876714, 3838.596947320547, 4118.897027574335, 4337.392765012869, 4339.220919423022, 5358.5981051421295, 5677.51741102011, 5835.358110607872, 6740.595564266159, 6754.3921047105505, 3836.0, 4275.508316543575, 4368.126374725068, 4405.163019026375, 4432.512423633398, 3898.6101389861356, 4426.026274219666, 4452.48796388413, 4466.7939656293265, 4472.239719247736, 4402.977985110054, 4495.9325610115875, 4569.200389931749, 4986.301917731521, 5240.371155461369, 6481.837954051092, 6482.254540727782, 6492.772752953624, 6504.9674751625935, 6528.67356632176, 1275.9362031898554, 1491.597268737435, 1505.856943590357, 1525.7711343298595, 1534.9309281082378, 836.9121242269596, 893.8480458322101, 964.4599024546277, 996.960121595128, 1005.1556692378291, 6040.728167232485, 6057.939420605826, 6072.635641861502, 6090.0, 6112.388761123941, 6171.321154672983, 6700.49746269022, 6730.899036514358, 6793.286704895915, 6821.965890170517, 4977.925331120036, 5621.381648018796, 5919.437653422918, 6008.789692360747, 6031.457168854737, 3241.3517296540786, 3495.2310491691787, 3504.789712617251, 3515.945216435059, 3527.0020482589593, 6603.405693487513, 6788.558743681645, 6832.93167068323, 6867.553609015498, 6927.411170050602, 5906.350301466835, 6411.557399585149, 6707.792597332429, 6798.014287928223, 6860.0, 5368.489993450616, 5633.366323766062, 5989.910151347646, 6386.904196437057, 6852.725890964405, 6717.16035495563, 6733.326667333227, 6738.292479289604, 6764.391204791593, 6800.803622297512, 5611.775528978795, 6288.371162883675, 6363.93636063652, 6422.807315780534, 6589.155036589763, 5270.631055826056, 6716.462682985447, 6830.248672645906, 6869.793906182823, 6910.550814197061, 4032.2741906457118, 4165.291900376883, 4296.93554596675, 4337.371081193272, 4391.934120988124, 6233.909065913538, 6612.140421745143, 6762.087118239171, 6788.694508747217, 6826.624535650587, 6201.224846894138, 6467.5472716911245, 6513.185851768529, 6513.837154071186, 6514.990176522647, 5405.8918821622565, 6298.590591611531, 6416.422521972858, 6418.390252925965, 6572.8356791080605, 6033.370989832808, 6322.905156422566, 6347.381992264365, 6354.491640668828, 6356.841078973062, 6111.847203819762, 6439.710213040331, 6450.516211284266, 6512.413882750575, 6512.5766825156215, 6345.841353966188, 6357.014662727284, 6364.167945264313, 6367.52243581724, 6378.138951241523], "value": 4645.767765016813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.2226418110251, 828.2049232736573, 847.6016272351997, 871.7079778274277, 879.0945326313895, 14081.859181408208, 14636.926815365909, 16069.035857848537, 16706.248218830166, 16728.66542669146, 16678.749818752698, 16910.577235569115, 17054.23255953482, 17347.73978390322, 17443.47669569912, 706.8196112492151, 952.200151872427, 978.6623614852864, 980.5881529757519, 985.3742873275486, 966.5988614724881, 984.5520288268856, 990.7968866382411, 991.3506653142204, 994.328828041073, 907.9228265597433, 1047.0524175621038, 1049.942253176075, 1052.27393098762, 1054.0671505717419, 1044.8537204791335, 1044.879838818538, 1050.4800123938662, 1050.6427814543054, 1052.6947185316249, 776.2082675670785, 776.867932451479, 777.1296148313868, 779.4738551477786, 787.0712559180165, 16726.0, 17106.91446542772, 17189.7421538677, 17207.0, 17279.568010799703, 16692.415765448273, 16823.91588042064, 17116.828831711773, 17288.827111728846, 17330.3934362298, 13682.631736826337, 14018.579442616738, 14090.577282681536, 14126.505572305023, 14474.782878256834, 3246.5130230465384, 3541.256336169382, 3543.273628906068, 3548.1661809474754, 3551.271989242199, 110964.4451777744, 112375.0, 114180.0, 114410.42794786056, 115787.68424631545, 13228.669283267804, 13448.924086073092, 13658.658533536742, 13769.518066867811, 13769.793453098211, 24773.25680229596, 25444.363890902507, 25514.74485255161, 25617.0, 25640.0, 7831.334336581341, 7903.920960790433, 7943.086545047394, 7948.602569871599, 7950.363970882316, 4010.9598904010586, 4020.2562525932794, 4031.254217969685, 4050.6556942660204, 4097.119119389286, 4241.151769646083, 4337.0458499130145, 4343.891402714894, 4360.716553424018, 4375.584319489643, 863.9891327147253, 877.0440220160057, 878.6704985630389, 934.9111834375724, 968.6948611187594, 588.1794896119889, 619.8760247950428, 648.1023782061784, 648.8961766117399, 670.3196255800367, 9933.850992235122, 10456.215783816244, 11314.377709225906, 11681.415929203506, 12084.637460876012, 634.6160572853449, 640.0, 641.7112299465259, 644.2333622988629, 645.4803882874331, 5274.894502109936, 5381.192821076792, 5386.272853164851, 5398.433164517748, 5477.67133971963, 97957.0, 98311.50844245733, 98715.0, 99964.0, 102390.48804755928, 60356.09465858016, 76461.61769191119, 77375.78628871717, 78779.8183027255, 78917.60541197257, 72507.63746181235, 73252.0, 74217.0, 74483.0, 74530.31105956191, 10046.0, 10649.201309901633, 10684.83972740425, 10946.343219406861, 11050.502727377127, 31010.0, 38570.0, 40093.59906400899, 40112.799436002635, 41355.1728965413, 63968.36031639624, 65039.67480162569, 67005.0, 67377.66311168413, 71224.0, 12592.685182870502, 12692.428840702007, 16202.837971620133, 16467.258973346467, 16486.422975195812, 18436.539086522946, 18567.814321856607, 18588.163532640792, 18665.0, 18707.438776836716, 13834.446622135001, 16674.416395426586, 16783.91608041952, 16923.49229523067, 17144.0, 16467.0, 16946.40687575929, 17033.829661703225, 17051.573710657332, 17130.057846818545, 15281.770773438186, 15979.201039948188, 16333.509994700178, 16734.07962562022, 16756.832431676015, 10633.468326583794, 10871.184661150288, 10996.2852414596, 11812.232204906653, 12488.375581221084, 11596.304221746723, 13127.0, 13287.867121328663, 13557.25435101079, 13576.86423135756], "value": 8204.251306101834, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 117.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 103.0, 143.0, 186.0, 151.0, 112.0, 115.0, 114.0, 166.0, 146.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 203.0, 213.0, 222.0, 277.0, 266.0, 198.0, 197.0, 197.0, 200.0], "value": 217.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 57.0, 85.0, 57.0, 59.0, 58.0, 57.0, 78.0, 57.0], "value": 64.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 72.0, 87.0, 84.0, 89.0, 55.0, 81.0, 87.0, 106.0, 111.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 91.0, 90.0, 91.0, 92.0, 103.0, 90.0, 91.0, 90.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 138.0, 97.0, 126.0, 99.0, 100.0, 98.0, 98.0, 99.0, 99.0], "value": 111.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 92.0, 92.0, 92.0, 92.0, 90.0, 91.0, 91.0, 92.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 50.0, 51.0, 51.0, 53.0, 61.0, 75.0, 80.0, 51.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 88.0, 50.0, 65.0, 92.0, 92.0, 85.0, 83.0, 60.0, 59.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 84.0, 88.0, 85.0, 85.0, 88.0, 89.0, 83.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 166.0, 150.0, 132.0, 146.0, 140.0, 142.0, 146.0, 212.0, 141.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 233.0, 190.0, 185.0, 185.0, 185.0, 184.0, 191.0, 241.0, 214.0], "value": 199.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 85.0, 84.0, 69.0, 70.0, 66.0, 70.0, 67.0, 68.0, 71.0], "value": 72.5, "unit": "score"}]}]} 14:11:48 INFO - Return code: 0 14:11:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:48 ERROR - # TBPL SUCCESS # 14:11:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:48 INFO - 2017-04-17 14:11:48.838 screenresolution[1660:10605] starting screenresolution argv=screenresolution get 14:11:48 INFO - 2017-04-17 14:11:48.842 screenresolution[1660:10605] Display 0: 1600x1200x32@60 14:11:48 INFO - 2017-04-17 14:11:48.848 screenresolution[1661:10608] starting screenresolution argv=screenresolution list 14:11:48 INFO - Available Modes on Display 0 14:11:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:49 INFO - Intel Iris: 14:11:49 INFO - Chipset Model: Intel Iris 14:11:49 INFO - Type: GPU 14:11:49 INFO - Bus: Built-In 14:11:49 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:49 INFO - Vendor: Intel (0x8086) 14:11:49 INFO - Device ID: 0x0a2e 14:11:49 INFO - Revision ID: 0x0009 14:11:49 INFO - Displays: 14:11:49 INFO - Display: 14:11:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:49 INFO - Display Serial Number: 1600x1200 60 14:11:49 INFO - Main Display: Yes 14:11:49 INFO - Mirror: Off 14:11:49 INFO - Online: Yes 14:11:49 INFO - Rotation: Supported 14:11:49 INFO - Return code: 0 14:11:49 INFO - Running post-action listener: _resource_record_post_action 14:11:49 INFO - [mozharness: 2017-04-17 21:11:49.091588Z] Finished run-tests step (success) 14:11:49 INFO - Running post-run listener: _resource_record_post_run 14:11:49 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39853056; Write bytes: 517369856; Read time: 386; Write time: 1816 14:11:49 INFO - TinderboxPrint: CPU usage
54.2% 14:11:49 INFO - TinderboxPrint: I/O read bytes / time
39,853,056 / 386 14:11:49 INFO - TinderboxPrint: I/O write bytes / time
517,369,856 / 1,816 14:11:49 INFO - TinderboxPrint: CPU idle
2,199.3 (45.8%) 14:11:49 INFO - TinderboxPrint: CPU system
967.8 (20.2%) 14:11:49 INFO - TinderboxPrint: CPU user
1,630.6 (34.0%) 14:11:49 INFO - TinderboxPrint: Swap in / out
248,446,976 / 0 14:11:49 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201243136; Write bytes: 195917824; Read time: 16045; Write time: 395 14:11:49 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 38890496; Write bytes: 305657856; Read time: 370; Write time: 1377 14:11:49 INFO - Running post-run listener: _upload_blobber_files 14:11:49 INFO - Blob upload gear active. 14:11:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:49 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 14:11:49 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'] 14:11:49 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 14:11:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:51 INFO - (blobuploader) - INFO - Done attempting. 14:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:52 INFO - (blobuploader) - INFO - Done attempting. 14:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:52 INFO - (blobuploader) - INFO - Done attempting. 14:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:55 INFO - (blobuploader) - INFO - Done attempting. 14:11:55 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:55 INFO - Return code: 0 14:11:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbfa94cfbad89e612fed8d0f551a06838b4059e72d59dc38c594706451d4cf2a8777d9e12d6f473376c3a9aae3c97b7cb87d2e9cac0b6b58543d99cba7deedeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/254c7ab854c4618e780e5a90d1257760e89d6f01614c9fd37c58c093687864c3631615b15584ac7609e21b16454e9f323dcf2802b52f36738293456e4e4f8487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/409fd3040b64bd8269b1b04005cb35c58ff070442c47e6186d716a4140ba7deab2301b7394349e4375f810bbab9e926f8330531e5a8b21ae4ecbdbf0924f3485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/220b58f6dc85f1039299d7b7e1e520760c1956dc27abe44de43b53792e23c914305681cef92aac7400ff43a00b2a636b00c5909d36d9f0854e234731122030b8"} 14:11:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:55 INFO - Contents: 14:11:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbfa94cfbad89e612fed8d0f551a06838b4059e72d59dc38c594706451d4cf2a8777d9e12d6f473376c3a9aae3c97b7cb87d2e9cac0b6b58543d99cba7deedeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/254c7ab854c4618e780e5a90d1257760e89d6f01614c9fd37c58c093687864c3631615b15584ac7609e21b16454e9f323dcf2802b52f36738293456e4e4f8487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/409fd3040b64bd8269b1b04005cb35c58ff070442c47e6186d716a4140ba7deab2301b7394349e4375f810bbab9e926f8330531e5a8b21ae4ecbdbf0924f3485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/220b58f6dc85f1039299d7b7e1e520760c1956dc27abe44de43b53792e23c914305681cef92aac7400ff43a00b2a636b00c5909d36d9f0854e234731122030b8"} 14:11:55 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:55 INFO - Copying logs to upload dir... 14:11:55 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.712530 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-17 14:11:55.913863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 14:11:55.917094) ========= 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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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/fbfa94cfbad89e612fed8d0f551a06838b4059e72d59dc38c594706451d4cf2a8777d9e12d6f473376c3a9aae3c97b7cb87d2e9cac0b6b58543d99cba7deedeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/254c7ab854c4618e780e5a90d1257760e89d6f01614c9fd37c58c093687864c3631615b15584ac7609e21b16454e9f323dcf2802b52f36738293456e4e4f8487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/409fd3040b64bd8269b1b04005cb35c58ff070442c47e6186d716a4140ba7deab2301b7394349e4375f810bbab9e926f8330531e5a8b21ae4ecbdbf0924f3485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/220b58f6dc85f1039299d7b7e1e520760c1956dc27abe44de43b53792e23c914305681cef92aac7400ff43a00b2a636b00c5909d36d9f0854e234731122030b8"} build_url:https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/YB6_eWtDR3yleMqEG6G_xw/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/fbfa94cfbad89e612fed8d0f551a06838b4059e72d59dc38c594706451d4cf2a8777d9e12d6f473376c3a9aae3c97b7cb87d2e9cac0b6b58543d99cba7deedeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/254c7ab854c4618e780e5a90d1257760e89d6f01614c9fd37c58c093687864c3631615b15584ac7609e21b16454e9f323dcf2802b52f36738293456e4e4f8487", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/409fd3040b64bd8269b1b04005cb35c58ff070442c47e6186d716a4140ba7deab2301b7394349e4375f810bbab9e926f8330531e5a8b21ae4ecbdbf0924f3485", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/220b58f6dc85f1039299d7b7e1e520760c1956dc27abe44de43b53792e23c914305681cef92aac7400ff43a00b2a636b00c5909d36d9f0854e234731122030b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 14:11:55.951225) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:11:55.951512) ========= 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.6FPwr3fdy2/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.K5q1IfTAl2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005146 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:11:55.999801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 14:11:56.000107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 14:11:56.000408) ========= ========= Total master_lag: 0.18 =========